2025-11-01 20:18:20,769 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 20:18:20,770 - INFO - ya.test - pytest_runtest_setup: test_all_supported_compression[zstd_12_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 12]
2025-11-01 20:18:20,770 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 20:18:20,770 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-01 20:18:20,773 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-11-01 20:18:20,774 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-11-01 20:18:20,775 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/4xuc/002505/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 20:18:20,777 - DEBUG - ya.test - execute: Command pid: 915984
2025-11-01 20:18:21,636 - DEBUG - ya.test - _save_outputs: Command (pid 915984) rc: 0
2025-11-01 20:18:21,637 - DEBUG - ya.test - _save_outputs: Command (pid 915984) elapsed time (sec): 0.8581295013427734
2025-11-01 20:18:21,637 - DEBUG - ya.test - _save_outputs: Command (pid 915984) idrss: 0
2025-11-01 20:18:21,637 - DEBUG - ya.test - _save_outputs: Command (pid 915984) inblock: 0
2025-11-01 20:18:21,638 - DEBUG - ya.test - _save_outputs: Command (pid 915984) isrss: 0
2025-11-01 20:18:21,638 - DEBUG - ya.test - _save_outputs: Command (pid 915984) ixrss: 0
2025-11-01 20:18:21,638 - DEBUG - ya.test - _save_outputs: Command (pid 915984) majflt: 0
2025-11-01 20:18:21,638 - DEBUG - ya.test - _save_outputs: Command (pid 915984) maxrss: 492072
2025-11-01 20:18:21,639 - DEBUG - ya.test - _save_outputs: Command (pid 915984) minflt: 45459
2025-11-01 20:18:21,639 - DEBUG - ya.test - _save_outputs: Command (pid 915984) msgrcv: 0
2025-11-01 20:18:21,639 - DEBUG - ya.test - _save_outputs: Command (pid 915984) msgsnd: 0
2025-11-01 20:18:21,639 - DEBUG - ya.test - _save_outputs: Command (pid 915984) nivcsw: 104
2025-11-01 20:18:21,640 - DEBUG - ya.test - _save_outputs: Command (pid 915984) nsignals: 0
2025-11-01 20:18:21,640 - DEBUG - ya.test - _save_outputs: Command (pid 915984) nswap: 0
2025-11-01 20:18:21,641 - DEBUG - ya.test - _save_outputs: Command (pid 915984) nvcsw: 14
2025-11-01 20:18:21,641 - DEBUG - ya.test - _save_outputs: Command (pid 915984) oublock: 8
2025-11-01 20:18:21,641 - DEBUG - ya.test - _save_outputs: Command (pid 915984) stime: 0.23731
2025-11-01 20:18:21,642 - DEBUG - ya.test - _save_outputs: Command (pid 915984) utime: 0.5308889999999999
2025-11-01 20:18:21,642 - DEBUG - ya.test - _save_outputs: Command (pid 915984) wtime: 0.861
2025-11-01 20:18:21,643 - DEBUG - ya.test - _save_outputs: Command (pid 915984) output:
Git info:
    Commit: 05d0b84db63541076afbd98f86145cdc7d321216
    Branch: 
    Author: Bulat <bylatgr@gmail.com>
    Summary: Merge 178566593d70f1bd1201a183576bb9dac2870947 into d673dcc87a894a66c7dc98770ee098d1af022f54

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-govtdgmox4
    Host information: 
        Linux ghrun-govtdgmox4 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 20:18:21,643 - DEBUG - ya.test - _save_outputs: Command (pid 915984) errors:

2025-11-01 20:18:21,644 - INFO - __tests__.base - _setup_ydb: Git info:
    Commit: 05d0b84db63541076afbd98f86145cdc7d321216
    Branch: 
    Author: Bulat <bylatgr@gmail.com>
    Summary: Merge 178566593d70f1bd1201a183576bb9dac2870947 into d673dcc87a894a66c7dc98770ee098d1af022f54

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-govtdgmox4
    Host information: 
        Linux ghrun-govtdgmox4 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 20:18:21,832 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/4xuc/002505/ydb/apps/ydbd/ydbd
2025-11-01 20:18:21,834 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/2869
2025-11-01 20:18:21,836 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/4xuc/002505/r3tmp/kikimr_cluster_r1o0cj9h
2025-11-01 20:18:21,884 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/4xuc/002505/ydb/apps/ydbd/ydbd
2025-11-01 20:18:21,885 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/18467
2025-11-01 20:18:21,885 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/17422
2025-11-01 20:18:21,886 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/26823
2025-11-01 20:18:21,887 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/1914
2025-11-01 20:18:21,888 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/4xuc/002505/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk1/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_12_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.12/cluster/kikimr_configs"
2025-11-01 20:18:21,888 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/4xuc/002505/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/4xuc/002505/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk1/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_12_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.12/cluster/node_1/logfile_9x49bzl7.log --grpc-port=18467 --mon-port=17422 --ic-port=2869
2025-11-01 20:18:21,889 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:18467/1, disk_size 68719476736
2025-11-01 20:18:21,889 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/4xuc/002505/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk1/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_12_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.12/cluster/kikimr_configs"
2025-11-01 20:18:21,890 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/4xuc/002505/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/4xuc/002505/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk1/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_12_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.12/cluster/node_1/logfile_9x49bzl7.log --grpc-port=18467 --mon-port=17422 --ic-port=2869
2025-11-01 20:18:21,891 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/4xuc/002505/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/4xuc/002505/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk1/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_12_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.12/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/4xuc/002505/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk1/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_12_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.12/cluster/node_1/logfile_9x49bzl7.log', '--grpc-port=18467', '--mon-port=17422', '--ic-port=2869')' in '/home/runner/.ya/build/build_root/4xuc/002505/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk1/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_12_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.12/cluster/node_1' (no wait)
2025-11-01 20:18:21,899 - DEBUG - ya.test - execute: Command pid: 916129
2025-11-01 20:18:21,900 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:18467/1
2025-11-01 20:18:21,902 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-11-01 20:18:21,903 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-11-01 20:18:21,903 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/4xuc/002505/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 20:18:21,907 - DEBUG - ya.test - execute: Command pid: 916131
2025-11-01 20:18:22,779 - DEBUG - ya.test - _save_outputs: Command (pid 916131) rc: 0
2025-11-01 20:18:22,780 - DEBUG - ya.test - _save_outputs: Command (pid 916131) elapsed time (sec): 0.8711607456207275
2025-11-01 20:18:22,780 - DEBUG - ya.test - _save_outputs: Command (pid 916131) idrss: 0
2025-11-01 20:18:22,781 - DEBUG - ya.test - _save_outputs: Command (pid 916131) inblock: 0
2025-11-01 20:18:22,781 - DEBUG - ya.test - _save_outputs: Command (pid 916131) isrss: 0
2025-11-01 20:18:22,781 - DEBUG - ya.test - _save_outputs: Command (pid 916131) ixrss: 0
2025-11-01 20:18:22,782 - DEBUG - ya.test - _save_outputs: Command (pid 916131) majflt: 0
2025-11-01 20:18:22,782 - DEBUG - ya.test - _save_outputs: Command (pid 916131) maxrss: 495676
2025-11-01 20:18:22,782 - DEBUG - ya.test - _save_outputs: Command (pid 916131) minflt: 45354
2025-11-01 20:18:22,783 - DEBUG - ya.test - _save_outputs: Command (pid 916131) msgrcv: 0
2025-11-01 20:18:22,783 - DEBUG - ya.test - _save_outputs: Command (pid 916131) msgsnd: 0
2025-11-01 20:18:22,784 - DEBUG - ya.test - _save_outputs: Command (pid 916131) nivcsw: 91
2025-11-01 20:18:22,784 - DEBUG - ya.test - _save_outputs: Command (pid 916131) nsignals: 0
2025-11-01 20:18:22,784 - DEBUG - ya.test - _save_outputs: Command (pid 916131) nswap: 0
2025-11-01 20:18:22,785 - DEBUG - ya.test - _save_outputs: Command (pid 916131) nvcsw: 13
2025-11-01 20:18:22,785 - DEBUG - ya.test - _save_outputs: Command (pid 916131) oublock: 8
2025-11-01 20:18:22,785 - DEBUG - ya.test - _save_outputs: Command (pid 916131) stime: 0.207087
2025-11-01 20:18:22,786 - DEBUG - ya.test - _save_outputs: Command (pid 916131) utime: 0.5806209999999999
2025-11-01 20:18:22,786 - DEBUG - ya.test - _save_outputs: Command (pid 916131) wtime: 0.875
2025-11-01 20:18:22,786 - DEBUG - ya.test - _save_outputs: Command (pid 916131) output:
Git info:
    Commit: 05d0b84db63541076afbd98f86145cdc7d321216
    Branch: 
    Author: Bulat <bylatgr@gmail.com>
    Summary: Merge 178566593d70f1bd1201a183576bb9dac2870947 into d673dcc87a894a66c7dc98770ee098d1af022f54

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-govtdgmox4
    Host information: 
        Linux ghrun-govtdgmox4 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 20:18:22,787 - DEBUG - ya.test - _save_outputs: Command (pid 916131) errors:

2025-11-01 20:18:22,787 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 05d0b84db63541076afbd98f86145cdc7d321216
    Branch: 
    Author: Bulat <bylatgr@gmail.com>
    Summary: Merge 178566593d70f1bd1201a183576bb9dac2870947 into d673dcc87a894a66c7dc98770ee098d1af022f54
2025-11-01 20:18:28,034 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/4xuc/002505/ydb/apps/ydbd/ydbd
2025-11-01 20:18:28,034 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/4xuc/002505/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:18467', '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: 2869\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-01 20:18:28,036 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-11-01 20:18:28,037 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-11-01 20:18:28,037 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/4xuc/002505/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:18467', '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: 2869\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-01 20:18:28,043 - DEBUG - ya.test - execute: Command pid: 917104
2025-11-01 20:18:29,068 - DEBUG - ya.test - _save_outputs: Command (pid 917104) rc: 0
2025-11-01 20:18:29,069 - DEBUG - ya.test - _save_outputs: Command (pid 917104) elapsed time (sec): 1.0244503021240234
2025-11-01 20:18:29,069 - DEBUG - ya.test - _save_outputs: Command (pid 917104) idrss: 0
2025-11-01 20:18:29,069 - DEBUG - ya.test - _save_outputs: Command (pid 917104) inblock: 0
2025-11-01 20:18:29,070 - DEBUG - ya.test - _save_outputs: Command (pid 917104) isrss: 0
2025-11-01 20:18:29,070 - DEBUG - ya.test - _save_outputs: Command (pid 917104) ixrss: 0
2025-11-01 20:18:29,070 - DEBUG - ya.test - _save_outputs: Command (pid 917104) majflt: 0
2025-11-01 20:18:29,071 - DEBUG - ya.test - _save_outputs: Command (pid 917104) maxrss: 593728
2025-11-01 20:18:29,071 - DEBUG - ya.test - _save_outputs: Command (pid 917104) minflt: 51598
2025-11-01 20:18:29,071 - DEBUG - ya.test - _save_outputs: Command (pid 917104) msgrcv: 0
2025-11-01 20:18:29,071 - DEBUG - ya.test - _save_outputs: Command (pid 917104) msgsnd: 0
2025-11-01 20:18:29,072 - DEBUG - ya.test - _save_outputs: Command (pid 917104) nivcsw: 211
2025-11-01 20:18:29,072 - DEBUG - ya.test - _save_outputs: Command (pid 917104) nsignals: 0
2025-11-01 20:18:29,073 - DEBUG - ya.test - _save_outputs: Command (pid 917104) nswap: 0
2025-11-01 20:18:29,073 - DEBUG - ya.test - _save_outputs: Command (pid 917104) nvcsw: 924
2025-11-01 20:18:29,073 - DEBUG - ya.test - _save_outputs: Command (pid 917104) oublock: 8
2025-11-01 20:18:29,074 - DEBUG - ya.test - _save_outputs: Command (pid 917104) stime: 0.29672
2025-11-01 20:18:29,074 - DEBUG - ya.test - _save_outputs: Command (pid 917104) utime: 0.577989
2025-11-01 20:18:29,074 - DEBUG - ya.test - _save_outputs: Command (pid 917104) wtime: 1.03
2025-11-01 20:18:29,075 - DEBUG - ya.test - _save_outputs: Command (pid 917104) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-01 20:18:29,075 - DEBUG - ya.test - _save_outputs: Command (pid 917104) errors:

2025-11-01 20:18:29,076 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/4xuc/002505/ydb/apps/ydbd/ydbd
2025-11-01 20:18:29,077 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/4xuc/002505/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:18467', '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 20:18:29,079 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-11-01 20:18:29,080 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-11-01 20:18:29,080 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/4xuc/002505/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:18467', '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 20:18:29,091 - DEBUG - ya.test - execute: Command pid: 917297
2025-11-01 20:18:30,135 - DEBUG - ya.test - _save_outputs: Command (pid 917297) rc: 0
2025-11-01 20:18:30,136 - DEBUG - ya.test - _save_outputs: Command (pid 917297) elapsed time (sec): 1.042752981185913
2025-11-01 20:18:30,136 - DEBUG - ya.test - _save_outputs: Command (pid 917297) idrss: 0
2025-11-01 20:18:30,136 - DEBUG - ya.test - _save_outputs: Command (pid 917297) inblock: 0
2025-11-01 20:18:30,137 - DEBUG - ya.test - _save_outputs: Command (pid 917297) isrss: 0
2025-11-01 20:18:30,137 - DEBUG - ya.test - _save_outputs: Command (pid 917297) ixrss: 0
2025-11-01 20:18:30,137 - DEBUG - ya.test - _save_outputs: Command (pid 917297) majflt: 0
2025-11-01 20:18:30,137 - DEBUG - ya.test - _save_outputs: Command (pid 917297) maxrss: 593728
2025-11-01 20:18:30,138 - DEBUG - ya.test - _save_outputs: Command (pid 917297) minflt: 51564
2025-11-01 20:18:30,138 - DEBUG - ya.test - _save_outputs: Command (pid 917297) msgrcv: 0
2025-11-01 20:18:30,138 - DEBUG - ya.test - _save_outputs: Command (pid 917297) msgsnd: 0
2025-11-01 20:18:30,143 - DEBUG - ya.test - _save_outputs: Command (pid 917297) nivcsw: 170
2025-11-01 20:18:30,144 - DEBUG - ya.test - _save_outputs: Command (pid 917297) nsignals: 0
2025-11-01 20:18:30,144 - DEBUG - ya.test - _save_outputs: Command (pid 917297) nswap: 0
2025-11-01 20:18:30,144 - DEBUG - ya.test - _save_outputs: Command (pid 917297) nvcsw: 609
2025-11-01 20:18:30,145 - DEBUG - ya.test - _save_outputs: Command (pid 917297) oublock: 8
2025-11-01 20:18:30,145 - DEBUG - ya.test - _save_outputs: Command (pid 917297) stime: 0.28599399999999997
2025-11-01 20:18:30,145 - DEBUG - ya.test - _save_outputs: Command (pid 917297) utime: 0.622077
2025-11-01 20:18:30,145 - DEBUG - ya.test - _save_outputs: Command (pid 917297) wtime: 1.054
2025-11-01 20:18:30,146 - DEBUG - ya.test - _save_outputs: Command (pid 917297) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-11-01 20:18:30,146 - DEBUG - ya.test - _save_outputs: Command (pid 917297) errors:

2025-11-01 20:18:30,151 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-01 20:18:30,298 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-11-01 20:18:30,338 - 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 20:18:30,347 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:18:30,348 - 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 20:18:30,390 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-01 20:18:30,392 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 5cc7a0f9-0b5b-43bd-bb08-a7ce757a5d95, localhost:18467): creating call state
2025-11-01 20:18:30,393 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 5cc7a0f9-0b5b-43bd-bb08-a7ce757a5d95, localhost:18467): request = { database: "/Root" }
2025-11-01 20:18:30,409 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 5cc7a0f9-0b5b-43bd-bb08-a7ce757a5d95, localhost:18467): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-govtdgmox4.auto.internal" port: 18467 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 20:18:30,411 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-govtdgmox4.auto.internal:18467, location 1, ssl: False>]>
2025-11-01 20:18:30,412 - 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 20:18:30,455 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:18467
2025-11-01 20:18:30,459 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:18:30,461 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 94f8df90-6e43-478f-be26-85f7c8e4e8df, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:30,461 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 94f8df90-6e43-478f-be26-85f7c8e4e8df, ghrun-govtdgmox4.auto.internal:18467): request = {  }
2025-11-01 20:18:30,470 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 94f8df90-6e43-478f-be26-85f7c8e4e8df, ghrun-govtdgmox4.auto.internal:18467): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" node_id: 1 }
2025-11-01 20:18:30,471 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, dda98e31-0b6a-4e98-9113-0ae0e13b1797, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:30,472 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, dda98e31-0b6a-4e98-9113-0ae0e13b1797, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" }
2025-11-01 20:18:30,475 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, dda98e31-0b6a-4e98-9113-0ae0e13b1797, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:30,487 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:30,488 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 36257268-baa6-4136-8055-bd22a1614de6, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:30,490 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 36257268-baa6-4136-8055-bd22a1614de6, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:18:30,496 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 36257268-baa6-4136-8055-bd22a1614de6, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:33,696 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:33,697 - INFO - __tests__.alter_compression - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-11-01 20:18:33,698 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:33,699 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, cdbeaca4-266f-4e7a-b487-3726efc19676, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:33,700 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, cdbeaca4-266f-4e7a-b487-3726efc19676, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:18:33,702 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, cdbeaca4-266f-4e7a-b487-3726efc19676, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:34,849 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:34,850 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:34,851 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5dcb1478-97da-4295-8f1e-11035d2c3428, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:34,852 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5dcb1478-97da-4295-8f1e-11035d2c3428, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:18:34,854 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5dcb1478-97da-4295-8f1e-11035d2c3428, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:36,231 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:36,232 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:36,233 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8899b817-8f57-4e45-af98-67f2b9598678, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:36,233 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8899b817-8f57-4e45-af98-67f2b9598678, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:18:36,239 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8899b817-8f57-4e45-af98-67f2b9598678, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:37,208 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:37,209 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:37,210 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, db96efd1-625d-4aff-857a-8fa4218928bd, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:37,210 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, db96efd1-625d-4aff-857a-8fa4218928bd, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:18:37,212 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, db96efd1-625d-4aff-857a-8fa4218928bd, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:38,817 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:38,818 - 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 20:18:38,819 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:38,820 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 130e1791-5bab-49c2-9148-ee37cba933f8, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:38,822 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 130e1791-5bab-49c2-9148-ee37cba933f8, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:18:38,824 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 130e1791-5bab-49c2-9148-ee37cba933f8, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:39,999 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:40,000 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:40,001 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, bdf5cb72-4c62-4789-8d1e-ccb3c6098513, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:40,002 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, bdf5cb72-4c62-4789-8d1e-ccb3c6098513, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:18:40,004 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, bdf5cb72-4c62-4789-8d1e-ccb3c6098513, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:40,303 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:40,304 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:40,305 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 40bbfd1a-c631-4fa3-8bb4-1c3e5cbe4d27, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:40,306 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 40bbfd1a-c631-4fa3-8bb4-1c3e5cbe4d27, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:18:40,312 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 40bbfd1a-c631-4fa3-8bb4-1c3e5cbe4d27, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:40,678 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:40,679 - 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 20:18:40,680 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:40,680 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, bf76a28f-fd2b-4478-aad9-4657e6504a7c, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:40,682 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, bf76a28f-fd2b-4478-aad9-4657e6504a7c, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:18:40,692 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, bf76a28f-fd2b-4478-aad9-4657e6504a7c, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:41,947 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:41,948 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:41,948 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 00e0e1af-c568-46ee-8e0c-35b91f30a6e5, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:41,949 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 00e0e1af-c568-46ee-8e0c-35b91f30a6e5, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:18:41,951 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 00e0e1af-c568-46ee-8e0c-35b91f30a6e5, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:42,170 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:42,171 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:42,172 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d1b9ffeb-4fba-46a6-947d-1f94c8bff007, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:42,173 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d1b9ffeb-4fba-46a6-947d-1f94c8bff007, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:18:42,175 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d1b9ffeb-4fba-46a6-947d-1f94c8bff007, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:42,579 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:42,580 - 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 20:18:42,581 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:42,581 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, fb71e6bf-f201-40a8-9676-b994f7e2ad60, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:42,583 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, fb71e6bf-f201-40a8-9676-b994f7e2ad60, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:18:42,584 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, fb71e6bf-f201-40a8-9676-b994f7e2ad60, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:43,652 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:43,653 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:43,654 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, dfb2164f-b7af-4edd-8b72-22c7f28083d9, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:43,655 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, dfb2164f-b7af-4edd-8b72-22c7f28083d9, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:18:43,657 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, dfb2164f-b7af-4edd-8b72-22c7f28083d9, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:43,980 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:43,981 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:43,982 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e11e7980-3f72-4f0b-947c-4566a8221737, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:43,983 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e11e7980-3f72-4f0b-947c-4566a8221737, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:18:43,985 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e11e7980-3f72-4f0b-947c-4566a8221737, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:44,725 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:44,726 - 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 20:18:44,727 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:44,728 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 11b08506-039c-49fc-af85-7ab251ad76da, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:44,729 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 11b08506-039c-49fc-af85-7ab251ad76da, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:18:44,731 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 11b08506-039c-49fc-af85-7ab251ad76da, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:46,143 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:46,146 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:46,147 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1e9849af-25b3-4df3-9415-7cd3626439fd, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:46,148 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1e9849af-25b3-4df3-9415-7cd3626439fd, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:18:46,150 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1e9849af-25b3-4df3-9415-7cd3626439fd, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:46,475 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:46,476 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:46,477 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, cd0f63e3-ef89-404e-92c0-ab4a5529a650, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:46,479 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, cd0f63e3-ef89-404e-92c0-ab4a5529a650, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:18:46,480 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, cd0f63e3-ef89-404e-92c0-ab4a5529a650, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:46,995 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:46,996 - 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 20:18:46,997 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:46,997 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 00e38ec4-ee12-40cc-bd94-39a2c489a08d, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:46,999 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 00e38ec4-ee12-40cc-bd94-39a2c489a08d, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:18:47,000 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 00e38ec4-ee12-40cc-bd94-39a2c489a08d, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:48,176 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:48,177 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:48,178 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b4860b58-8594-4087-9003-974771d2b89b, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:48,179 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b4860b58-8594-4087-9003-974771d2b89b, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:18:48,180 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b4860b58-8594-4087-9003-974771d2b89b, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:48,426 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:48,426 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:48,427 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8056d4e5-2a4c-498d-997e-5fc178b5d910, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:48,428 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8056d4e5-2a4c-498d-997e-5fc178b5d910, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:18:48,429 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8056d4e5-2a4c-498d-997e-5fc178b5d910, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:48,963 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:48,964 - 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 20:18:48,964 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:48,965 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3c35525e-db8b-455c-b625-39e0032a2f43, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:48,966 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3c35525e-db8b-455c-b625-39e0032a2f43, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:18:48,968 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3c35525e-db8b-455c-b625-39e0032a2f43, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:50,392 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:50,393 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:50,394 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1e00e5dc-b004-4944-ad02-b9796b8c7c00, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:50,395 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1e00e5dc-b004-4944-ad02-b9796b8c7c00, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:18:50,397 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1e00e5dc-b004-4944-ad02-b9796b8c7c00, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:50,727 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:50,727 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:50,728 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, bb71dcb6-060d-4bd9-986e-18be0f463779, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:50,729 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, bb71dcb6-060d-4bd9-986e-18be0f463779, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:18:50,730 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, bb71dcb6-060d-4bd9-986e-18be0f463779, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:51,255 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:51,256 - 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 20:18:51,257 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:51,257 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a63208ac-a356-46d5-a88b-515b9f33d2c7, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:51,259 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a63208ac-a356-46d5-a88b-515b9f33d2c7, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:18:51,261 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a63208ac-a356-46d5-a88b-515b9f33d2c7, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:52,471 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:52,472 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:52,473 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1e9a6d86-a5b4-4f8b-9f96-1ba16aece0e8, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:52,474 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1e9a6d86-a5b4-4f8b-9f96-1ba16aece0e8, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:18:52,480 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1e9a6d86-a5b4-4f8b-9f96-1ba16aece0e8, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:52,811 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:52,812 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:52,813 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a37f71b3-f6a2-44d2-8ddb-635b141aefd2, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:52,814 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a37f71b3-f6a2-44d2-8ddb-635b141aefd2, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:18:52,820 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a37f71b3-f6a2-44d2-8ddb-635b141aefd2, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:53,367 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:53,368 - 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 20:18:53,369 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:53,370 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 256c2de1-de96-497f-aed8-ad140fd82ae6, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:53,375 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 256c2de1-de96-497f-aed8-ad140fd82ae6, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:18:53,377 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 256c2de1-de96-497f-aed8-ad140fd82ae6, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:54,685 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:54,686 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:54,687 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 07f808c9-f8cb-45f6-8ca9-d23302d31002, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:54,688 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 07f808c9-f8cb-45f6-8ca9-d23302d31002, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:18:54,690 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 07f808c9-f8cb-45f6-8ca9-d23302d31002, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:55,009 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:55,010 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:55,011 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 05370315-7107-4115-8ad9-a02c21ff5d33, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:55,012 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 05370315-7107-4115-8ad9-a02c21ff5d33, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:18:55,016 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 05370315-7107-4115-8ad9-a02c21ff5d33, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:55,776 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:55,777 - 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 20:18:55,778 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:55,778 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, aabaf3f5-36bd-4c1e-b5f9-794ddbcef2ed, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:55,780 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, aabaf3f5-36bd-4c1e-b5f9-794ddbcef2ed, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:18:55,783 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, aabaf3f5-36bd-4c1e-b5f9-794ddbcef2ed, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:56,895 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:56,896 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:56,896 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a29d4b63-5aa4-4956-9b6c-442b18ec3821, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:56,897 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a29d4b63-5aa4-4956-9b6c-442b18ec3821, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:18:56,899 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a29d4b63-5aa4-4956-9b6c-442b18ec3821, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:57,171 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:57,172 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:57,173 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, aec8b24f-c9ef-459f-99db-fe0c31dc7b31, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:57,174 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, aec8b24f-c9ef-459f-99db-fe0c31dc7b31, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:18:57,177 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, aec8b24f-c9ef-459f-99db-fe0c31dc7b31, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:57,827 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:57,828 - 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 20:18:57,828 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:57,829 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8a228c25-0fad-4d55-b632-a7e446aa8c80, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:57,830 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8a228c25-0fad-4d55-b632-a7e446aa8c80, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:18:57,837 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8a228c25-0fad-4d55-b632-a7e446aa8c80, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:59,210 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:59,211 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:59,212 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2b9524a0-f5a3-4639-a2b7-603ca46d5df3, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:59,213 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2b9524a0-f5a3-4639-a2b7-603ca46d5df3, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:18:59,215 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2b9524a0-f5a3-4639-a2b7-603ca46d5df3, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:59,601 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:59,602 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:59,603 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f6eaad5d-6fb3-4c56-975d-9e3de06de8d7, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:59,604 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f6eaad5d-6fb3-4c56-975d-9e3de06de8d7, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:18:59,616 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f6eaad5d-6fb3-4c56-975d-9e3de06de8d7, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:59,987 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:59,988 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:18:59,989 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a264e625-0f31-4eb5-b75e-e452d230fc42, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:18:59,990 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a264e625-0f31-4eb5-b75e-e452d230fc42, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:18:59,992 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a264e625-0f31-4eb5-b75e-e452d230fc42, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:19:04,884 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:19:14,970 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:19:14,971 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9910a81f-64dd-49b7-87d7-11d4940ee014, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:19:14,972 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9910a81f-64dd-49b7-87d7-11d4940ee014, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:19:14,974 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9910a81f-64dd-49b7-87d7-11d4940ee014, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:19:18,711 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:19:18,766 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-11-01 20:19:18,767 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:19:18,768 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 64d58f3d-7459-4d29-94d6-87a5040dd1c7, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:19:18,769 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 64d58f3d-7459-4d29-94d6-87a5040dd1c7, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:19:18,770 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 64d58f3d-7459-4d29-94d6-87a5040dd1c7, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:19:23,250 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:19:33,295 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:19:33,296 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5c411418-899d-4cdb-a637-3afd331dfe93, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:19:33,297 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5c411418-899d-4cdb-a637-3afd331dfe93, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:19:33,300 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5c411418-899d-4cdb-a637-3afd331dfe93, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:19:37,472 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:19:47,511 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:19:47,512 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 647006f3-7089-4b83-863f-ab1f7a09530e, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:19:47,513 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 647006f3-7089-4b83-863f-ab1f7a09530e, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:19:47,514 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 647006f3-7089-4b83-863f-ab1f7a09530e, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:19:48,305 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:19:58,311 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:19:58,312 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 549aeeec-2a87-439e-a033-bd970d9d62c6, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:19:58,313 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 549aeeec-2a87-439e-a033-bd970d9d62c6, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:19:58,315 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 549aeeec-2a87-439e-a033-bd970d9d62c6, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:19:59,008 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:19:59,014 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8009216)
2025-11-01 20:19:59,014 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:19:59,015 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 64222eb8-6ab2-471d-b0c4-7a4665990c9a, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:19:59,016 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 64222eb8-6ab2-471d-b0c4-7a4665990c9a, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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 20:19:59,018 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 64222eb8-6ab2-471d-b0c4-7a4665990c9a, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:19:59,336 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:19:59,340 - INFO - ya.test - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_12_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 12])
2025-11-01 20:19:59,341 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:19:59,342 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a96a4f78-5ec3-4376-b80e-f37b5c5ed9db, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:19:59,343 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a96a4f78-5ec3-4376-b80e-f37b5c5ed9db, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_12_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 12)\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:19:59,345 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a96a4f78-5ec3-4376-b80e-f37b5c5ed9db, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:02,903 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:02,904 - INFO - __tests__.alter_compression - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_12_compression created
2025-11-01 20:20:02,904 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:02,905 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e2c6b6bf-372d-4461-878a-0504badab95d, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:20:02,906 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e2c6b6bf-372d-4461-878a-0504badab95d, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_12_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:02,912 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e2c6b6bf-372d-4461-878a-0504badab95d, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:03,893 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:03,894 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:03,895 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, adcbc1b4-d571-4023-a3b5-925f48c9c9bf, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:20:03,895 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, adcbc1b4-d571-4023-a3b5-925f48c9c9bf, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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_12_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:03,897 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, adcbc1b4-d571-4023-a3b5-925f48c9c9bf, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:06,650 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:06,650 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:06,651 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 862be8e8-0420-4d75-8f1b-a8d702819782, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:20:06,652 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 862be8e8-0420-4d75-8f1b-a8d702819782, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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_12_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:06,653 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 862be8e8-0420-4d75-8f1b-a8d702819782, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:07,979 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:07,980 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:07,981 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, add92931-1102-4135-9753-f727754d52ce, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:20:07,982 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, add92931-1102-4135-9753-f727754d52ce, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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_12_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:07,984 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, add92931-1102-4135-9753-f727754d52ce, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:10,405 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:10,405 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 375776, 'BlobCount': 128}}
2025-11-01 20:20:10,406 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:10,407 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ee60465d-7a08-4d68-9a69-f721014bb346, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:20:10,408 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ee60465d-7a08-4d68-9a69-f721014bb346, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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_12_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:10,410 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ee60465d-7a08-4d68-9a69-f721014bb346, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:13,276 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:13,277 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:13,278 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 29817033-8c56-429b-846c-31d5db24a526, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:20:13,279 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 29817033-8c56-429b-846c-31d5db24a526, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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_12_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:13,281 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 29817033-8c56-429b-846c-31d5db24a526, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:13,606 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:13,608 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:13,609 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4470f2dd-21b8-4d66-be9a-4b5d2c1d89c9, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:20:13,610 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4470f2dd-21b8-4d66-be9a-4b5d2c1d89c9, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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_12_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:13,614 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4470f2dd-21b8-4d66-be9a-4b5d2c1d89c9, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:13,899 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:20:13,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 20:20:13,934 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-01 20:20:13,935 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, a0b1a4c3-7743-4008-9e80-71bf4e54cc64, localhost:18467): creating call state
2025-11-01 20:20:13,936 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, a0b1a4c3-7743-4008-9e80-71bf4e54cc64, localhost:18467): request = { database: "/Root" }
2025-11-01 20:20:13,969 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, a0b1a4c3-7743-4008-9e80-71bf4e54cc64, localhost:18467): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-govtdgmox4.auto.internal" port: 18467 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 20:20:13,970 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-govtdgmox4.auto.internal:18467, location 1, ssl: False>]>
2025-11-01 20:20:13,970 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:18467
2025-11-01 20:20:14,059 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:14,060 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 753024, 'BlobCount': 256}}
2025-11-01 20:20:14,061 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:14,062 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 788db0fc-682c-4829-917d-e4681c6277d9, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:20:14,063 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 788db0fc-682c-4829-917d-e4681c6277d9, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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_12_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:14,065 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 788db0fc-682c-4829-917d-e4681c6277d9, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:16,788 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:16,789 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:16,790 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b6b216cf-e070-404b-8509-2ddd46da7b4f, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:20:16,791 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b6b216cf-e070-404b-8509-2ddd46da7b4f, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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_12_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:16,793 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b6b216cf-e070-404b-8509-2ddd46da7b4f, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:17,095 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:17,096 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:17,096 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 02c6d52f-84a4-469c-9894-ae12e9621418, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:20:17,097 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 02c6d52f-84a4-469c-9894-ae12e9621418, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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_12_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:17,099 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 02c6d52f-84a4-469c-9894-ae12e9621418, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:17,576 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:17,577 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 1129904, 'BlobCount': 384}}
2025-11-01 20:20:17,578 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:17,579 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 90ff59b2-ccfe-4bd0-a775-5779507cffb1, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:20:17,580 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 90ff59b2-ccfe-4bd0-a775-5779507cffb1, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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_12_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:17,582 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 90ff59b2-ccfe-4bd0-a775-5779507cffb1, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:20,423 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:20,424 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:20,425 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3c91b236-a62f-4b73-9e81-cb3330fbe375, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:20:20,425 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3c91b236-a62f-4b73-9e81-cb3330fbe375, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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_12_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:20,427 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3c91b236-a62f-4b73-9e81-cb3330fbe375, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:20,731 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:20,732 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:20,733 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ab1e1800-6c54-4a4a-bc37-1a958d179e2d, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:20:20,734 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ab1e1800-6c54-4a4a-bc37-1a958d179e2d, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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_12_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:20,736 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ab1e1800-6c54-4a4a-bc37-1a958d179e2d, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:21,209 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:21,210 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1507088, 'BlobCount': 512}}
2025-11-01 20:20:21,211 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:21,211 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 17d080d7-cc77-4310-bd2d-a3b70f8c2c56, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:20:21,213 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 17d080d7-cc77-4310-bd2d-a3b70f8c2c56, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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_12_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:21,215 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 17d080d7-cc77-4310-bd2d-a3b70f8c2c56, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:24,080 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:24,081 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:24,082 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 49b8b485-e00c-49ec-aeca-3229ea45db32, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:20:24,084 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 49b8b485-e00c-49ec-aeca-3229ea45db32, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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_12_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:24,086 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 49b8b485-e00c-49ec-aeca-3229ea45db32, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:24,374 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:24,375 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:24,376 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f26f7dd9-adda-4a1c-8436-871f6345ceed, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:20:24,377 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f26f7dd9-adda-4a1c-8436-871f6345ceed, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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_12_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:24,379 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f26f7dd9-adda-4a1c-8436-871f6345ceed, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:24,860 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:24,861 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1883952, 'BlobCount': 640}}
2025-11-01 20:20:24,862 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:24,863 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a15f82f2-f6cb-419f-aae6-d1a1cbeebc06, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:20:24,864 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a15f82f2-f6cb-419f-aae6-d1a1cbeebc06, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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_12_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:24,872 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a15f82f2-f6cb-419f-aae6-d1a1cbeebc06, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:27,463 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:27,464 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:27,465 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b41e8562-00aa-4192-be98-ed604cdb54d5, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:20:27,466 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b41e8562-00aa-4192-be98-ed604cdb54d5, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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_12_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:27,468 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b41e8562-00aa-4192-be98-ed604cdb54d5, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:27,812 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:27,813 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:27,814 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 411ea2ba-573c-466c-83eb-77206dff5c60, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:20:27,815 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 411ea2ba-573c-466c-83eb-77206dff5c60, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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_12_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:27,818 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 411ea2ba-573c-466c-83eb-77206dff5c60, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:28,363 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:28,364 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 2261152, 'BlobCount': 768}}
2025-11-01 20:20:28,365 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:28,365 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 405f15e1-983e-4c23-bbd9-e336a855489a, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:20:28,366 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 405f15e1-983e-4c23-bbd9-e336a855489a, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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_12_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:28,368 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 405f15e1-983e-4c23-bbd9-e336a855489a, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:31,214 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:31,215 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:31,216 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, cbe42ec6-16f5-4d62-8ea4-2bc71ee4b16e, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:20:31,217 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, cbe42ec6-16f5-4d62-8ea4-2bc71ee4b16e, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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_12_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:31,219 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, cbe42ec6-16f5-4d62-8ea4-2bc71ee4b16e, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:31,761 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:31,762 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:31,763 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1569c877-5117-4da0-99a0-6b5344223cc1, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:20:31,764 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1569c877-5117-4da0-99a0-6b5344223cc1, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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_12_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:31,766 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1569c877-5117-4da0-99a0-6b5344223cc1, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:32,427 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:32,428 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2638128, 'BlobCount': 896}}
2025-11-01 20:20:32,428 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:32,429 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, bc1ec8d0-0190-415c-aafb-e07ac4d55122, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:20:32,437 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, bc1ec8d0-0190-415c-aafb-e07ac4d55122, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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_12_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:32,439 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, bc1ec8d0-0190-415c-aafb-e07ac4d55122, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:35,672 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:35,673 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:35,674 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1e484736-4760-48f6-a7d6-bb0f99d65c9c, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:20:35,675 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1e484736-4760-48f6-a7d6-bb0f99d65c9c, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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_12_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:35,677 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1e484736-4760-48f6-a7d6-bb0f99d65c9c, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:36,200 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:36,201 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:36,201 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6dc457bd-7722-4ea0-9d58-3e40bfd2815b, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:20:36,203 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6dc457bd-7722-4ea0-9d58-3e40bfd2815b, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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_12_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:36,205 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6dc457bd-7722-4ea0-9d58-3e40bfd2815b, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:36,949 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:36,949 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 3015296, 'BlobCount': 1024}}
2025-11-01 20:20:36,950 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:36,951 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 405ce5f3-7395-4851-88bd-029054484fd1, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:20:36,952 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 405ce5f3-7395-4851-88bd-029054484fd1, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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_12_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:36,954 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 405ce5f3-7395-4851-88bd-029054484fd1, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:39,908 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:39,909 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:39,909 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a035141e-b55a-478a-99e0-c3a9f85036c0, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:20:39,910 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a035141e-b55a-478a-99e0-c3a9f85036c0, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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_12_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:39,917 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a035141e-b55a-478a-99e0-c3a9f85036c0, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:40,340 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:40,341 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:40,342 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e6e0173d-dccb-42e8-875c-c434bf3dfa92, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:20:40,343 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e6e0173d-dccb-42e8-875c-c434bf3dfa92, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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_12_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:40,345 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e6e0173d-dccb-42e8-875c-c434bf3dfa92, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:41,136 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:41,137 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 3392304, 'BlobCount': 1152}}
2025-11-01 20:20:41,138 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:41,138 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6b47a1e7-9ffa-4629-ac5e-4f32c2abcca1, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:20:41,139 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6b47a1e7-9ffa-4629-ac5e-4f32c2abcca1, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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_12_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:41,141 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6b47a1e7-9ffa-4629-ac5e-4f32c2abcca1, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:44,159 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:44,160 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:44,161 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ae41703b-094e-44a1-9164-5e0c597abcd8, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:20:44,162 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ae41703b-094e-44a1-9164-5e0c597abcd8, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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_12_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:44,163 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ae41703b-094e-44a1-9164-5e0c597abcd8, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:44,575 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:44,576 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:44,577 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0983ce83-d5a0-4f2b-938f-43bed278216f, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:20:44,578 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0983ce83-d5a0-4f2b-938f-43bed278216f, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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_12_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:44,580 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0983ce83-d5a0-4f2b-938f-43bed278216f, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:45,330 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:45,331 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3769616, 'BlobCount': 1280}}
2025-11-01 20:20:45,332 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:45,332 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f9001c5f-9897-44e1-a1aa-c0b633dfdfd9, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:20:45,333 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f9001c5f-9897-44e1-a1aa-c0b633dfdfd9, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_12_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:45,335 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f9001c5f-9897-44e1-a1aa-c0b633dfdfd9, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:46,605 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:46,605 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:46,606 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 90ae8a4f-0fc1-4664-bda5-a6662b8951dc, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:20:46,607 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 90ae8a4f-0fc1-4664-bda5-a6662b8951dc, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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_12_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:46,610 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 90ae8a4f-0fc1-4664-bda5-a6662b8951dc, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:47,009 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:47,010 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:47,011 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, cecb4693-e708-4083-aa3d-1a1c3678a4e4, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:20:47,012 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, cecb4693-e708-4083-aa3d-1a1c3678a4e4, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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_12_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:47,014 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, cecb4693-e708-4083-aa3d-1a1c3678a4e4, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:47,466 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:47,467 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:20:47,468 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b52ec811-dfd7-4152-b5b5-28b32e0253a6, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:20:47,469 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b52ec811-dfd7-4152-b5b5-28b32e0253a6, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_12_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:47,472 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b52ec811-dfd7-4152-b5b5-28b32e0253a6, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:52,687 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:21:02,736 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:21:02,737 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c3a41963-019f-4f0a-ab89-6cc4060863a4, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:21:02,738 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c3a41963-019f-4f0a-ab89-6cc4060863a4, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_12_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:21:02,739 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c3a41963-019f-4f0a-ab89-6cc4060863a4, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:21:08,151 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:21:14,659 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:21:14,659 - 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 20:21:14,698 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-01 20:21:14,699 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, cc465b2f-e67a-4842-ac4b-22934155b1b1, localhost:18467): creating call state
2025-11-01 20:21:14,700 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, cc465b2f-e67a-4842-ac4b-22934155b1b1, localhost:18467): request = { database: "/Root" }
2025-11-01 20:21:14,717 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, cc465b2f-e67a-4842-ac4b-22934155b1b1, localhost:18467): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-govtdgmox4.auto.internal" port: 18467 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 20:21:14,718 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-govtdgmox4.auto.internal:18467, location 1, ssl: False>]>
2025-11-01 20:21:14,718 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:18467
2025-11-01 20:21:18,220 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:21:18,222 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c2646f50-6f7c-4667-90a4-9a79f143cad3, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:21:18,223 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c2646f50-6f7c-4667-90a4-9a79f143cad3, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_12_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:21:18,224 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c2646f50-6f7c-4667-90a4-9a79f143cad3, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:21:20,029 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:21:30,041 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:21:30,042 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2921dd7c-05ef-49d6-b417-3a74f73927bb, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:21:30,043 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2921dd7c-05ef-49d6-b417-3a74f73927bb, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_12_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:21:30,045 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2921dd7c-05ef-49d6-b417-3a74f73927bb, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:21:30,908 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:21:30,914 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_12_compression`, volumes `value` (8000000, 1465648)
2025-11-01 20:21:30,915 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:21:30,916 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0c0ff733-8994-402f-97d4-82bd269cb05e, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:21:30,917 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0c0ff733-8994-402f-97d4-82bd269cb05e, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" 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_12_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:21:30,919 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0c0ff733-8994-402f-97d4-82bd269cb05e, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:21:31,272 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:21:31,274 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:21:31,275 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 23a600ab-a5c6-4621-a4c9-6cf9126012de, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:21:31,276 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 23a600ab-a5c6-4621-a4c9-6cf9126012de, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_12_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:21:31,277 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 23a600ab-a5c6-4621-a4c9-6cf9126012de, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:21:32,273 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:21:42,279 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:21:42,281 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, fe55d35a-9622-4ff8-a66f-b81d866cf3c9, ghrun-govtdgmox4.auto.internal:18467): creating call state
2025-11-01 20:21:42,282 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, fe55d35a-9622-4ff8-a66f-b81d866cf3c9, ghrun-govtdgmox4.auto.internal:18467): request = { session_id: "ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_12_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:21:42,288 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, fe55d35a-9622-4ff8-a66f-b81d866cf3c9, ghrun-govtdgmox4.auto.internal:18467): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:21:43,516 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjAxZTYzZmMtYmM5OTkyMGUtMzlmNjg1YjctMWQ5YWJkNWM=
2025-11-01 20:21:43,522 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_12_compression`, volumes `value` (8000000, 1465648)
2025-11-01 20:21:43,522 - INFO - root - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_12_compression` 8092160 / 1465648: 5.52121655404299
2025-11-01 20:21:43,525 - INFO - ya.test - pytest_runtest_teardown: Test teardown
