2025-11-01 20:18:21,896 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 20:18:21,897 - INFO - ya.test - pytest_runtest_setup: test_all_supported_compression[zstd_4_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 4]
2025-11-01 20:18:21,897 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 20:18:21,897 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-01 20:18:21,900 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-11-01 20:18:21,900 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-11-01 20:18:21,901 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/4xuc/0024f6/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 20:18:21,903 - DEBUG - ya.test - execute: Command pid: 916130
2025-11-01 20:18:22,791 - DEBUG - ya.test - _save_outputs: Command (pid 916130) rc: 0
2025-11-01 20:18:22,791 - DEBUG - ya.test - _save_outputs: Command (pid 916130) elapsed time (sec): 0.886899471282959
2025-11-01 20:18:22,792 - DEBUG - ya.test - _save_outputs: Command (pid 916130) idrss: 0
2025-11-01 20:18:22,792 - DEBUG - ya.test - _save_outputs: Command (pid 916130) inblock: 0
2025-11-01 20:18:22,792 - DEBUG - ya.test - _save_outputs: Command (pid 916130) isrss: 0
2025-11-01 20:18:22,792 - DEBUG - ya.test - _save_outputs: Command (pid 916130) ixrss: 0
2025-11-01 20:18:22,793 - DEBUG - ya.test - _save_outputs: Command (pid 916130) majflt: 0
2025-11-01 20:18:22,793 - DEBUG - ya.test - _save_outputs: Command (pid 916130) maxrss: 493796
2025-11-01 20:18:22,793 - DEBUG - ya.test - _save_outputs: Command (pid 916130) minflt: 45324
2025-11-01 20:18:22,794 - DEBUG - ya.test - _save_outputs: Command (pid 916130) msgrcv: 0
2025-11-01 20:18:22,794 - DEBUG - ya.test - _save_outputs: Command (pid 916130) msgsnd: 0
2025-11-01 20:18:22,794 - DEBUG - ya.test - _save_outputs: Command (pid 916130) nivcsw: 194
2025-11-01 20:18:22,795 - DEBUG - ya.test - _save_outputs: Command (pid 916130) nsignals: 0
2025-11-01 20:18:22,795 - DEBUG - ya.test - _save_outputs: Command (pid 916130) nswap: 0
2025-11-01 20:18:22,795 - DEBUG - ya.test - _save_outputs: Command (pid 916130) nvcsw: 14
2025-11-01 20:18:22,795 - DEBUG - ya.test - _save_outputs: Command (pid 916130) oublock: 8
2025-11-01 20:18:22,796 - DEBUG - ya.test - _save_outputs: Command (pid 916130) stime: 0.209346
2025-11-01 20:18:22,796 - DEBUG - ya.test - _save_outputs: Command (pid 916130) utime: 0.5572779999999999
2025-11-01 20:18:22,796 - DEBUG - ya.test - _save_outputs: Command (pid 916130) wtime: 0.889
2025-11-01 20:18:22,807 - DEBUG - ya.test - _save_outputs: Command (pid 916130) 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,807 - DEBUG - ya.test - _save_outputs: Command (pid 916130) errors:

2025-11-01 20:18:22,808 - 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:22,934 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/4xuc/0024f6/ydb/apps/ydbd/ydbd
2025-11-01 20:18:22,935 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/26241
2025-11-01 20:18:22,938 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/4xuc/0024f6/r3tmp/kikimr_cluster_1wc_ilky
2025-11-01 20:18:22,975 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/4xuc/0024f6/ydb/apps/ydbd/ydbd
2025-11-01 20:18:22,976 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/8330
2025-11-01 20:18:22,976 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/2338
2025-11-01 20:18:22,977 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/23444
2025-11-01 20:18:22,977 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/61780
2025-11-01 20:18:22,978 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/4xuc/0024f6/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/kikimr_configs"
2025-11-01 20:18:22,978 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/4xuc/0024f6/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/0024f6/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/node_1/logfile_y2qu8rzl.log --grpc-port=8330 --mon-port=2338 --ic-port=26241
2025-11-01 20:18:22,979 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:8330/1, disk_size 68719476736
2025-11-01 20:18:22,979 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/4xuc/0024f6/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/kikimr_configs"
2025-11-01 20:18:22,980 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/4xuc/0024f6/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/0024f6/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/node_1/logfile_y2qu8rzl.log --grpc-port=8330 --mon-port=2338 --ic-port=26241
2025-11-01 20:18:22,981 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/4xuc/0024f6/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/4xuc/0024f6/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/4xuc/0024f6/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/node_1/logfile_y2qu8rzl.log', '--grpc-port=8330', '--mon-port=2338', '--ic-port=26241')' in '/home/runner/.ya/build/build_root/4xuc/0024f6/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/node_1' (no wait)
2025-11-01 20:18:22,987 - DEBUG - ya.test - execute: Command pid: 916245
2025-11-01 20:18:22,988 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:8330/1
2025-11-01 20:18:22,990 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-11-01 20:18:22,990 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-11-01 20:18:22,991 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/4xuc/0024f6/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 20:18:22,995 - DEBUG - ya.test - execute: Command pid: 916246
2025-11-01 20:18:23,867 - DEBUG - ya.test - _save_outputs: Command (pid 916246) rc: 0
2025-11-01 20:18:23,867 - DEBUG - ya.test - _save_outputs: Command (pid 916246) elapsed time (sec): 0.8712079524993896
2025-11-01 20:18:23,868 - DEBUG - ya.test - _save_outputs: Command (pid 916246) idrss: 0
2025-11-01 20:18:23,868 - DEBUG - ya.test - _save_outputs: Command (pid 916246) inblock: 0
2025-11-01 20:18:23,868 - DEBUG - ya.test - _save_outputs: Command (pid 916246) isrss: 0
2025-11-01 20:18:23,869 - DEBUG - ya.test - _save_outputs: Command (pid 916246) ixrss: 0
2025-11-01 20:18:23,869 - DEBUG - ya.test - _save_outputs: Command (pid 916246) majflt: 0
2025-11-01 20:18:23,869 - DEBUG - ya.test - _save_outputs: Command (pid 916246) maxrss: 503400
2025-11-01 20:18:23,870 - DEBUG - ya.test - _save_outputs: Command (pid 916246) minflt: 45298
2025-11-01 20:18:23,870 - DEBUG - ya.test - _save_outputs: Command (pid 916246) msgrcv: 0
2025-11-01 20:18:23,879 - DEBUG - ya.test - _save_outputs: Command (pid 916246) msgsnd: 0
2025-11-01 20:18:23,879 - DEBUG - ya.test - _save_outputs: Command (pid 916246) nivcsw: 145
2025-11-01 20:18:23,879 - DEBUG - ya.test - _save_outputs: Command (pid 916246) nsignals: 0
2025-11-01 20:18:23,880 - DEBUG - ya.test - _save_outputs: Command (pid 916246) nswap: 0
2025-11-01 20:18:23,880 - DEBUG - ya.test - _save_outputs: Command (pid 916246) nvcsw: 14
2025-11-01 20:18:23,880 - DEBUG - ya.test - _save_outputs: Command (pid 916246) oublock: 8
2025-11-01 20:18:23,881 - DEBUG - ya.test - _save_outputs: Command (pid 916246) stime: 0.23477299999999998
2025-11-01 20:18:23,881 - DEBUG - ya.test - _save_outputs: Command (pid 916246) utime: 0.5337459999999999
2025-11-01 20:18:23,881 - DEBUG - ya.test - _save_outputs: Command (pid 916246) wtime: 0.875
2025-11-01 20:18:23,882 - DEBUG - ya.test - _save_outputs: Command (pid 916246) 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:23,882 - DEBUG - ya.test - _save_outputs: Command (pid 916246) errors:

2025-11-01 20:18:23,883 - 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,833 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/4xuc/0024f6/ydb/apps/ydbd/ydbd
2025-11-01 20:18:28,834 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/4xuc/0024f6/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:8330', '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: 26241\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-01 20:18:28,836 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-11-01 20:18:28,837 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-11-01 20:18:28,837 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/4xuc/0024f6/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:8330', '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: 26241\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-01 20:18:28,839 - DEBUG - ya.test - execute: Command pid: 917253
2025-11-01 20:18:29,864 - DEBUG - ya.test - _save_outputs: Command (pid 917253) rc: 0
2025-11-01 20:18:29,864 - DEBUG - ya.test - _save_outputs: Command (pid 917253) elapsed time (sec): 1.0233099460601807
2025-11-01 20:18:29,865 - DEBUG - ya.test - _save_outputs: Command (pid 917253) idrss: 0
2025-11-01 20:18:29,865 - DEBUG - ya.test - _save_outputs: Command (pid 917253) inblock: 0
2025-11-01 20:18:29,865 - DEBUG - ya.test - _save_outputs: Command (pid 917253) isrss: 0
2025-11-01 20:18:29,866 - DEBUG - ya.test - _save_outputs: Command (pid 917253) ixrss: 0
2025-11-01 20:18:29,866 - DEBUG - ya.test - _save_outputs: Command (pid 917253) majflt: 0
2025-11-01 20:18:29,866 - DEBUG - ya.test - _save_outputs: Command (pid 917253) maxrss: 591852
2025-11-01 20:18:29,867 - DEBUG - ya.test - _save_outputs: Command (pid 917253) minflt: 51517
2025-11-01 20:18:29,868 - DEBUG - ya.test - _save_outputs: Command (pid 917253) msgrcv: 0
2025-11-01 20:18:29,868 - DEBUG - ya.test - _save_outputs: Command (pid 917253) msgsnd: 0
2025-11-01 20:18:29,868 - DEBUG - ya.test - _save_outputs: Command (pid 917253) nivcsw: 169
2025-11-01 20:18:29,869 - DEBUG - ya.test - _save_outputs: Command (pid 917253) nsignals: 0
2025-11-01 20:18:29,869 - DEBUG - ya.test - _save_outputs: Command (pid 917253) nswap: 0
2025-11-01 20:18:29,869 - DEBUG - ya.test - _save_outputs: Command (pid 917253) nvcsw: 565
2025-11-01 20:18:29,870 - DEBUG - ya.test - _save_outputs: Command (pid 917253) oublock: 8
2025-11-01 20:18:29,870 - DEBUG - ya.test - _save_outputs: Command (pid 917253) stime: 0.28302499999999997
2025-11-01 20:18:29,872 - DEBUG - ya.test - _save_outputs: Command (pid 917253) utime: 0.659374
2025-11-01 20:18:29,872 - DEBUG - ya.test - _save_outputs: Command (pid 917253) wtime: 1.025
2025-11-01 20:18:29,873 - DEBUG - ya.test - _save_outputs: Command (pid 917253) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

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

2025-11-01 20:18:29,875 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/4xuc/0024f6/ydb/apps/ydbd/ydbd
2025-11-01 20:18:29,875 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/4xuc/0024f6/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:8330', '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,877 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-11-01 20:18:29,878 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-11-01 20:18:29,878 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/4xuc/0024f6/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:8330', '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,880 - DEBUG - ya.test - execute: Command pid: 917444
2025-11-01 20:18:30,857 - DEBUG - ya.test - _save_outputs: Command (pid 917444) rc: 0
2025-11-01 20:18:30,858 - DEBUG - ya.test - _save_outputs: Command (pid 917444) elapsed time (sec): 0.9759230613708496
2025-11-01 20:18:30,858 - DEBUG - ya.test - _save_outputs: Command (pid 917444) idrss: 0
2025-11-01 20:18:30,859 - DEBUG - ya.test - _save_outputs: Command (pid 917444) inblock: 0
2025-11-01 20:18:30,859 - DEBUG - ya.test - _save_outputs: Command (pid 917444) isrss: 0
2025-11-01 20:18:30,859 - DEBUG - ya.test - _save_outputs: Command (pid 917444) ixrss: 0
2025-11-01 20:18:30,859 - DEBUG - ya.test - _save_outputs: Command (pid 917444) majflt: 0
2025-11-01 20:18:30,860 - DEBUG - ya.test - _save_outputs: Command (pid 917444) maxrss: 592092
2025-11-01 20:18:30,860 - DEBUG - ya.test - _save_outputs: Command (pid 917444) minflt: 51597
2025-11-01 20:18:30,860 - DEBUG - ya.test - _save_outputs: Command (pid 917444) msgrcv: 0
2025-11-01 20:18:30,861 - DEBUG - ya.test - _save_outputs: Command (pid 917444) msgsnd: 0
2025-11-01 20:18:30,861 - DEBUG - ya.test - _save_outputs: Command (pid 917444) nivcsw: 156
2025-11-01 20:18:30,861 - DEBUG - ya.test - _save_outputs: Command (pid 917444) nsignals: 0
2025-11-01 20:18:30,862 - DEBUG - ya.test - _save_outputs: Command (pid 917444) nswap: 0
2025-11-01 20:18:30,862 - DEBUG - ya.test - _save_outputs: Command (pid 917444) nvcsw: 636
2025-11-01 20:18:30,862 - DEBUG - ya.test - _save_outputs: Command (pid 917444) oublock: 8
2025-11-01 20:18:30,863 - DEBUG - ya.test - _save_outputs: Command (pid 917444) stime: 0.28601
2025-11-01 20:18:30,863 - DEBUG - ya.test - _save_outputs: Command (pid 917444) utime: 0.600324
2025-11-01 20:18:30,863 - DEBUG - ya.test - _save_outputs: Command (pid 917444) wtime: 0.978
2025-11-01 20:18:30,864 - DEBUG - ya.test - _save_outputs: Command (pid 917444) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

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

2025-11-01 20:18:30,865 - 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,939 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-11-01 20:18:30,990 - 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,995 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:18:30,998 - 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:31,043 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-01 20:18:31,044 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 829b015c-3f52-46be-8677-9060b98e45d4, localhost:8330): creating call state
2025-11-01 20:18:31,045 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 829b015c-3f52-46be-8677-9060b98e45d4, localhost:8330): request = { database: "/Root" }
2025-11-01 20:18:31,055 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 829b015c-3f52-46be-8677-9060b98e45d4, localhost:8330): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-govtdgmox4.auto.internal" port: 8330 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:31,056 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-govtdgmox4.auto.internal:8330, location 1, ssl: False>]>
2025-11-01 20:18:31,057 - 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:31,096 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:8330
2025-11-01 20:18:31,097 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:18:31,099 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, aa9fb01d-ea64-4f53-96b1-3e7b8b7f08f2, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:18:31,100 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, aa9fb01d-ea64-4f53-96b1-3e7b8b7f08f2, ghrun-govtdgmox4.auto.internal:8330): request = {  }
2025-11-01 20:18:31,112 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, aa9fb01d-ea64-4f53-96b1-3e7b8b7f08f2, ghrun-govtdgmox4.auto.internal:8330): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" node_id: 1 }
2025-11-01 20:18:31,114 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, 4347bc04-f6c0-4775-b741-33867be75514, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:18:31,118 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, 4347bc04-f6c0-4775-b741-33867be75514, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" }
2025-11-01 20:18:31,120 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, 4347bc04-f6c0-4775-b741-33867be75514, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:31,124 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:31,125 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d0f1a4b6-0189-404b-afb8-15fd43f11ede, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:18:31,126 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d0f1a4b6-0189-404b-afb8-15fd43f11ede, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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:31,128 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d0f1a4b6-0189-404b-afb8-15fd43f11ede, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:34,197 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:34,197 - INFO - __tests__.alter_compression - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-11-01 20:18:34,198 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:34,199 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, efd6db5b-ed1e-4e6c-8631-a621fc862cd2, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:18:34,200 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, efd6db5b-ed1e-4e6c-8631-a621fc862cd2, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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:34,201 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, efd6db5b-ed1e-4e6c-8631-a621fc862cd2, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:35,332 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:35,333 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:35,334 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 54f556a5-df93-4e4f-92f0-de6ff912eeb6, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:18:35,335 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 54f556a5-df93-4e4f-92f0-de6ff912eeb6, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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:35,337 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 54f556a5-df93-4e4f-92f0-de6ff912eeb6, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:36,661 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:36,662 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:36,663 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 39b2cfeb-edb8-441e-9c44-99383141cbc8, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:18:36,664 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 39b2cfeb-edb8-441e-9c44-99383141cbc8, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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,669 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 39b2cfeb-edb8-441e-9c44-99383141cbc8, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:37,570 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:37,571 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:37,572 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 75137c41-99db-4999-91ef-be28002c4e9a, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:18:37,573 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 75137c41-99db-4999-91ef-be28002c4e9a, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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,576 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 75137c41-99db-4999-91ef-be28002c4e9a, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:39,271 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:39,272 - 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:39,273 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:39,273 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 06a6dcd4-35aa-4dd7-a7ba-c7bad7822fa0, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:18:39,274 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 06a6dcd4-35aa-4dd7-a7ba-c7bad7822fa0, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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:39,279 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 06a6dcd4-35aa-4dd7-a7ba-c7bad7822fa0, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:40,652 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:40,653 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:40,654 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 01acc4e0-8233-4e7b-9f83-6ed3630067e3, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:18:40,654 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 01acc4e0-8233-4e7b-9f83-6ed3630067e3, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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,656 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 01acc4e0-8233-4e7b-9f83-6ed3630067e3, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:40,984 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:40,985 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:40,986 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ef9c4044-9896-4c8a-a4f1-a1a2d560d568, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:18:40,987 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ef9c4044-9896-4c8a-a4f1-a1a2d560d568, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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,989 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ef9c4044-9896-4c8a-a4f1-a1a2d560d568, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:41,425 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:41,426 - 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:41,426 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:41,427 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e49fea4a-549f-449a-ae82-5479f258e9ce, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:18:41,428 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e49fea4a-549f-449a-ae82-5479f258e9ce, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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:41,430 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e49fea4a-549f-449a-ae82-5479f258e9ce, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:42,631 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:42,632 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:42,632 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 866066b3-1fa6-4d17-983a-aa1467e16387, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:18:42,633 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 866066b3-1fa6-4d17-983a-aa1467e16387, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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:42,634 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 866066b3-1fa6-4d17-983a-aa1467e16387, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:42,847 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:42,848 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:42,849 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a5835da7-c8ce-42a7-b06c-0878837e62d7, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:18:42,850 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a5835da7-c8ce-42a7-b06c-0878837e62d7, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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,852 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a5835da7-c8ce-42a7-b06c-0878837e62d7, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:43,203 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:43,205 - 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:43,205 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:43,206 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0f33e2c8-cce0-4b77-930e-1ddf67cc70b7, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:18:43,208 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0f33e2c8-cce0-4b77-930e-1ddf67cc70b7, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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:43,210 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0f33e2c8-cce0-4b77-930e-1ddf67cc70b7, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:44,335 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:44,336 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:44,337 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 00a0bf0d-311f-49b9-96b0-c16dcd648c77, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:18:44,338 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 00a0bf0d-311f-49b9-96b0-c16dcd648c77, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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:44,341 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 00a0bf0d-311f-49b9-96b0-c16dcd648c77, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:44,721 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:44,722 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:44,723 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, fed8b250-6290-42c9-8c2d-19b1a8d94bd6, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:18:44,724 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, fed8b250-6290-42c9-8c2d-19b1a8d94bd6, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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:44,730 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, fed8b250-6290-42c9-8c2d-19b1a8d94bd6, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:45,228 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:45,229 - 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:45,229 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:45,231 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 954747fd-fa8f-4c16-88df-e3610a5a8e8d, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:18:45,232 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 954747fd-fa8f-4c16-88df-e3610a5a8e8d, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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:45,234 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 954747fd-fa8f-4c16-88df-e3610a5a8e8d, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:46,593 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:46,594 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:46,595 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f267f87e-df43-4646-89f8-3c3ed3c57845, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:18:46,596 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f267f87e-df43-4646-89f8-3c3ed3c57845, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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,598 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f267f87e-df43-4646-89f8-3c3ed3c57845, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:46,846 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:46,847 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:46,848 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 300d1ccb-5a07-41de-8acb-446e3eec61a3, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:18:46,849 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 300d1ccb-5a07-41de-8acb-446e3eec61a3, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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,851 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 300d1ccb-5a07-41de-8acb-446e3eec61a3, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:47,441 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:47,442 - 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:47,443 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:47,444 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d814c957-f0a3-4cda-ac6b-d883f27c7212, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:18:47,446 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d814c957-f0a3-4cda-ac6b-d883f27c7212, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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,448 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d814c957-f0a3-4cda-ac6b-d883f27c7212, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:48,648 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:48,649 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:48,650 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 38a76bef-ed7e-4a2c-b283-1824fa6c01d4, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:18:48,651 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 38a76bef-ed7e-4a2c-b283-1824fa6c01d4, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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,653 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 38a76bef-ed7e-4a2c-b283-1824fa6c01d4, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:48,965 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:48,966 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:48,967 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 813f0f41-fec7-4a99-87f9-f94962b94de3, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:18:48,968 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 813f0f41-fec7-4a99-87f9-f94962b94de3, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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,970 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 813f0f41-fec7-4a99-87f9-f94962b94de3, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:49,627 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:49,629 - 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:49,629 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:49,630 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e7d8d0a6-cfc5-46a8-9466-7463b7c40139, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:18:49,631 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e7d8d0a6-cfc5-46a8-9466-7463b7c40139, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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:49,633 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e7d8d0a6-cfc5-46a8-9466-7463b7c40139, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:50,912 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:50,913 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:50,914 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 82220e4f-9d75-4529-8577-83ccc748bbb0, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:18:50,915 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 82220e4f-9d75-4529-8577-83ccc748bbb0, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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,917 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 82220e4f-9d75-4529-8577-83ccc748bbb0, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:51,356 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:51,357 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:51,358 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f47f9c65-8477-44ce-98e5-81edf210b695, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:18:51,359 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f47f9c65-8477-44ce-98e5-81edf210b695, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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:51,368 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f47f9c65-8477-44ce-98e5-81edf210b695, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:51,938 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:51,939 - 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,940 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:51,941 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 08b8f3fe-2f2f-4ba8-94aa-c50f8327275c, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:18:51,942 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 08b8f3fe-2f2f-4ba8-94aa-c50f8327275c, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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,944 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 08b8f3fe-2f2f-4ba8-94aa-c50f8327275c, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:53,211 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:53,212 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:53,213 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 215634ad-91f9-45a4-90a2-419d41bb0a23, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:18:53,214 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 215634ad-91f9-45a4-90a2-419d41bb0a23, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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:53,216 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 215634ad-91f9-45a4-90a2-419d41bb0a23, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:53,546 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:53,547 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:53,547 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5a340276-e6c3-45f4-8d68-3b32ab08168e, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:18:53,548 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5a340276-e6c3-45f4-8d68-3b32ab08168e, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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:53,551 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5a340276-e6c3-45f4-8d68-3b32ab08168e, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:54,138 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:54,138 - 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:54,139 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:54,140 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 68151142-8231-4c65-af8b-63fdfde263e6, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:18:54,141 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 68151142-8231-4c65-af8b-63fdfde263e6, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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:54,143 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 68151142-8231-4c65-af8b-63fdfde263e6, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:55,245 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:55,247 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:55,249 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d18e1af0-7aed-40be-ae25-f2e9f99f5416, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:18:55,250 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d18e1af0-7aed-40be-ae25-f2e9f99f5416, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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:55,254 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d18e1af0-7aed-40be-ae25-f2e9f99f5416, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:55,556 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:55,557 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:55,558 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8d6da998-eff8-4782-b5cf-51c1ab6f07b4, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:18:55,559 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8d6da998-eff8-4782-b5cf-51c1ab6f07b4, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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,560 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8d6da998-eff8-4782-b5cf-51c1ab6f07b4, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:56,199 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:56,200 - 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:56,201 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:56,202 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 35f5774c-31c4-44b3-af68-e66cf0494f3b, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:18:56,203 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 35f5774c-31c4-44b3-af68-e66cf0494f3b, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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:56,205 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 35f5774c-31c4-44b3-af68-e66cf0494f3b, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:57,300 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:57,301 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:57,302 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 86ddeb84-d206-42f2-9a6b-566b5aba5f91, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:18:57,303 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 86ddeb84-d206-42f2-9a6b-566b5aba5f91, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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:57,305 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 86ddeb84-d206-42f2-9a6b-566b5aba5f91, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:57,610 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:57,611 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:57,612 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 85f75ed5-27d2-420c-ab82-da60f4852734, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:18:57,613 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 85f75ed5-27d2-420c-ab82-da60f4852734, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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,615 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 85f75ed5-27d2-420c-ab82-da60f4852734, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:58,319 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:58,321 - 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:58,321 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:58,322 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 165f882a-4f3b-4e84-a62b-aece58c36d45, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:18:58,323 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 165f882a-4f3b-4e84-a62b-aece58c36d45, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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:58,325 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 165f882a-4f3b-4e84-a62b-aece58c36d45, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:59,671 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:59,672 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:59,673 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8a823734-8ac2-4ce1-88e0-e3d20a244872, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:18:59,674 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8a823734-8ac2-4ce1-88e0-e3d20a244872, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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,676 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8a823734-8ac2-4ce1-88e0-e3d20a244872, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:18:59,979 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:59,980 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:18:59,981 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7e7915eb-f580-4034-9ae0-6a9f9df3d542, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:18:59,984 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7e7915eb-f580-4034-9ae0-6a9f9df3d542, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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,986 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7e7915eb-f580-4034-9ae0-6a9f9df3d542, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:19:00,315 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:19:00,317 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:19:00,317 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3c25795a-622f-4225-961b-f93a2d4385dd, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:19:00,318 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3c25795a-622f-4225-961b-f93a2d4385dd, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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:00,320 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3c25795a-622f-4225-961b-f93a2d4385dd, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:19:05,869 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:19:15,927 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:19:15,928 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b4e6c917-5893-4a59-b95c-8eec6776f853, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:19:15,929 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b4e6c917-5893-4a59-b95c-8eec6776f853, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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:15,931 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b4e6c917-5893-4a59-b95c-8eec6776f853, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:19:19,568 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:19:19,622 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-11-01 20:19:19,623 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:19:19,624 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ec2d6390-f410-4ce0-b0cd-51b0d70fb707, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:19:19,625 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ec2d6390-f410-4ce0-b0cd-51b0d70fb707, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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:19,629 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ec2d6390-f410-4ce0-b0cd-51b0d70fb707, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:19:23,651 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:19:33,703 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:19:33,704 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ba63f10c-f8e0-4fc8-99dc-efd95aaf87e1, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:19:33,705 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ba63f10c-f8e0-4fc8-99dc-efd95aaf87e1, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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,711 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ba63f10c-f8e0-4fc8-99dc-efd95aaf87e1, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:19:37,995 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:19:48,035 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:19:48,036 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0bd68ab3-3834-4fa8-8aa0-f05943a1787a, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:19:48,037 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0bd68ab3-3834-4fa8-8aa0-f05943a1787a, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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:48,038 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0bd68ab3-3834-4fa8-8aa0-f05943a1787a, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:19:48,856 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:19:58,863 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:19:58,864 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f9396109-bc2e-41d4-a887-13ac926549d6, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:19:58,865 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f9396109-bc2e-41d4-a887-13ac926549d6, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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,866 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f9396109-bc2e-41d4-a887-13ac926549d6, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:19:59,699 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:19:59,704 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8009216)
2025-11-01 20:19:59,705 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:19:59,705 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, fd83d343-6dc1-4bdf-9534-575aabd7e054, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:19:59,707 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, fd83d343-6dc1-4bdf-9534-575aabd7e054, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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,708 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, fd83d343-6dc1-4bdf-9534-575aabd7e054, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:19:59,980 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:19:59,983 - INFO - ya.test - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_4_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 4])
2025-11-01 20:19:59,984 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:19:59,985 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 12ea4cd1-752e-4859-9e60-4df47ec0c9c0, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:19:59,985 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 12ea4cd1-752e-4859-9e60-4df47ec0c9c0, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_4_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 4)\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:19:59,987 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 12ea4cd1-752e-4859-9e60-4df47ec0c9c0, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:03,483 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:03,483 - INFO - __tests__.alter_compression - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_4_compression created
2025-11-01 20:20:03,484 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:03,484 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 70084e6b-6618-4983-9930-118fba985bca, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:03,485 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 70084e6b-6618-4983-9930-118fba985bca, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_4_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:03,486 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 70084e6b-6618-4983-9930-118fba985bca, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:04,413 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:04,414 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:04,415 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b9fc0322-626d-49f4-a494-43adadea90c6, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:04,415 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b9fc0322-626d-49f4-a494-43adadea90c6, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:04,417 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b9fc0322-626d-49f4-a494-43adadea90c6, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:05,771 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:05,772 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:05,773 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b51443c3-485f-40fd-bc55-b7d42ad3fcff, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:05,774 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b51443c3-485f-40fd-bc55-b7d42ad3fcff, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:05,777 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b51443c3-485f-40fd-bc55-b7d42ad3fcff, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:06,865 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:06,866 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:06,867 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 98f1093c-98fc-4c6b-a09b-540deaae4d47, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:06,868 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 98f1093c-98fc-4c6b-a09b-540deaae4d47, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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_4_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:06,870 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 98f1093c-98fc-4c6b-a09b-540deaae4d47, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:09,148 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:09,149 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318960, 'BlobCount': 128}}
2025-11-01 20:20:09,150 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:09,150 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, cb713676-b9b9-462e-b894-45c34ba31c62, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:09,151 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, cb713676-b9b9-462e-b894-45c34ba31c62, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:09,153 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, cb713676-b9b9-462e-b894-45c34ba31c62, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:10,893 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:10,894 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:10,894 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 64421e09-3c82-4903-9abe-4a8c6a7b94fa, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:10,895 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 64421e09-3c82-4903-9abe-4a8c6a7b94fa, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:10,897 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 64421e09-3c82-4903-9abe-4a8c6a7b94fa, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:11,336 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:11,337 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:11,338 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7ae8b8e0-0220-4f63-a82e-160876c1d1f9, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:11,339 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7ae8b8e0-0220-4f63-a82e-160876c1d1f9, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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_4_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:11,341 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7ae8b8e0-0220-4f63-a82e-160876c1d1f9, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:11,743 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:11,744 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 638256, 'BlobCount': 256}}
2025-11-01 20:20:11,745 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:11,745 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8958dd0d-bf0b-4d2b-9ac8-bcdc69a0ce37, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:11,747 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8958dd0d-bf0b-4d2b-9ac8-bcdc69a0ce37, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:11,749 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8958dd0d-bf0b-4d2b-9ac8-bcdc69a0ce37, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:11,899 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:20:11,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:11,943 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-01 20:20:11,944 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 8299b452-50e7-4c63-93ad-a66937671001, localhost:8330): creating call state
2025-11-01 20:20:11,944 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 8299b452-50e7-4c63-93ad-a66937671001, localhost:8330): request = { database: "/Root" }
2025-11-01 20:20:11,956 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 8299b452-50e7-4c63-93ad-a66937671001, localhost:8330): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-govtdgmox4.auto.internal" port: 8330 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:11,957 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-govtdgmox4.auto.internal:8330, location 1, ssl: False>]>
2025-11-01 20:20:11,958 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:8330
2025-11-01 20:20:13,138 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:13,139 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:13,140 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0f0a1ddd-cf43-4f3a-8ee0-6203a454d7f4, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:13,141 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0f0a1ddd-cf43-4f3a-8ee0-6203a454d7f4, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:13,143 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0f0a1ddd-cf43-4f3a-8ee0-6203a454d7f4, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:13,402 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:13,403 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:13,404 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8e2ce599-878b-48cc-8042-cc5d0cf9754b, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:13,405 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8e2ce599-878b-48cc-8042-cc5d0cf9754b, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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_4_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,407 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8e2ce599-878b-48cc-8042-cc5d0cf9754b, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:14,012 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:14,014 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 957296, 'BlobCount': 384}}
2025-11-01 20:20:14,014 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:14,015 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1ab1aef9-1073-43ad-acce-4bd449715e98, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:14,017 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1ab1aef9-1073-43ad-acce-4bd449715e98, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:14,019 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1ab1aef9-1073-43ad-acce-4bd449715e98, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:15,536 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:15,537 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:15,538 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0d4d4cd9-f94c-4dde-8260-9bac87cbe344, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:15,539 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0d4d4cd9-f94c-4dde-8260-9bac87cbe344, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:15,541 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0d4d4cd9-f94c-4dde-8260-9bac87cbe344, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:15,885 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:15,886 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:15,887 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a612e48d-52e2-4a2e-a373-edba9e50200a, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:15,888 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a612e48d-52e2-4a2e-a373-edba9e50200a, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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_4_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:15,890 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a612e48d-52e2-4a2e-a373-edba9e50200a, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:16,441 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:16,442 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1276656, 'BlobCount': 512}}
2025-11-01 20:20:16,443 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:16,443 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 19abbe77-0e33-406a-9cdf-d512d26151b3, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:16,444 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 19abbe77-0e33-406a-9cdf-d512d26151b3, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:16,446 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 19abbe77-0e33-406a-9cdf-d512d26151b3, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:17,828 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:17,829 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:17,830 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8fd37ba8-2e73-4279-a7e2-13dc7252f8cb, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:17,831 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8fd37ba8-2e73-4279-a7e2-13dc7252f8cb, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:17,832 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8fd37ba8-2e73-4279-a7e2-13dc7252f8cb, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:18,216 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:18,217 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:18,218 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c2af2f12-a267-4464-a47a-06c589b5b34e, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:18,219 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c2af2f12-a267-4464-a47a-06c589b5b34e, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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_4_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:18,221 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c2af2f12-a267-4464-a47a-06c589b5b34e, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:18,820 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:18,821 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1595616, 'BlobCount': 640}}
2025-11-01 20:20:18,822 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:18,822 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 134568fa-1cc7-4646-8857-9fc50d26d839, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:18,824 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 134568fa-1cc7-4646-8857-9fc50d26d839, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:18,826 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 134568fa-1cc7-4646-8857-9fc50d26d839, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:20,218 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:20,219 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:20,220 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ff9d77ac-0a50-468f-bad6-84463a074661, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:20,221 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ff9d77ac-0a50-468f-bad6-84463a074661, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:20,226 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ff9d77ac-0a50-468f-bad6-84463a074661, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:20,536 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:20,538 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:20,539 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e9426219-cf13-4c69-aee6-0c4b85527341, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:20,540 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e9426219-cf13-4c69-aee6-0c4b85527341, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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_4_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,541 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e9426219-cf13-4c69-aee6-0c4b85527341, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:21,106 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:21,107 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1914800, 'BlobCount': 768}}
2025-11-01 20:20:21,108 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:21,108 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 48dfbf01-4ef7-4b90-b8c3-0c0ca72bc81f, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:21,110 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 48dfbf01-4ef7-4b90-b8c3-0c0ca72bc81f, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:21,115 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 48dfbf01-4ef7-4b90-b8c3-0c0ca72bc81f, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:22,571 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:22,573 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:22,574 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d5d92552-4b24-4e6c-a246-0a1b84690b68, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:22,575 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d5d92552-4b24-4e6c-a246-0a1b84690b68, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:22,577 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d5d92552-4b24-4e6c-a246-0a1b84690b68, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:22,936 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:22,937 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:22,938 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 80c8e8e4-9b1f-4f10-861a-6171ea388b18, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:22,940 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 80c8e8e4-9b1f-4f10-861a-6171ea388b18, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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_4_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:22,947 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 80c8e8e4-9b1f-4f10-861a-6171ea388b18, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:23,574 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:23,575 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2233936, 'BlobCount': 896}}
2025-11-01 20:20:23,575 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:23,576 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ec6756c7-2fc5-4429-b80f-51e3012dc785, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:23,576 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ec6756c7-2fc5-4429-b80f-51e3012dc785, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:23,578 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ec6756c7-2fc5-4429-b80f-51e3012dc785, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:25,125 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:25,126 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:25,126 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 55ff3b24-dc92-45b8-bcdd-3314590f7a6b, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:25,127 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 55ff3b24-dc92-45b8-bcdd-3314590f7a6b, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:25,130 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 55ff3b24-dc92-45b8-bcdd-3314590f7a6b, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:25,481 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:25,482 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:25,482 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a57eba14-f982-4b0a-921b-48201c35a4b4, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:25,483 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a57eba14-f982-4b0a-921b-48201c35a4b4, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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_4_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:25,486 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a57eba14-f982-4b0a-921b-48201c35a4b4, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:26,247 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:26,247 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2553424, 'BlobCount': 1024}}
2025-11-01 20:20:26,248 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:26,249 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b3b2f905-28aa-425b-9b03-79e912cdbacc, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:26,250 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b3b2f905-28aa-425b-9b03-79e912cdbacc, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:26,252 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b3b2f905-28aa-425b-9b03-79e912cdbacc, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:27,676 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:27,677 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:27,677 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 819e6a6c-e2d9-4c55-9cc8-3de6ec4234d7, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:27,678 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 819e6a6c-e2d9-4c55-9cc8-3de6ec4234d7, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:27,680 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 819e6a6c-e2d9-4c55-9cc8-3de6ec4234d7, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:27,999 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:28,000 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:28,001 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 441c57b2-bf03-41c8-a0fe-d89280cd14ee, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:28,002 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 441c57b2-bf03-41c8-a0fe-d89280cd14ee, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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_4_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:28,004 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 441c57b2-bf03-41c8-a0fe-d89280cd14ee, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:28,639 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:28,640 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2872432, 'BlobCount': 1152}}
2025-11-01 20:20:28,640 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:28,641 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8313d881-7d33-4e2c-a4bc-2522a7d51960, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:28,642 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8313d881-7d33-4e2c-a4bc-2522a7d51960, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:28,644 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8313d881-7d33-4e2c-a4bc-2522a7d51960, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:29,868 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:29,869 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:29,870 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c39d9840-3f00-41f4-a649-1b63121bccdc, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:29,871 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c39d9840-3f00-41f4-a649-1b63121bccdc, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:29,872 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c39d9840-3f00-41f4-a649-1b63121bccdc, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:30,175 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:30,176 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:30,178 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d5a11e81-0586-4221-b4b2-3f2cc64997d4, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:30,179 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d5a11e81-0586-4221-b4b2-3f2cc64997d4, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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_4_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:30,181 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d5a11e81-0586-4221-b4b2-3f2cc64997d4, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:30,974 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:30,975 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3191936, 'BlobCount': 1280}}
2025-11-01 20:20:30,976 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:30,976 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0d3efff5-45cb-40ab-b33c-73a013e2e951, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:30,977 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0d3efff5-45cb-40ab-b33c-73a013e2e951, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_4_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:30,979 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0d3efff5-45cb-40ab-b33c-73a013e2e951, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:32,391 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:32,392 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:32,392 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7e9df115-ef4b-406b-8746-c517875a83d5, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:32,393 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7e9df115-ef4b-406b-8746-c517875a83d5, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:32,395 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7e9df115-ef4b-406b-8746-c517875a83d5, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:32,747 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:32,748 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:32,749 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c23511aa-6d2f-4620-a6ef-a5a10eff4316, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:32,749 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c23511aa-6d2f-4620-a6ef-a5a10eff4316, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:32,751 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c23511aa-6d2f-4620-a6ef-a5a10eff4316, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:33,127 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:33,128 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:33,129 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2b6b2466-f054-4c9b-b94c-54431c542a8f, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:33,130 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2b6b2466-f054-4c9b-b94c-54431c542a8f, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:33,131 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2b6b2466-f054-4c9b-b94c-54431c542a8f, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:38,304 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:48,356 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:48,357 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3cedf2fb-edb7-410a-a4b5-bdde3a40c938, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:48,358 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3cedf2fb-edb7-410a-a4b5-bdde3a40c938, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:48,360 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3cedf2fb-edb7-410a-a4b5-bdde3a40c938, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:52,996 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:53,053 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_4_compression`, volumes `value` (8000000, 1595968)
2025-11-01 20:20:53,054 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:53,055 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5ab9b582-f622-4acc-b750-a2948c0d32ca, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:53,056 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5ab9b582-f622-4acc-b750-a2948c0d32ca, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:53,058 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5ab9b582-f622-4acc-b750-a2948c0d32ca, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:53,447 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:53,448 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:20:53,449 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5c8fb351-50dc-4e87-96dd-066203443fac, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:20:53,451 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5c8fb351-50dc-4e87-96dd-066203443fac, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:20:53,453 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5c8fb351-50dc-4e87-96dd-066203443fac, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:20:58,478 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:21:08,523 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:21:08,524 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3c622916-a5c4-4626-9680-244dbe74221a, ghrun-govtdgmox4.auto.internal:8330): creating call state
2025-11-01 20:21:08,525 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3c622916-a5c4-4626-9680-244dbe74221a, ghrun-govtdgmox4.auto.internal:8330): request = { session_id: "ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:21:08,527 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3c622916-a5c4-4626-9680-244dbe74221a, ghrun-govtdgmox4.auto.internal:8330): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:21:12,019 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ODMzYWM0MmItODk4YWI4MDgtNDQ5NmEyMjktYzM4MjhkODc=
2025-11-01 20:21:12,064 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_4_compression`, volumes `value` (8000000, 1531304)
2025-11-01 20:21:12,064 - INFO - root - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_4_compression` 8092160 / 1531304: 5.28448955922534
2025-11-01 20:21:12,075 - INFO - ya.test - pytest_runtest_teardown: Test teardown
