2025-11-01 16:19:04,225 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 16:19:04,226 - INFO - ya.test - pytest_runtest_setup: test_all_supported_compression[zstd_15_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 15]
2025-11-01 16:19:04,226 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 16:19:04,226 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-01 16:19:04,228 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-11-01 16:19:04,229 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-11-01 16:19:04,229 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/y72z/002524/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 16:19:04,231 - DEBUG - ya.test - execute: Command pid: 516294
2025-11-01 16:19:04,939 - DEBUG - ya.test - _save_outputs: Command (pid 516294) rc: 0
2025-11-01 16:19:04,939 - DEBUG - ya.test - _save_outputs: Command (pid 516294) elapsed time (sec): 0.7069308757781982
2025-11-01 16:19:04,940 - DEBUG - ya.test - _save_outputs: Command (pid 516294) idrss: 0
2025-11-01 16:19:04,940 - DEBUG - ya.test - _save_outputs: Command (pid 516294) inblock: 0
2025-11-01 16:19:04,940 - DEBUG - ya.test - _save_outputs: Command (pid 516294) isrss: 0
2025-11-01 16:19:04,941 - DEBUG - ya.test - _save_outputs: Command (pid 516294) ixrss: 0
2025-11-01 16:19:04,941 - DEBUG - ya.test - _save_outputs: Command (pid 516294) majflt: 0
2025-11-01 16:19:04,941 - DEBUG - ya.test - _save_outputs: Command (pid 516294) maxrss: 493856
2025-11-01 16:19:04,941 - DEBUG - ya.test - _save_outputs: Command (pid 516294) minflt: 45403
2025-11-01 16:19:04,942 - DEBUG - ya.test - _save_outputs: Command (pid 516294) msgrcv: 0
2025-11-01 16:19:04,942 - DEBUG - ya.test - _save_outputs: Command (pid 516294) msgsnd: 0
2025-11-01 16:19:04,942 - DEBUG - ya.test - _save_outputs: Command (pid 516294) nivcsw: 23
2025-11-01 16:19:04,942 - DEBUG - ya.test - _save_outputs: Command (pid 516294) nsignals: 0
2025-11-01 16:19:04,943 - DEBUG - ya.test - _save_outputs: Command (pid 516294) nswap: 0
2025-11-01 16:19:04,943 - DEBUG - ya.test - _save_outputs: Command (pid 516294) nvcsw: 15
2025-11-01 16:19:04,943 - DEBUG - ya.test - _save_outputs: Command (pid 516294) oublock: 8
2025-11-01 16:19:04,944 - DEBUG - ya.test - _save_outputs: Command (pid 516294) stime: 0.21870499999999998
2025-11-01 16:19:04,944 - DEBUG - ya.test - _save_outputs: Command (pid 516294) utime: 0.441279
2025-11-01 16:19:04,944 - DEBUG - ya.test - _save_outputs: Command (pid 516294) wtime: 0.709
2025-11-01 16:19:04,945 - DEBUG - ya.test - _save_outputs: Command (pid 516294) output:
Git info:
    Commit: b759454d1e40b275ba8b2f5964202fc9f08a1c3c
    Branch: 
    Author: Denis Khalikov <dennis.khalikov@gmail.com>
    Summary: Merge b3001557f326a9ac3df9852d3eea5c83a6651a93 into 88f362bbf1115d2653ecf70400035099c5165741

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-cjocww3of4
    Host information: 
        Linux ghrun-cjocww3of4 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-01 16:19:04,945 - DEBUG - ya.test - _save_outputs: Command (pid 516294) errors:

2025-11-01 16:19:04,945 - INFO - __tests__.base - _setup_ydb: Git info:
    Commit: b759454d1e40b275ba8b2f5964202fc9f08a1c3c
    Branch: 
    Author: Denis Khalikov <dennis.khalikov@gmail.com>
    Summary: Merge b3001557f326a9ac3df9852d3eea5c83a6651a93 into 88f362bbf1115d2653ecf70400035099c5165741

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-cjocww3of4
    Host information: 
        Linux ghrun-cjocww3of4 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-01 16:19:05,048 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/y72z/002524/ydb/apps/ydbd/ydbd
2025-11-01 16:19:05,050 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/31970
2025-11-01 16:19:05,052 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/y72z/002524/r3tmp/kikimr_cluster_6taunlq6
2025-11-01 16:19:05,089 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/y72z/002524/ydb/apps/ydbd/ydbd
2025-11-01 16:19:05,090 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/29100
2025-11-01 16:19:05,091 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/2631
2025-11-01 16:19:05,091 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/11268
2025-11-01 16:19:05,092 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/20157
2025-11-01 16:19:05,092 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/y72z/002524/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_15_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.15/cluster/kikimr_configs"
2025-11-01 16:19:05,093 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/y72z/002524/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/y72z/002524/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_15_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.15/cluster/node_1/logfile_cf5i97wi.log --grpc-port=29100 --mon-port=2631 --ic-port=31970
2025-11-01 16:19:05,093 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:29100/1, disk_size 68719476736
2025-11-01 16:19:05,094 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/y72z/002524/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_15_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.15/cluster/kikimr_configs"
2025-11-01 16:19:05,094 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/y72z/002524/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/y72z/002524/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_15_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.15/cluster/node_1/logfile_cf5i97wi.log --grpc-port=29100 --mon-port=2631 --ic-port=31970
2025-11-01 16:19:05,095 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/y72z/002524/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/y72z/002524/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_15_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.15/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/y72z/002524/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_15_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.15/cluster/node_1/logfile_cf5i97wi.log', '--grpc-port=29100', '--mon-port=2631', '--ic-port=31970')' in '/home/runner/.ya/build/build_root/y72z/002524/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_15_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.15/cluster/node_1' (no wait)
2025-11-01 16:19:05,097 - DEBUG - ya.test - execute: Command pid: 516383
2025-11-01 16:19:05,098 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:29100/1
2025-11-01 16:19:05,100 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-11-01 16:19:05,101 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-11-01 16:19:05,101 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/y72z/002524/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 16:19:05,102 - DEBUG - ya.test - execute: Command pid: 516412
2025-11-01 16:19:05,747 - DEBUG - ya.test - _save_outputs: Command (pid 516412) rc: 0
2025-11-01 16:19:05,747 - DEBUG - ya.test - _save_outputs: Command (pid 516412) elapsed time (sec): 0.6439580917358398
2025-11-01 16:19:05,748 - DEBUG - ya.test - _save_outputs: Command (pid 516412) idrss: 0
2025-11-01 16:19:05,748 - DEBUG - ya.test - _save_outputs: Command (pid 516412) inblock: 0
2025-11-01 16:19:05,748 - DEBUG - ya.test - _save_outputs: Command (pid 516412) isrss: 0
2025-11-01 16:19:05,749 - DEBUG - ya.test - _save_outputs: Command (pid 516412) ixrss: 0
2025-11-01 16:19:05,749 - DEBUG - ya.test - _save_outputs: Command (pid 516412) majflt: 0
2025-11-01 16:19:05,749 - DEBUG - ya.test - _save_outputs: Command (pid 516412) maxrss: 502844
2025-11-01 16:19:05,749 - DEBUG - ya.test - _save_outputs: Command (pid 516412) minflt: 45402
2025-11-01 16:19:05,750 - DEBUG - ya.test - _save_outputs: Command (pid 516412) msgrcv: 0
2025-11-01 16:19:05,750 - DEBUG - ya.test - _save_outputs: Command (pid 516412) msgsnd: 0
2025-11-01 16:19:05,750 - DEBUG - ya.test - _save_outputs: Command (pid 516412) nivcsw: 33
2025-11-01 16:19:05,750 - DEBUG - ya.test - _save_outputs: Command (pid 516412) nsignals: 0
2025-11-01 16:19:05,751 - DEBUG - ya.test - _save_outputs: Command (pid 516412) nswap: 0
2025-11-01 16:19:05,751 - DEBUG - ya.test - _save_outputs: Command (pid 516412) nvcsw: 14
2025-11-01 16:19:05,751 - DEBUG - ya.test - _save_outputs: Command (pid 516412) oublock: 8
2025-11-01 16:19:05,751 - DEBUG - ya.test - _save_outputs: Command (pid 516412) stime: 0.16914099999999999
2025-11-01 16:19:05,752 - DEBUG - ya.test - _save_outputs: Command (pid 516412) utime: 0.426687
2025-11-01 16:19:05,752 - DEBUG - ya.test - _save_outputs: Command (pid 516412) wtime: 0.645
2025-11-01 16:19:05,752 - DEBUG - ya.test - _save_outputs: Command (pid 516412) output:
Git info:
    Commit: b759454d1e40b275ba8b2f5964202fc9f08a1c3c
    Branch: 
    Author: Denis Khalikov <dennis.khalikov@gmail.com>
    Summary: Merge b3001557f326a9ac3df9852d3eea5c83a6651a93 into 88f362bbf1115d2653ecf70400035099c5165741

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-cjocww3of4
    Host information: 
        Linux ghrun-cjocww3of4 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-01 16:19:05,753 - DEBUG - ya.test - _save_outputs: Command (pid 516412) errors:

2025-11-01 16:19:05,753 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: b759454d1e40b275ba8b2f5964202fc9f08a1c3c
    Branch: 
    Author: Denis Khalikov <dennis.khalikov@gmail.com>
    Summary: Merge b3001557f326a9ac3df9852d3eea5c83a6651a93 into 88f362bbf1115d2653ecf70400035099c5165741
2025-11-01 16:19:10,485 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/y72z/002524/ydb/apps/ydbd/ydbd
2025-11-01 16:19:10,486 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/y72z/002524/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:29100', '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: 31970\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-01 16:19:10,487 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-11-01 16:19:10,488 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-11-01 16:19:10,488 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/y72z/002524/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:29100', '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: 31970\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-01 16:19:10,495 - DEBUG - ya.test - execute: Command pid: 519185
2025-11-01 16:19:11,555 - DEBUG - ya.test - _save_outputs: Command (pid 519185) rc: 0
2025-11-01 16:19:11,555 - DEBUG - ya.test - _save_outputs: Command (pid 519185) elapsed time (sec): 1.0592334270477295
2025-11-01 16:19:11,556 - DEBUG - ya.test - _save_outputs: Command (pid 519185) idrss: 0
2025-11-01 16:19:11,556 - DEBUG - ya.test - _save_outputs: Command (pid 519185) inblock: 0
2025-11-01 16:19:11,556 - DEBUG - ya.test - _save_outputs: Command (pid 519185) isrss: 0
2025-11-01 16:19:11,557 - DEBUG - ya.test - _save_outputs: Command (pid 519185) ixrss: 0
2025-11-01 16:19:11,557 - DEBUG - ya.test - _save_outputs: Command (pid 519185) majflt: 0
2025-11-01 16:19:11,557 - DEBUG - ya.test - _save_outputs: Command (pid 519185) maxrss: 597520
2025-11-01 16:19:11,557 - DEBUG - ya.test - _save_outputs: Command (pid 519185) minflt: 51820
2025-11-01 16:19:11,558 - DEBUG - ya.test - _save_outputs: Command (pid 519185) msgrcv: 0
2025-11-01 16:19:11,558 - DEBUG - ya.test - _save_outputs: Command (pid 519185) msgsnd: 0
2025-11-01 16:19:11,558 - DEBUG - ya.test - _save_outputs: Command (pid 519185) nivcsw: 197
2025-11-01 16:19:11,558 - DEBUG - ya.test - _save_outputs: Command (pid 519185) nsignals: 0
2025-11-01 16:19:11,559 - DEBUG - ya.test - _save_outputs: Command (pid 519185) nswap: 0
2025-11-01 16:19:11,559 - DEBUG - ya.test - _save_outputs: Command (pid 519185) nvcsw: 728
2025-11-01 16:19:11,559 - DEBUG - ya.test - _save_outputs: Command (pid 519185) oublock: 8
2025-11-01 16:19:11,559 - DEBUG - ya.test - _save_outputs: Command (pid 519185) stime: 0.264388
2025-11-01 16:19:11,560 - DEBUG - ya.test - _save_outputs: Command (pid 519185) utime: 0.5279539999999999
2025-11-01 16:19:11,560 - DEBUG - ya.test - _save_outputs: Command (pid 519185) wtime: 1.066
2025-11-01 16:19:11,560 - DEBUG - ya.test - _save_outputs: Command (pid 519185) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-01 16:19:11,560 - DEBUG - ya.test - _save_outputs: Command (pid 519185) errors:

2025-11-01 16:19:11,562 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/y72z/002524/ydb/apps/ydbd/ydbd
2025-11-01 16:19:11,562 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/y72z/002524/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:29100', '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-01 16:19:11,563 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-11-01 16:19:11,564 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-11-01 16:19:11,564 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/y72z/002524/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:29100', '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-01 16:19:11,581 - DEBUG - ya.test - execute: Command pid: 519537
2025-11-01 16:19:12,532 - DEBUG - ya.test - _save_outputs: Command (pid 519537) rc: 0
2025-11-01 16:19:12,532 - DEBUG - ya.test - _save_outputs: Command (pid 519537) elapsed time (sec): 0.9502265453338623
2025-11-01 16:19:12,533 - DEBUG - ya.test - _save_outputs: Command (pid 519537) idrss: 0
2025-11-01 16:19:12,533 - DEBUG - ya.test - _save_outputs: Command (pid 519537) inblock: 0
2025-11-01 16:19:12,533 - DEBUG - ya.test - _save_outputs: Command (pid 519537) isrss: 0
2025-11-01 16:19:12,534 - DEBUG - ya.test - _save_outputs: Command (pid 519537) ixrss: 0
2025-11-01 16:19:12,534 - DEBUG - ya.test - _save_outputs: Command (pid 519537) majflt: 0
2025-11-01 16:19:12,534 - DEBUG - ya.test - _save_outputs: Command (pid 519537) maxrss: 597648
2025-11-01 16:19:12,534 - DEBUG - ya.test - _save_outputs: Command (pid 519537) minflt: 51661
2025-11-01 16:19:12,534 - DEBUG - ya.test - _save_outputs: Command (pid 519537) msgrcv: 0
2025-11-01 16:19:12,535 - DEBUG - ya.test - _save_outputs: Command (pid 519537) msgsnd: 0
2025-11-01 16:19:12,535 - DEBUG - ya.test - _save_outputs: Command (pid 519537) nivcsw: 133
2025-11-01 16:19:12,535 - DEBUG - ya.test - _save_outputs: Command (pid 519537) nsignals: 0
2025-11-01 16:19:12,535 - DEBUG - ya.test - _save_outputs: Command (pid 519537) nswap: 0
2025-11-01 16:19:12,536 - DEBUG - ya.test - _save_outputs: Command (pid 519537) nvcsw: 678
2025-11-01 16:19:12,536 - DEBUG - ya.test - _save_outputs: Command (pid 519537) oublock: 8
2025-11-01 16:19:12,536 - DEBUG - ya.test - _save_outputs: Command (pid 519537) stime: 0.17191499999999998
2025-11-01 16:19:12,537 - DEBUG - ya.test - _save_outputs: Command (pid 519537) utime: 0.565441
2025-11-01 16:19:12,537 - DEBUG - ya.test - _save_outputs: Command (pid 519537) wtime: 0.967
2025-11-01 16:19:12,537 - DEBUG - ya.test - _save_outputs: Command (pid 519537) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-11-01 16:19:12,538 - DEBUG - ya.test - _save_outputs: Command (pid 519537) errors:

2025-11-01 16:19:12,538 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-01 16:19:12,763 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-11-01 16:19:12,845 - 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-01 16:19:12,857 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 16:19:12,858 - 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-01 16:19:12,889 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-01 16:19:12,890 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, ec0a1034-25a7-493b-8208-8990f1de5daa, localhost:29100): creating call state
2025-11-01 16:19:12,891 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, ec0a1034-25a7-493b-8208-8990f1de5daa, localhost:29100): request = { database: "/Root" }
2025-11-01 16:19:12,898 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, ec0a1034-25a7-493b-8208-8990f1de5daa, localhost:29100): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-cjocww3of4.auto.internal" port: 29100 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-01 16:19:12,899 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-cjocww3of4.auto.internal:29100, location 1, ssl: False>]>
2025-11-01 16:19:12,900 - 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-01 16:19:12,930 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:29100
2025-11-01 16:19:12,931 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 16:19:12,938 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 10edf86a-6e12-4058-9a59-1720353143bc, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:12,939 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 10edf86a-6e12-4058-9a59-1720353143bc, ghrun-cjocww3of4.auto.internal:29100): request = {  }
2025-11-01 16:19:12,954 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 10edf86a-6e12-4058-9a59-1720353143bc, ghrun-cjocww3of4.auto.internal:29100): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" node_id: 1 }
2025-11-01 16:19:12,955 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, 285d8361-980e-4e8d-bd90-c35b90547a1e, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:12,955 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, 285d8361-980e-4e8d-bd90-c35b90547a1e, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" }
2025-11-01 16:19:12,961 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, 285d8361-980e-4e8d-bd90-c35b90547a1e, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:12,977 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:12,978 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ae85e45b-b10a-4b99-8772-c54dedf0a0af, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:12,979 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ae85e45b-b10a-4b99-8772-c54dedf0a0af, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:12,981 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ae85e45b-b10a-4b99-8772-c54dedf0a0af, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:15,755 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:15,755 - INFO - __tests__.alter_compression - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-11-01 16:19:15,756 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:15,756 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d2c90e62-68b8-47f9-af60-986c34d6f191, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:15,757 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d2c90e62-68b8-47f9-af60-986c34d6f191, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:15,758 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d2c90e62-68b8-47f9-af60-986c34d6f191, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:16,673 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:16,674 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:16,674 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2b721226-06a6-4f8b-a817-0259b1e9aba1, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:16,675 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2b721226-06a6-4f8b-a817-0259b1e9aba1, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:16,677 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2b721226-06a6-4f8b-a817-0259b1e9aba1, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:17,749 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:17,749 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:17,750 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7b64e059-2159-40f5-bcc2-e7a0035eb4bb, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:17,751 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7b64e059-2159-40f5-bcc2-e7a0035eb4bb, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:17,752 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7b64e059-2159-40f5-bcc2-e7a0035eb4bb, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:18,545 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:18,546 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:18,546 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 740fd36d-f089-4fec-abf3-14ef6477fd6a, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:18,547 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 740fd36d-f089-4fec-abf3-14ef6477fd6a, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:18,548 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 740fd36d-f089-4fec-abf3-14ef6477fd6a, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:19,848 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:19,849 - 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-01 16:19:19,849 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:19,850 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8e92c23a-0398-4e66-abdd-23a478020acc, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:19,851 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8e92c23a-0398-4e66-abdd-23a478020acc, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:19,852 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8e92c23a-0398-4e66-abdd-23a478020acc, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:20,737 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:20,738 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:20,739 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a476c865-6407-40cc-b86b-d250011bdd8f, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:20,739 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a476c865-6407-40cc-b86b-d250011bdd8f, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:20,742 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a476c865-6407-40cc-b86b-d250011bdd8f, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:20,992 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:20,993 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:20,993 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, dbc6983b-55ca-4c0d-9dff-4638ecc505e3, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:20,994 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, dbc6983b-55ca-4c0d-9dff-4638ecc505e3, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:20,995 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, dbc6983b-55ca-4c0d-9dff-4638ecc505e3, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:21,246 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:21,247 - 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-01 16:19:21,247 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:21,248 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, dce5365a-6953-456a-89f9-7ccab7c41a8e, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:21,248 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, dce5365a-6953-456a-89f9-7ccab7c41a8e, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:21,249 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, dce5365a-6953-456a-89f9-7ccab7c41a8e, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:22,092 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:22,092 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:22,093 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c365eae9-8d0d-4098-8860-19b54618c7ca, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:22,093 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c365eae9-8d0d-4098-8860-19b54618c7ca, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:22,095 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c365eae9-8d0d-4098-8860-19b54618c7ca, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:22,295 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:22,296 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:22,297 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9015779a-cedb-4426-a3db-2241e1d4b066, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:22,298 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9015779a-cedb-4426-a3db-2241e1d4b066, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:22,299 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9015779a-cedb-4426-a3db-2241e1d4b066, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:22,583 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:22,583 - 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-01 16:19:22,584 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:22,585 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ae73478f-3b35-4595-8abe-8eb83e3fd5d6, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:22,585 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ae73478f-3b35-4595-8abe-8eb83e3fd5d6, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:22,588 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ae73478f-3b35-4595-8abe-8eb83e3fd5d6, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:23,453 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:23,454 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:23,454 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 649e8d63-2e96-4ba5-b78b-d13936fe63c7, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:23,455 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 649e8d63-2e96-4ba5-b78b-d13936fe63c7, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:23,457 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 649e8d63-2e96-4ba5-b78b-d13936fe63c7, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:23,715 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:23,716 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:23,717 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, cba6daa3-ede3-4d53-aa13-811c5a115345, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:23,718 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, cba6daa3-ede3-4d53-aa13-811c5a115345, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:23,719 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, cba6daa3-ede3-4d53-aa13-811c5a115345, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:24,061 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:24,062 - 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-01 16:19:24,062 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:24,063 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, eaaa9b3b-be2b-49fe-800e-5a56b276f939, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:24,064 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, eaaa9b3b-be2b-49fe-800e-5a56b276f939, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:24,068 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, eaaa9b3b-be2b-49fe-800e-5a56b276f939, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:25,174 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:25,175 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:25,175 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 77d7d7b9-c17e-45ee-9d47-af6b0168e4bf, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:25,176 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 77d7d7b9-c17e-45ee-9d47-af6b0168e4bf, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:25,177 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 77d7d7b9-c17e-45ee-9d47-af6b0168e4bf, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:25,394 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:25,395 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:25,395 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 75d1cf4a-257a-4cd2-9cd0-1b750f897559, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:25,396 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 75d1cf4a-257a-4cd2-9cd0-1b750f897559, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:25,397 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 75d1cf4a-257a-4cd2-9cd0-1b750f897559, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:25,926 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:25,927 - 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-01 16:19:25,927 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:25,928 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 06edb4bb-7c75-47dd-879c-b288dc826d28, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:25,929 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 06edb4bb-7c75-47dd-879c-b288dc826d28, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:25,932 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 06edb4bb-7c75-47dd-879c-b288dc826d28, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:26,968 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:26,968 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:26,969 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d758b6b0-9cd2-40b3-b213-96e51e1b3f74, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:26,970 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d758b6b0-9cd2-40b3-b213-96e51e1b3f74, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:26,971 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d758b6b0-9cd2-40b3-b213-96e51e1b3f74, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:27,226 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:27,226 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:27,227 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1ba11999-6f20-4ce5-ad29-daf923c1f7f7, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:27,227 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1ba11999-6f20-4ce5-ad29-daf923c1f7f7, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:27,228 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1ba11999-6f20-4ce5-ad29-daf923c1f7f7, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:27,672 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:27,673 - 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-01 16:19:27,673 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:27,674 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, bda2610f-edc8-49e2-9670-d899b1da9e93, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:27,675 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, bda2610f-edc8-49e2-9670-d899b1da9e93, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:27,676 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, bda2610f-edc8-49e2-9670-d899b1da9e93, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:28,906 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:28,907 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:28,908 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8373d9be-fd7f-4195-bd6a-e8ad589a80ce, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:28,909 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8373d9be-fd7f-4195-bd6a-e8ad589a80ce, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:28,910 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8373d9be-fd7f-4195-bd6a-e8ad589a80ce, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:29,164 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:29,165 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:29,165 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7a1994f4-94b7-447d-87cb-01584de5db5f, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:29,166 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7a1994f4-94b7-447d-87cb-01584de5db5f, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:29,167 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7a1994f4-94b7-447d-87cb-01584de5db5f, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:29,654 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:29,654 - 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-01 16:19:29,655 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:29,656 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 267a7953-c746-4757-85b8-5e75746c8960, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:29,656 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 267a7953-c746-4757-85b8-5e75746c8960, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:29,658 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 267a7953-c746-4757-85b8-5e75746c8960, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:30,596 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:30,596 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:30,597 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b9556a59-45a0-467d-8d5e-1ef3d17a0c7e, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:30,598 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b9556a59-45a0-467d-8d5e-1ef3d17a0c7e, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:30,599 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b9556a59-45a0-467d-8d5e-1ef3d17a0c7e, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:30,907 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:30,908 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:30,908 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 845d48e6-044a-4dc4-bd2c-e2d4ee065639, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:30,909 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 845d48e6-044a-4dc4-bd2c-e2d4ee065639, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:30,910 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 845d48e6-044a-4dc4-bd2c-e2d4ee065639, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:31,666 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:31,667 - 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-01 16:19:31,667 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:31,668 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 17984275-db18-43ad-94b9-a49ab356e458, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:31,669 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 17984275-db18-43ad-94b9-a49ab356e458, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:31,670 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 17984275-db18-43ad-94b9-a49ab356e458, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:32,744 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:32,744 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:32,745 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e827b235-5419-46c3-8d02-61e975f296ca, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:32,746 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e827b235-5419-46c3-8d02-61e975f296ca, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:32,747 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e827b235-5419-46c3-8d02-61e975f296ca, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:33,085 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:33,086 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:33,087 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 804a3e8e-3d3b-48d2-baeb-ace467eceeaf, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:33,088 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 804a3e8e-3d3b-48d2-baeb-ace467eceeaf, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:33,089 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 804a3e8e-3d3b-48d2-baeb-ace467eceeaf, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:33,714 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:33,714 - 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-01 16:19:33,715 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:33,715 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1ea6e602-0d02-4daf-8fe9-57a1addc5787, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:33,720 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1ea6e602-0d02-4daf-8fe9-57a1addc5787, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:33,722 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1ea6e602-0d02-4daf-8fe9-57a1addc5787, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:34,870 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:34,871 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:34,872 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0ca119e2-6188-442d-aee9-41c5de87aef1, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:34,873 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0ca119e2-6188-442d-aee9-41c5de87aef1, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:34,874 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0ca119e2-6188-442d-aee9-41c5de87aef1, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:35,154 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:35,155 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:35,159 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7a0b5a16-694a-4ff8-9a7f-ba1cdd2e5995, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:35,161 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7a0b5a16-694a-4ff8-9a7f-ba1cdd2e5995, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:35,162 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7a0b5a16-694a-4ff8-9a7f-ba1cdd2e5995, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:35,778 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:35,779 - 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-01 16:19:35,780 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:35,781 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 28a1a3cf-9750-4b9e-850d-bddde18a1564, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:35,782 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 28a1a3cf-9750-4b9e-850d-bddde18a1564, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:35,783 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 28a1a3cf-9750-4b9e-850d-bddde18a1564, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:36,826 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:36,827 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:36,827 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 63bd4a4c-c2ef-467b-8a22-04f77385859c, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:36,828 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 63bd4a4c-c2ef-467b-8a22-04f77385859c, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:36,829 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 63bd4a4c-c2ef-467b-8a22-04f77385859c, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:37,099 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:37,100 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:37,100 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ae026a90-cf70-441a-a74f-fe99d06d64f7, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:37,101 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ae026a90-cf70-441a-a74f-fe99d06d64f7, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:37,103 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ae026a90-cf70-441a-a74f-fe99d06d64f7, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:37,341 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:37,342 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:37,342 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 65c1718e-704b-456c-b26b-9b64ee29f022, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:37,343 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 65c1718e-704b-456c-b26b-9b64ee29f022, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:37,349 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 65c1718e-704b-456c-b26b-9b64ee29f022, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:40,589 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:50,624 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:50,625 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b1b9ce56-27bb-4a13-a92b-520a010efef3, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:50,626 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b1b9ce56-27bb-4a13-a92b-520a010efef3, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:50,627 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b1b9ce56-27bb-4a13-a92b-520a010efef3, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:53,475 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:53,513 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-11-01 16:19:53,513 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:19:53,514 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e0a1c4e0-e515-4694-a329-ca6e8f90dec7, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:19:53,514 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e0a1c4e0-e515-4694-a329-ca6e8f90dec7, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:19:53,516 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e0a1c4e0-e515-4694-a329-ca6e8f90dec7, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:56,906 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:06,936 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:06,937 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 804ed2ab-7291-4972-923c-5790ac3a9c5e, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:06,938 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 804ed2ab-7291-4972-923c-5790ac3a9c5e, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:20:06,939 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 804ed2ab-7291-4972-923c-5790ac3a9c5e, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:10,351 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:10,390 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-11-01 16:20:10,390 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:10,391 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 93839be2-bf0e-4215-913c-244d6ec6ca5d, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:10,392 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 93839be2-bf0e-4215-913c-244d6ec6ca5d, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" 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-01 16:20:10,393 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 93839be2-bf0e-4215-913c-244d6ec6ca5d, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:10,708 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:10,711 - INFO - ya.test - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_15_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 15])
2025-11-01 16:20:10,713 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:10,714 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, cb894298-d124-4759-acd7-a7a92171572c, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:10,715 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, cb894298-d124-4759-acd7-a7a92171572c, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_15_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 15)\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:10,716 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, cb894298-d124-4759-acd7-a7a92171572c, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:13,961 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:13,961 - INFO - __tests__.alter_compression - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_15_compression created
2025-11-01 16:20:13,962 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:13,962 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5a10b02b-88b5-4e2c-9731-f2cc5e2f1660, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:13,963 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5a10b02b-88b5-4e2c-9731-f2cc5e2f1660, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_15_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:13,964 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5a10b02b-88b5-4e2c-9731-f2cc5e2f1660, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:15,196 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:15,197 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:15,198 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, cef46272-7090-4eda-b800-c9948310ed27, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:15,199 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, cef46272-7090-4eda-b800-c9948310ed27, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 0;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:15,200 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, cef46272-7090-4eda-b800-c9948310ed27, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:18,885 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:18,886 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:18,886 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7146edb5-eb7e-4390-9903-41f3de9869c5, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:18,887 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7146edb5-eb7e-4390-9903-41f3de9869c5, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:18,890 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7146edb5-eb7e-4390-9903-41f3de9869c5, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:20,233 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:20,234 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:20,235 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a1baccbf-4158-4258-8e38-0502cf67f13c, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:20,236 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a1baccbf-4158-4258-8e38-0502cf67f13c, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:20,239 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a1baccbf-4158-4258-8e38-0502cf67f13c, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:22,474 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:22,475 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318544, 'BlobCount': 128}}
2025-11-01 16:20:22,475 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:22,476 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 70d273ca-c843-4be3-8b9f-aa22a4ff0742, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:22,477 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 70d273ca-c843-4be3-8b9f-aa22a4ff0742, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 100000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:22,478 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 70d273ca-c843-4be3-8b9f-aa22a4ff0742, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:25,614 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:25,615 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:25,616 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c9f55873-6874-46e0-b075-d75755b4d481, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:25,617 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c9f55873-6874-46e0-b075-d75755b4d481, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:25,619 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c9f55873-6874-46e0-b075-d75755b4d481, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:25,893 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:25,894 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:25,895 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4f8f594e-6cac-496d-b5d5-486d1f27c3c2, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:25,896 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4f8f594e-6cac-496d-b5d5-486d1f27c3c2, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:25,901 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4f8f594e-6cac-496d-b5d5-486d1f27c3c2, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:26,218 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:26,219 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 638064, 'BlobCount': 256}}
2025-11-01 16:20:26,219 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:26,220 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, cff24ee3-12a5-4036-837d-18e1ab770487, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:26,221 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, cff24ee3-12a5-4036-837d-18e1ab770487, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 200000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:26,222 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, cff24ee3-12a5-4036-837d-18e1ab770487, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:28,801 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:28,802 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:28,802 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 18a80676-5243-4771-99f6-b6d9d47c92ce, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:28,803 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 18a80676-5243-4771-99f6-b6d9d47c92ce, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:28,804 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 18a80676-5243-4771-99f6-b6d9d47c92ce, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:29,058 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:29,059 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:29,060 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a29f3b07-599b-4544-a25a-907d7a6d9f8d, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:29,061 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a29f3b07-599b-4544-a25a-907d7a6d9f8d, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:29,062 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a29f3b07-599b-4544-a25a-907d7a6d9f8d, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:29,433 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:29,434 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 957088, 'BlobCount': 384}}
2025-11-01 16:20:29,434 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:29,435 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 44f18bb1-aca5-4fea-a1db-162fba4fa9bd, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:29,436 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 44f18bb1-aca5-4fea-a1db-162fba4fa9bd, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 300000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:29,438 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 44f18bb1-aca5-4fea-a1db-162fba4fa9bd, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:31,954 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:31,955 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:31,956 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c422ffd4-6d05-495b-ae47-3e5064e2726f, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:31,957 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c422ffd4-6d05-495b-ae47-3e5064e2726f, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:31,959 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c422ffd4-6d05-495b-ae47-3e5064e2726f, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:32,242 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:32,243 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:32,244 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5af335ca-30f4-4808-afd5-6c6c980ec31a, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:32,245 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5af335ca-30f4-4808-afd5-6c6c980ec31a, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:32,246 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5af335ca-30f4-4808-afd5-6c6c980ec31a, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:32,684 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:32,685 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1276560, 'BlobCount': 512}}
2025-11-01 16:20:32,685 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:32,686 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, cdf94941-91f3-48b1-a0a7-50d3735314b7, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:32,687 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, cdf94941-91f3-48b1-a0a7-50d3735314b7, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 400000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:32,693 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, cdf94941-91f3-48b1-a0a7-50d3735314b7, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:35,150 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:35,151 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:35,152 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7a87c820-9b9b-4ddc-8024-5393da093569, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:35,153 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7a87c820-9b9b-4ddc-8024-5393da093569, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:35,154 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7a87c820-9b9b-4ddc-8024-5393da093569, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:35,407 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:35,408 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:35,409 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5d6c6f64-5b29-4def-962d-3b257b07639d, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:35,410 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5d6c6f64-5b29-4def-962d-3b257b07639d, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:35,411 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5d6c6f64-5b29-4def-962d-3b257b07639d, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:36,023 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:36,024 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1595584, 'BlobCount': 640}}
2025-11-01 16:20:36,024 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:36,025 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8872aed6-b186-48c3-b922-d6ab2f17e058, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:36,026 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8872aed6-b186-48c3-b922-d6ab2f17e058, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 500000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:36,027 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8872aed6-b186-48c3-b922-d6ab2f17e058, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:38,762 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:38,763 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:38,763 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a366ad5c-6225-4e83-919c-4acef2421a61, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:38,764 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a366ad5c-6225-4e83-919c-4acef2421a61, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:38,766 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a366ad5c-6225-4e83-919c-4acef2421a61, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:39,177 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:39,178 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:39,179 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a061ab99-7379-420f-acd5-973374976b4a, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:39,180 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a061ab99-7379-420f-acd5-973374976b4a, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:39,182 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a061ab99-7379-420f-acd5-973374976b4a, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:39,839 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:39,840 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1914960, 'BlobCount': 768}}
2025-11-01 16:20:39,840 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:39,841 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7529e1fb-fb6b-4759-aad3-da6356d0fcf3, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:39,842 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7529e1fb-fb6b-4759-aad3-da6356d0fcf3, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 600000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:39,846 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7529e1fb-fb6b-4759-aad3-da6356d0fcf3, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:42,725 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:42,726 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:42,726 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c0d99147-e4c3-44b9-ada9-0d1fef8d6686, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:42,727 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c0d99147-e4c3-44b9-ada9-0d1fef8d6686, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:42,729 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c0d99147-e4c3-44b9-ada9-0d1fef8d6686, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:43,016 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:43,016 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:43,017 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4340fcbd-1828-4150-836e-68a71bfc8130, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:43,018 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4340fcbd-1828-4150-836e-68a71bfc8130, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:43,019 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4340fcbd-1828-4150-836e-68a71bfc8130, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:43,709 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:43,710 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2234080, 'BlobCount': 896}}
2025-11-01 16:20:43,710 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:43,711 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f63703f1-314f-45a4-8770-bf34a7d22a8c, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:43,712 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f63703f1-314f-45a4-8770-bf34a7d22a8c, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 700000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:43,713 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f63703f1-314f-45a4-8770-bf34a7d22a8c, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:47,250 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:47,251 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:47,252 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8ed5f36c-b2c9-4ca6-9389-1d22e2c27589, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:47,253 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8ed5f36c-b2c9-4ca6-9389-1d22e2c27589, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:47,254 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8ed5f36c-b2c9-4ca6-9389-1d22e2c27589, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:47,801 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:47,802 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:47,802 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8827e6ba-7090-48d6-a6bf-68f885c48c6b, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:47,803 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8827e6ba-7090-48d6-a6bf-68f885c48c6b, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:47,809 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8827e6ba-7090-48d6-a6bf-68f885c48c6b, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:48,539 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:48,540 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2553696, 'BlobCount': 1024}}
2025-11-01 16:20:48,540 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:48,541 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b5592a72-384e-4162-be1f-f1d8d445a4ec, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:48,542 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b5592a72-384e-4162-be1f-f1d8d445a4ec, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 800000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:48,543 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b5592a72-384e-4162-be1f-f1d8d445a4ec, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:51,501 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:51,502 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:51,503 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e940cd20-fe82-4882-9d80-cf7b1591a161, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:51,503 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e940cd20-fe82-4882-9d80-cf7b1591a161, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:51,505 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e940cd20-fe82-4882-9d80-cf7b1591a161, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:51,782 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:51,783 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:51,807 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1189876e-cfb9-4b10-9922-43fc8c6663d6, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:51,808 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1189876e-cfb9-4b10-9922-43fc8c6663d6, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:51,809 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1189876e-cfb9-4b10-9922-43fc8c6663d6, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:52,477 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:52,477 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2872720, 'BlobCount': 1152}}
2025-11-01 16:20:52,478 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:52,478 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4b8b62a9-4a08-4b45-bd0d-b3c95f870f35, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:52,479 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4b8b62a9-4a08-4b45-bd0d-b3c95f870f35, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 900000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:52,480 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4b8b62a9-4a08-4b45-bd0d-b3c95f870f35, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:55,345 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:55,345 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:55,346 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5a7a8093-0d81-4626-9283-8e1edd506239, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:55,347 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5a7a8093-0d81-4626-9283-8e1edd506239, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:55,348 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5a7a8093-0d81-4626-9283-8e1edd506239, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:55,724 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:55,725 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:55,725 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b6266893-9186-4cea-82cf-264fbdd04c7b, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:55,726 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b6266893-9186-4cea-82cf-264fbdd04c7b, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:55,727 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b6266893-9186-4cea-82cf-264fbdd04c7b, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:56,445 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:56,446 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3192432, 'BlobCount': 1280}}
2025-11-01 16:20:56,446 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:56,447 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9f9cdae2-497f-4b66-9453-d5637a8fba08, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:56,447 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9f9cdae2-497f-4b66-9453-d5637a8fba08, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_15_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:56,449 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9f9cdae2-497f-4b66-9453-d5637a8fba08, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:57,857 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:57,858 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:57,859 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 60799ebe-b60c-4a3f-b6a1-d2c21213df5c, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:57,859 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 60799ebe-b60c-4a3f-b6a1-d2c21213df5c, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:57,862 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 60799ebe-b60c-4a3f-b6a1-d2c21213df5c, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:58,213 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:58,213 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:58,214 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6b1f19ee-8b24-4160-a782-9dbeef3dde47, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:58,214 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6b1f19ee-8b24-4160-a782-9dbeef3dde47, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:58,215 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6b1f19ee-8b24-4160-a782-9dbeef3dde47, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:58,582 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:58,582 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:20:58,583 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0b10c614-0166-487a-b88f-b58dc2200e6e, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:20:58,584 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0b10c614-0166-487a-b88f-b58dc2200e6e, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:58,585 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0b10c614-0166-487a-b88f-b58dc2200e6e, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:03,072 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:21:07,181 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 16:21:07,181 - 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-01 16:21:07,218 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-01 16:21:07,219 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 77495282-c300-4e6b-84aa-30a3b03ce738, localhost:29100): creating call state
2025-11-01 16:21:07,219 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 77495282-c300-4e6b-84aa-30a3b03ce738, localhost:29100): request = { database: "/Root" }
2025-11-01 16:21:07,224 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 77495282-c300-4e6b-84aa-30a3b03ce738, localhost:29100): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-cjocww3of4.auto.internal" port: 29100 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-01 16:21:07,225 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-cjocww3of4.auto.internal:29100, location 1, ssl: False>]>
2025-11-01 16:21:07,226 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:29100
2025-11-01 16:21:13,155 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:21:13,156 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e5f279ad-c95c-4e0a-a50d-4729696bd31c, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:21:13,157 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e5f279ad-c95c-4e0a-a50d-4729696bd31c, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:21:13,159 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e5f279ad-c95c-4e0a-a50d-4729696bd31c, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:16,902 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:21:26,937 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:21:26,938 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 033c1538-8057-4a62-8b1a-480b2426e619, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:21:26,939 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 033c1538-8057-4a62-8b1a-480b2426e619, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:21:26,942 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 033c1538-8057-4a62-8b1a-480b2426e619, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:28,764 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:21:38,776 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:21:38,777 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, fa2654c3-4dfa-43f3-b27b-6a86a3809791, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:21:38,778 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, fa2654c3-4dfa-43f3-b27b-6a86a3809791, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:21:38,779 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, fa2654c3-4dfa-43f3-b27b-6a86a3809791, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:39,416 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:21:39,419 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_15_compression`, volumes `value` (8000000, 1870856)
2025-11-01 16:21:39,420 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:21:39,420 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 74abca46-66e1-4ac6-b4a7-1e906d76cabd, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:21:39,421 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 74abca46-66e1-4ac6-b4a7-1e906d76cabd, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:21:39,422 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 74abca46-66e1-4ac6-b4a7-1e906d76cabd, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:39,722 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:21:39,722 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:21:39,723 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b920444b-698c-4b7d-ad57-9d459edbe991, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:21:39,724 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b920444b-698c-4b7d-ad57-9d459edbe991, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:21:39,725 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b920444b-698c-4b7d-ad57-9d459edbe991, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:40,365 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:21:50,373 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:21:50,374 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 785b1d0a-6d89-4797-a586-a6785daeadd1, ghrun-cjocww3of4.auto.internal:29100): creating call state
2025-11-01 16:21:50,375 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 785b1d0a-6d89-4797-a586-a6785daeadd1, ghrun-cjocww3of4.auto.internal:29100): request = { session_id: "ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:21:50,376 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 785b1d0a-6d89-4797-a586-a6785daeadd1, ghrun-cjocww3of4.auto.internal:29100): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:50,939 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjNlZTE3YjAtZTBmODYxOWMtZDQwNGZkMWYtNTUxY2Y4MGU=
2025-11-01 16:21:50,942 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_15_compression`, volumes `value` (8000000, 1870856)
2025-11-01 16:21:50,942 - INFO - root - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_15_compression` 8092160 / 1870856: 4.325378329491954
2025-11-01 16:21:50,944 - INFO - ya.test - pytest_runtest_teardown: Test teardown
