2025-11-10 10:00:48,387 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-10 10:00:48,388 - INFO - ya.test - pytest_runtest_setup: test_all_supported_compression[zstd_4_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 4]
2025-11-10 10:00:48,388 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-10 10:00:48,388 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-10 10:00:48,390 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-11-10 10:00:48,391 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-11-10 10:00:48,391 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/fhvo/0021f0/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-10 10:00:48,393 - DEBUG - ya.test - execute: Command pid: 461738
2025-11-10 10:00:49,217 - DEBUG - ya.test - _save_outputs: Command (pid 461738) rc: 0
2025-11-10 10:00:49,218 - DEBUG - ya.test - _save_outputs: Command (pid 461738) elapsed time (sec): 0.8226559162139893
2025-11-10 10:00:49,218 - DEBUG - ya.test - _save_outputs: Command (pid 461738) idrss: 0
2025-11-10 10:00:49,218 - DEBUG - ya.test - _save_outputs: Command (pid 461738) inblock: 0
2025-11-10 10:00:49,219 - DEBUG - ya.test - _save_outputs: Command (pid 461738) isrss: 0
2025-11-10 10:00:49,219 - DEBUG - ya.test - _save_outputs: Command (pid 461738) ixrss: 0
2025-11-10 10:00:49,219 - DEBUG - ya.test - _save_outputs: Command (pid 461738) majflt: 0
2025-11-10 10:00:49,219 - DEBUG - ya.test - _save_outputs: Command (pid 461738) maxrss: 492952
2025-11-10 10:00:49,220 - DEBUG - ya.test - _save_outputs: Command (pid 461738) minflt: 45354
2025-11-10 10:00:49,220 - DEBUG - ya.test - _save_outputs: Command (pid 461738) msgrcv: 0
2025-11-10 10:00:49,220 - DEBUG - ya.test - _save_outputs: Command (pid 461738) msgsnd: 0
2025-11-10 10:00:49,220 - DEBUG - ya.test - _save_outputs: Command (pid 461738) nivcsw: 92
2025-11-10 10:00:49,221 - DEBUG - ya.test - _save_outputs: Command (pid 461738) nsignals: 0
2025-11-10 10:00:49,221 - DEBUG - ya.test - _save_outputs: Command (pid 461738) nswap: 0
2025-11-10 10:00:49,221 - DEBUG - ya.test - _save_outputs: Command (pid 461738) nvcsw: 14
2025-11-10 10:00:49,222 - DEBUG - ya.test - _save_outputs: Command (pid 461738) oublock: 8
2025-11-10 10:00:49,222 - DEBUG - ya.test - _save_outputs: Command (pid 461738) stime: 0.21659399999999998
2025-11-10 10:00:49,222 - DEBUG - ya.test - _save_outputs: Command (pid 461738) utime: 0.49515899999999996
2025-11-10 10:00:49,222 - DEBUG - ya.test - _save_outputs: Command (pid 461738) wtime: 0.825
2025-11-10 10:00:49,223 - DEBUG - ya.test - _save_outputs: Command (pid 461738) output:
Git info:
    Commit: 2d3bc32bffc01725fa6c3dd0bb0f7616ee098760
    Branch: 
    Author: Daniil Timižev <ditimizhev@ydb.tech>
    Summary: Merge 4ff3894868fb9bba81a268efd022ca68496f230a into 27b8fe5960eec979164acf2636986bcea3ca729d

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-2dyy577wua
    Host information: 
        Linux ghrun-2dyy577wua 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-10 10:00:49,223 - DEBUG - ya.test - _save_outputs: Command (pid 461738) errors:

2025-11-10 10:00:49,229 - INFO - __tests__.base - _setup_ydb: Git info:
    Commit: 2d3bc32bffc01725fa6c3dd0bb0f7616ee098760
    Branch: 
    Author: Daniil Timižev <ditimizhev@ydb.tech>
    Summary: Merge 4ff3894868fb9bba81a268efd022ca68496f230a into 27b8fe5960eec979164acf2636986bcea3ca729d

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-2dyy577wua
    Host information: 
        Linux ghrun-2dyy577wua 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-10 10:00:49,333 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/fhvo/0021f0/ydb/apps/ydbd/ydbd
2025-11-10 10:00:49,335 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/17406
2025-11-10 10:00:49,336 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/fhvo/0021f0/r3tmp/kikimr_cluster_toi0u3ei
2025-11-10 10:00:49,376 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/fhvo/0021f0/ydb/apps/ydbd/ydbd
2025-11-10 10:00:49,377 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/2340
2025-11-10 10:00:49,377 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/19970
2025-11-10 10:00:49,378 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/20608
2025-11-10 10:00:49,378 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/20302
2025-11-10 10:00:49,380 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/fhvo/0021f0/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-10 10:00:49,380 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/fhvo/0021f0/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/fhvo/0021f0/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_02hxr8l9.log --grpc-port=2340 --mon-port=19970 --ic-port=17406
2025-11-10 10:00:49,380 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:2340/1, disk_size 68719476736
2025-11-10 10:00:49,381 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/fhvo/0021f0/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-10 10:00:49,381 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/fhvo/0021f0/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/fhvo/0021f0/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_02hxr8l9.log --grpc-port=2340 --mon-port=19970 --ic-port=17406
2025-11-10 10:00:49,382 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/fhvo/0021f0/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/fhvo/0021f0/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/fhvo/0021f0/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_02hxr8l9.log', '--grpc-port=2340', '--mon-port=19970', '--ic-port=17406')' in '/home/runner/.ya/build/build_root/fhvo/0021f0/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-10 10:00:49,386 - DEBUG - ya.test - execute: Command pid: 461780
2025-11-10 10:00:49,387 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:2340/1
2025-11-10 10:00:49,388 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-11-10 10:00:49,389 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-11-10 10:00:49,389 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/fhvo/0021f0/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-10 10:00:49,391 - DEBUG - ya.test - execute: Command pid: 461781
2025-11-10 10:00:50,141 - DEBUG - ya.test - _save_outputs: Command (pid 461781) rc: 0
2025-11-10 10:00:50,142 - DEBUG - ya.test - _save_outputs: Command (pid 461781) elapsed time (sec): 0.7496581077575684
2025-11-10 10:00:50,142 - DEBUG - ya.test - _save_outputs: Command (pid 461781) idrss: 0
2025-11-10 10:00:50,142 - DEBUG - ya.test - _save_outputs: Command (pid 461781) inblock: 0
2025-11-10 10:00:50,142 - DEBUG - ya.test - _save_outputs: Command (pid 461781) isrss: 0
2025-11-10 10:00:50,142 - DEBUG - ya.test - _save_outputs: Command (pid 461781) ixrss: 0
2025-11-10 10:00:50,143 - DEBUG - ya.test - _save_outputs: Command (pid 461781) majflt: 3
2025-11-10 10:00:50,143 - DEBUG - ya.test - _save_outputs: Command (pid 461781) maxrss: 502000
2025-11-10 10:00:50,143 - DEBUG - ya.test - _save_outputs: Command (pid 461781) minflt: 45676
2025-11-10 10:00:50,143 - DEBUG - ya.test - _save_outputs: Command (pid 461781) msgrcv: 0
2025-11-10 10:00:50,143 - DEBUG - ya.test - _save_outputs: Command (pid 461781) msgsnd: 0
2025-11-10 10:00:50,144 - DEBUG - ya.test - _save_outputs: Command (pid 461781) nivcsw: 106
2025-11-10 10:00:50,144 - DEBUG - ya.test - _save_outputs: Command (pid 461781) nsignals: 0
2025-11-10 10:00:50,144 - DEBUG - ya.test - _save_outputs: Command (pid 461781) nswap: 0
2025-11-10 10:00:50,144 - DEBUG - ya.test - _save_outputs: Command (pid 461781) nvcsw: 15
2025-11-10 10:00:50,144 - DEBUG - ya.test - _save_outputs: Command (pid 461781) oublock: 8
2025-11-10 10:00:50,145 - DEBUG - ya.test - _save_outputs: Command (pid 461781) stime: 0.21326399999999998
2025-11-10 10:00:50,145 - DEBUG - ya.test - _save_outputs: Command (pid 461781) utime: 0.464621
2025-11-10 10:00:50,145 - DEBUG - ya.test - _save_outputs: Command (pid 461781) wtime: 0.751
2025-11-10 10:00:50,146 - DEBUG - ya.test - _save_outputs: Command (pid 461781) output:
Git info:
    Commit: 2d3bc32bffc01725fa6c3dd0bb0f7616ee098760
    Branch: 
    Author: Daniil Timižev <ditimizhev@ydb.tech>
    Summary: Merge 4ff3894868fb9bba81a268efd022ca68496f230a into 27b8fe5960eec979164acf2636986bcea3ca729d

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-2dyy577wua
    Host information: 
        Linux ghrun-2dyy577wua 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-10 10:00:50,146 - DEBUG - ya.test - _save_outputs: Command (pid 461781) errors:

2025-11-10 10:00:50,146 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 2d3bc32bffc01725fa6c3dd0bb0f7616ee098760
    Branch: 
    Author: Daniil Timižev <ditimizhev@ydb.tech>
    Summary: Merge 4ff3894868fb9bba81a268efd022ca68496f230a into 27b8fe5960eec979164acf2636986bcea3ca729d
2025-11-10 10:00:54,594 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/fhvo/0021f0/ydb/apps/ydbd/ydbd
2025-11-10 10:00:54,595 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/fhvo/0021f0/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:2340', '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: 17406\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-10 10:00:54,596 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-11-10 10:00:54,596 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-11-10 10:00:54,597 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/fhvo/0021f0/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:2340', '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: 17406\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-10 10:00:54,598 - DEBUG - ya.test - execute: Command pid: 462402
2025-11-10 10:00:55,682 - DEBUG - ya.test - _save_outputs: Command (pid 462402) rc: 0
2025-11-10 10:00:55,682 - DEBUG - ya.test - _save_outputs: Command (pid 462402) elapsed time (sec): 1.0827252864837646
2025-11-10 10:00:55,683 - DEBUG - ya.test - _save_outputs: Command (pid 462402) idrss: 0
2025-11-10 10:00:55,683 - DEBUG - ya.test - _save_outputs: Command (pid 462402) inblock: 0
2025-11-10 10:00:55,683 - DEBUG - ya.test - _save_outputs: Command (pid 462402) isrss: 0
2025-11-10 10:00:55,683 - DEBUG - ya.test - _save_outputs: Command (pid 462402) ixrss: 0
2025-11-10 10:00:55,684 - DEBUG - ya.test - _save_outputs: Command (pid 462402) majflt: 0
2025-11-10 10:00:55,684 - DEBUG - ya.test - _save_outputs: Command (pid 462402) maxrss: 595772
2025-11-10 10:00:55,684 - DEBUG - ya.test - _save_outputs: Command (pid 462402) minflt: 51589
2025-11-10 10:00:55,685 - DEBUG - ya.test - _save_outputs: Command (pid 462402) msgrcv: 0
2025-11-10 10:00:55,685 - DEBUG - ya.test - _save_outputs: Command (pid 462402) msgsnd: 0
2025-11-10 10:00:55,685 - DEBUG - ya.test - _save_outputs: Command (pid 462402) nivcsw: 209
2025-11-10 10:00:55,686 - DEBUG - ya.test - _save_outputs: Command (pid 462402) nsignals: 0
2025-11-10 10:00:55,686 - DEBUG - ya.test - _save_outputs: Command (pid 462402) nswap: 0
2025-11-10 10:00:55,686 - DEBUG - ya.test - _save_outputs: Command (pid 462402) nvcsw: 685
2025-11-10 10:00:55,687 - DEBUG - ya.test - _save_outputs: Command (pid 462402) oublock: 8
2025-11-10 10:00:55,687 - DEBUG - ya.test - _save_outputs: Command (pid 462402) stime: 0.258656
2025-11-10 10:00:55,687 - DEBUG - ya.test - _save_outputs: Command (pid 462402) utime: 0.572203
2025-11-10 10:00:55,687 - DEBUG - ya.test - _save_outputs: Command (pid 462402) wtime: 1.084
2025-11-10 10:00:55,688 - DEBUG - ya.test - _save_outputs: Command (pid 462402) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-10 10:00:55,688 - DEBUG - ya.test - _save_outputs: Command (pid 462402) errors:

2025-11-10 10:00:55,689 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/fhvo/0021f0/ydb/apps/ydbd/ydbd
2025-11-10 10:00:55,690 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/fhvo/0021f0/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:2340', '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-10 10:00:55,691 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-11-10 10:00:55,692 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-11-10 10:00:55,692 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/fhvo/0021f0/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:2340', '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-10 10:00:55,694 - DEBUG - ya.test - execute: Command pid: 462595
2025-11-10 10:00:56,796 - DEBUG - ya.test - _save_outputs: Command (pid 462595) rc: 0
2025-11-10 10:00:56,796 - DEBUG - ya.test - _save_outputs: Command (pid 462595) elapsed time (sec): 1.100876808166504
2025-11-10 10:00:56,797 - DEBUG - ya.test - _save_outputs: Command (pid 462595) idrss: 0
2025-11-10 10:00:56,797 - DEBUG - ya.test - _save_outputs: Command (pid 462595) inblock: 0
2025-11-10 10:00:56,797 - DEBUG - ya.test - _save_outputs: Command (pid 462595) isrss: 0
2025-11-10 10:00:56,797 - DEBUG - ya.test - _save_outputs: Command (pid 462595) ixrss: 0
2025-11-10 10:00:56,798 - DEBUG - ya.test - _save_outputs: Command (pid 462595) majflt: 0
2025-11-10 10:00:56,798 - DEBUG - ya.test - _save_outputs: Command (pid 462595) maxrss: 595868
2025-11-10 10:00:56,798 - DEBUG - ya.test - _save_outputs: Command (pid 462595) minflt: 51723
2025-11-10 10:00:56,798 - DEBUG - ya.test - _save_outputs: Command (pid 462595) msgrcv: 0
2025-11-10 10:00:56,799 - DEBUG - ya.test - _save_outputs: Command (pid 462595) msgsnd: 0
2025-11-10 10:00:56,799 - DEBUG - ya.test - _save_outputs: Command (pid 462595) nivcsw: 205
2025-11-10 10:00:56,799 - DEBUG - ya.test - _save_outputs: Command (pid 462595) nsignals: 0
2025-11-10 10:00:56,799 - DEBUG - ya.test - _save_outputs: Command (pid 462595) nswap: 0
2025-11-10 10:00:56,800 - DEBUG - ya.test - _save_outputs: Command (pid 462595) nvcsw: 562
2025-11-10 10:00:56,800 - DEBUG - ya.test - _save_outputs: Command (pid 462595) oublock: 8
2025-11-10 10:00:56,800 - DEBUG - ya.test - _save_outputs: Command (pid 462595) stime: 0.37146199999999996
2025-11-10 10:00:56,801 - DEBUG - ya.test - _save_outputs: Command (pid 462595) utime: 0.54919
2025-11-10 10:00:56,801 - DEBUG - ya.test - _save_outputs: Command (pid 462595) wtime: 1.103
2025-11-10 10:00:56,801 - DEBUG - ya.test - _save_outputs: Command (pid 462595) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-11-10 10:00:56,802 - DEBUG - ya.test - _save_outputs: Command (pid 462595) errors:

2025-11-10 10:00:56,802 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-10 10:00:56,991 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-11-10 10:00:57,023 - 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-10 10:00:57,030 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-10 10:00:57,031 - 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-10 10:00:57,061 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-10 10:00:57,062 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 3f58e108-0259-44d8-acfb-17fe45468629, localhost:2340): creating call state
2025-11-10 10:00:57,062 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 3f58e108-0259-44d8-acfb-17fe45468629, localhost:2340): request = { database: "/Root" }
2025-11-10 10:00:57,072 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 3f58e108-0259-44d8-acfb-17fe45468629, localhost:2340): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-2dyy577wua.auto.internal" port: 2340 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-10 10:00:57,074 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-2dyy577wua.auto.internal:2340, location 1, ssl: False>]>
2025-11-10 10:00:57,074 - 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-10 10:00:57,110 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:2340
2025-11-10 10:00:57,113 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-10 10:00:57,114 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 3aaf06ad-546b-4bba-b215-da7257571606, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:00:57,115 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 3aaf06ad-546b-4bba-b215-da7257571606, ghrun-2dyy577wua.auto.internal:2340): request = {  }
2025-11-10 10:00:57,122 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 3aaf06ad-546b-4bba-b215-da7257571606, ghrun-2dyy577wua.auto.internal:2340): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" node_id: 1 }
2025-11-10 10:00:57,123 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, e8fc4dba-f286-41aa-b802-b42a86eaf92d, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:00:57,123 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, e8fc4dba-f286-41aa-b802-b42a86eaf92d, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" }
2025-11-10 10:00:57,126 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, e8fc4dba-f286-41aa-b802-b42a86eaf92d, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:00:57,129 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:00:57,130 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d4b36c4b-2261-4323-b43c-cb9188f44485, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:00:57,131 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d4b36c4b-2261-4323-b43c-cb9188f44485, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:00:57,132 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d4b36c4b-2261-4323-b43c-cb9188f44485, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:00:59,651 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:00:59,652 - INFO - __tests__.alter_compression - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-11-10 10:00:59,652 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:00:59,653 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, bc39fef9-e662-4f68-94aa-21b33b867c51, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:00:59,654 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, bc39fef9-e662-4f68-94aa-21b33b867c51, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:00:59,655 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, bc39fef9-e662-4f68-94aa-21b33b867c51, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:00,674 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:00,675 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:00,676 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 48897783-2f8a-4779-a7d4-7811be7c51e8, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:00,676 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 48897783-2f8a-4779-a7d4-7811be7c51e8, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:00,677 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 48897783-2f8a-4779-a7d4-7811be7c51e8, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:01,776 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:01,777 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:01,778 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5c6c51d6-89cf-43c7-a13e-846bd98304ed, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:01,778 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5c6c51d6-89cf-43c7-a13e-846bd98304ed, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:01,780 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5c6c51d6-89cf-43c7-a13e-846bd98304ed, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:02,476 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:02,477 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:02,478 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ec8320b7-494b-4e24-b209-41010e424ef9, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:02,479 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ec8320b7-494b-4e24-b209-41010e424ef9, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:02,480 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ec8320b7-494b-4e24-b209-41010e424ef9, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:03,829 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:03,831 - 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-10 10:01:03,831 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:03,832 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a34c82fa-a72d-466b-b9c4-c30ee0abdb40, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:03,833 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a34c82fa-a72d-466b-b9c4-c30ee0abdb40, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:03,841 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a34c82fa-a72d-466b-b9c4-c30ee0abdb40, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:04,674 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:04,675 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:04,675 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a997edab-d1ab-45b8-b285-7332d790950b, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:04,676 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a997edab-d1ab-45b8-b285-7332d790950b, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:04,678 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a997edab-d1ab-45b8-b285-7332d790950b, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:04,951 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:04,952 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:04,953 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3f189b13-ad83-45ac-98c0-48ec2c40c3dc, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:04,954 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3f189b13-ad83-45ac-98c0-48ec2c40c3dc, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:04,958 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3f189b13-ad83-45ac-98c0-48ec2c40c3dc, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:05,254 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:05,255 - 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-10 10:01:05,255 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:05,256 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 531d8734-4809-4085-861e-830f1dcdf9ac, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:05,257 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 531d8734-4809-4085-861e-830f1dcdf9ac, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:05,258 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 531d8734-4809-4085-861e-830f1dcdf9ac, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:06,081 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:06,082 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:06,083 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5c2d6666-b861-41e3-9d3e-b8939448fb38, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:06,083 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5c2d6666-b861-41e3-9d3e-b8939448fb38, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:06,085 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5c2d6666-b861-41e3-9d3e-b8939448fb38, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:06,331 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:06,331 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:06,332 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 43f95f6a-d07c-429f-ab93-e70ad62e5a53, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:06,333 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 43f95f6a-d07c-429f-ab93-e70ad62e5a53, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:06,335 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 43f95f6a-d07c-429f-ab93-e70ad62e5a53, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:06,698 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:06,699 - 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-10 10:01:06,700 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:06,700 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 39cd3675-74cb-40b5-9fea-3c019ae9f974, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:06,701 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 39cd3675-74cb-40b5-9fea-3c019ae9f974, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:06,709 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 39cd3675-74cb-40b5-9fea-3c019ae9f974, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:07,543 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:07,544 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:07,545 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1107caca-6214-48cf-84c6-aba9e65f5dca, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:07,546 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1107caca-6214-48cf-84c6-aba9e65f5dca, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:07,547 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1107caca-6214-48cf-84c6-aba9e65f5dca, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:07,808 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:07,809 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:07,810 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4c1a85a3-5b08-4380-8b1d-6b444def1f5d, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:07,810 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4c1a85a3-5b08-4380-8b1d-6b444def1f5d, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:07,812 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4c1a85a3-5b08-4380-8b1d-6b444def1f5d, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:08,120 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:08,121 - 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-10 10:01:08,121 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:08,122 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1d91ee02-9e16-4190-a1b6-79c1a4e265d6, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:08,123 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1d91ee02-9e16-4190-a1b6-79c1a4e265d6, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:08,124 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1d91ee02-9e16-4190-a1b6-79c1a4e265d6, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:09,034 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:09,035 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:09,036 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 200849ad-9ce8-4533-a03d-1428ad15e1e2, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:09,036 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 200849ad-9ce8-4533-a03d-1428ad15e1e2, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:09,038 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 200849ad-9ce8-4533-a03d-1428ad15e1e2, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:09,260 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:09,261 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:09,262 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 89e8bb80-ce2c-47f2-b3ef-44ab1cc2628f, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:09,262 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 89e8bb80-ce2c-47f2-b3ef-44ab1cc2628f, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:09,264 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 89e8bb80-ce2c-47f2-b3ef-44ab1cc2628f, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:09,668 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:09,669 - 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-10 10:01:09,670 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:09,670 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7f95cb18-aa3a-425c-a249-9ee3c05f1900, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:09,671 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7f95cb18-aa3a-425c-a249-9ee3c05f1900, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:09,673 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7f95cb18-aa3a-425c-a249-9ee3c05f1900, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:10,714 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:10,715 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:10,716 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f7c3308d-d7de-4cfd-9de9-d99015dea293, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:10,717 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f7c3308d-d7de-4cfd-9de9-d99015dea293, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:10,718 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f7c3308d-d7de-4cfd-9de9-d99015dea293, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:11,022 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:11,022 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:11,023 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 08fdc852-9d6e-43f2-a4f1-96c2b8ecdd74, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:11,024 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 08fdc852-9d6e-43f2-a4f1-96c2b8ecdd74, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:11,025 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 08fdc852-9d6e-43f2-a4f1-96c2b8ecdd74, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:11,440 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:11,441 - 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-10 10:01:11,442 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:11,443 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 808c96d8-fe85-4b7d-ba51-49a7321efe42, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:11,444 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 808c96d8-fe85-4b7d-ba51-49a7321efe42, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:11,445 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 808c96d8-fe85-4b7d-ba51-49a7321efe42, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:12,325 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:12,326 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:12,327 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 186761a5-32df-4328-b5ac-b28aa775aa17, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:12,328 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 186761a5-32df-4328-b5ac-b28aa775aa17, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:12,329 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 186761a5-32df-4328-b5ac-b28aa775aa17, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:12,533 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:12,534 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:12,535 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e8954149-7afd-44f0-aafc-d925bbbae90a, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:12,536 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e8954149-7afd-44f0-aafc-d925bbbae90a, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:12,538 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e8954149-7afd-44f0-aafc-d925bbbae90a, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:12,987 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:12,988 - 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-10 10:01:12,988 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:12,989 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 819fd0aa-8c41-4d25-acf1-e651208120de, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:12,990 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 819fd0aa-8c41-4d25-acf1-e651208120de, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:12,992 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 819fd0aa-8c41-4d25-acf1-e651208120de, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:13,970 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:13,971 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:13,972 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 60acb992-d467-4abb-9d4f-e8c2e6573644, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:13,972 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 60acb992-d467-4abb-9d4f-e8c2e6573644, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:13,974 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 60acb992-d467-4abb-9d4f-e8c2e6573644, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:14,159 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:14,160 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:14,161 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ba231a93-9b85-4e39-a7be-2e0c3044270d, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:14,162 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ba231a93-9b85-4e39-a7be-2e0c3044270d, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:14,163 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ba231a93-9b85-4e39-a7be-2e0c3044270d, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:14,657 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:14,658 - 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-10 10:01:14,659 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:14,659 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1a41cfd9-b177-43b1-a90c-0b5ca01c98ae, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:14,660 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1a41cfd9-b177-43b1-a90c-0b5ca01c98ae, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:14,662 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1a41cfd9-b177-43b1-a90c-0b5ca01c98ae, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:15,622 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:15,623 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:15,624 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4aad9f69-9c45-4593-92ea-090a257a708e, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:15,625 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4aad9f69-9c45-4593-92ea-090a257a708e, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:15,626 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4aad9f69-9c45-4593-92ea-090a257a708e, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:15,953 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:15,954 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:15,955 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 31edc1f9-8208-40d8-afa5-9d5e401704cd, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:15,956 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 31edc1f9-8208-40d8-afa5-9d5e401704cd, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:15,957 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 31edc1f9-8208-40d8-afa5-9d5e401704cd, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:16,572 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:16,572 - 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-10 10:01:16,573 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:16,574 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 64f42545-cd34-408b-9e2c-9fdb09a9c82b, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:16,575 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 64f42545-cd34-408b-9e2c-9fdb09a9c82b, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:16,578 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 64f42545-cd34-408b-9e2c-9fdb09a9c82b, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:17,653 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:17,654 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:17,655 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 742991a4-d01f-4dd5-97a3-9e1e9f96a246, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:17,655 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 742991a4-d01f-4dd5-97a3-9e1e9f96a246, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:17,657 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 742991a4-d01f-4dd5-97a3-9e1e9f96a246, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:17,889 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:17,890 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:17,890 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 44e1f867-e13a-4c5e-8b12-cc4fce7ea64d, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:17,891 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 44e1f867-e13a-4c5e-8b12-cc4fce7ea64d, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:17,893 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 44e1f867-e13a-4c5e-8b12-cc4fce7ea64d, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:18,559 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:18,560 - 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-10 10:01:18,560 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:18,561 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 941efa51-8490-434e-8cd4-dc75ad6c4d54, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:18,561 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 941efa51-8490-434e-8cd4-dc75ad6c4d54, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:18,562 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 941efa51-8490-434e-8cd4-dc75ad6c4d54, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:19,514 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:19,515 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:19,516 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3f440577-e32a-4d6a-9a6b-47649f403bfd, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:19,517 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3f440577-e32a-4d6a-9a6b-47649f403bfd, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:19,519 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3f440577-e32a-4d6a-9a6b-47649f403bfd, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:19,775 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:19,776 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:19,777 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 63e6c5c9-6737-45cb-b1bd-25f68771df3d, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:19,777 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 63e6c5c9-6737-45cb-b1bd-25f68771df3d, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:19,779 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 63e6c5c9-6737-45cb-b1bd-25f68771df3d, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:19,985 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:19,986 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:19,986 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, fabc5c17-cec6-4e39-bc6a-6f94f0da8ffb, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:19,987 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, fabc5c17-cec6-4e39-bc6a-6f94f0da8ffb, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:19,988 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, fabc5c17-cec6-4e39-bc6a-6f94f0da8ffb, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:23,683 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:33,725 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:33,726 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e64e2583-735f-411a-86b7-680f3e7f3914, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:33,726 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e64e2583-735f-411a-86b7-680f3e7f3914, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:33,728 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e64e2583-735f-411a-86b7-680f3e7f3914, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:36,387 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:36,424 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-11-10 10:01:36,425 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:36,426 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e2a9f52b-cf3a-4fa5-a9a2-b93ba66b54fb, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:36,427 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e2a9f52b-cf3a-4fa5-a9a2-b93ba66b54fb, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:36,428 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e2a9f52b-cf3a-4fa5-a9a2-b93ba66b54fb, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:38,880 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:48,921 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:48,922 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 395d834b-b79c-46fa-902f-f8f5fca717b3, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:48,922 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 395d834b-b79c-46fa-902f-f8f5fca717b3, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:48,924 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 395d834b-b79c-46fa-902f-f8f5fca717b3, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:51,994 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:52,050 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-11-10 10:01:52,051 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:52,051 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 12270992-383f-4d79-94d1-d473528a13f0, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:52,052 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 12270992-383f-4d79-94d1-d473528a13f0, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:52,053 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 12270992-383f-4d79-94d1-d473528a13f0, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:52,379 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:52,383 - 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-10 10:01:52,384 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:52,385 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c2bbbe0b-4bee-4c72-bec3-bc4d14ab67b9, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:52,386 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c2bbbe0b-4bee-4c72-bec3-bc4d14ab67b9, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:52,387 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c2bbbe0b-4bee-4c72-bec3-bc4d14ab67b9, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:55,073 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:55,074 - INFO - __tests__.alter_compression - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_4_compression created
2025-11-10 10:01:55,075 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:55,075 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b8a91c8b-fa15-4e05-8f04-644ac3fa05a3, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:55,076 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b8a91c8b-fa15-4e05-8f04-644ac3fa05a3, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:55,077 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b8a91c8b-fa15-4e05-8f04-644ac3fa05a3, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:55,764 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:55,765 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:55,766 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d21f0061-0f58-4b08-b254-0a3450bef495, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:55,766 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d21f0061-0f58-4b08-b254-0a3450bef495, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:55,768 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d21f0061-0f58-4b08-b254-0a3450bef495, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:56,807 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:56,808 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:56,808 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1a4a7c3a-559a-407b-beb3-593fc2d99cd5, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:56,809 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1a4a7c3a-559a-407b-beb3-593fc2d99cd5, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:56,810 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1a4a7c3a-559a-407b-beb3-593fc2d99cd5, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:57,631 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:57,632 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:57,632 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, fa17c531-6d81-4a2a-8cbf-b312a7a3daf2, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:57,633 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, fa17c531-6d81-4a2a-8cbf-b312a7a3daf2, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:57,635 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, fa17c531-6d81-4a2a-8cbf-b312a7a3daf2, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:59,033 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:59,034 - 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-10 10:01:59,035 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:01:59,036 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 57422e61-446a-4d1a-ac58-a41f321857b7, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:01:59,036 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 57422e61-446a-4d1a-ac58-a41f321857b7, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:01:59,038 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 57422e61-446a-4d1a-ac58-a41f321857b7, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:00,338 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:00,339 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:00,340 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c5508cf9-aa14-4f2b-ab68-7a28369ddfe2, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:02:00,340 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c5508cf9-aa14-4f2b-ab68-7a28369ddfe2, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:02:00,346 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c5508cf9-aa14-4f2b-ab68-7a28369ddfe2, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:00,692 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:00,693 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:00,694 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 01e622de-c711-4a52-a32e-d74eebbc9e09, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:02:00,695 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 01e622de-c711-4a52-a32e-d74eebbc9e09, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:02:00,701 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 01e622de-c711-4a52-a32e-d74eebbc9e09, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:01,170 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:01,171 - 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-10 10:02:01,171 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:01,171 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9644c125-3ee5-4246-99e4-b7da6361e5df, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:02:01,172 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9644c125-3ee5-4246-99e4-b7da6361e5df, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:02:01,182 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9644c125-3ee5-4246-99e4-b7da6361e5df, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:02,358 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:02,359 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:02,359 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a28f273c-cde3-4c4e-b93b-1017a3092c40, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:02:02,360 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a28f273c-cde3-4c4e-b93b-1017a3092c40, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:02:02,365 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a28f273c-cde3-4c4e-b93b-1017a3092c40, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:02,891 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:02,892 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:02,893 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5d5979a5-b342-47c1-887d-6c86b58a6d60, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:02:02,894 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5d5979a5-b342-47c1-887d-6c86b58a6d60, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:02:02,895 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5d5979a5-b342-47c1-887d-6c86b58a6d60, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:03,358 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:03,359 - 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-10 10:02:03,359 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:03,360 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 98d323ec-f2b8-4acc-90e0-ced40d267068, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:02:03,361 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 98d323ec-f2b8-4acc-90e0-ced40d267068, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:02:03,362 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 98d323ec-f2b8-4acc-90e0-ced40d267068, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:04,702 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:04,703 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:04,703 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2151529c-afe1-44ec-934f-b2834371361e, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:02:04,704 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2151529c-afe1-44ec-934f-b2834371361e, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:02:04,705 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2151529c-afe1-44ec-934f-b2834371361e, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:05,002 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:05,003 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:05,003 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3e739187-1300-4a11-99a5-f34db02d54e2, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:02:05,004 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3e739187-1300-4a11-99a5-f34db02d54e2, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:02:05,006 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3e739187-1300-4a11-99a5-f34db02d54e2, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:05,618 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:05,619 - 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-10 10:02:05,620 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:05,620 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 26ce215b-ebeb-452c-be6c-a5d7bb13f7af, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:02:05,621 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 26ce215b-ebeb-452c-be6c-a5d7bb13f7af, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:02:05,623 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 26ce215b-ebeb-452c-be6c-a5d7bb13f7af, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:07,029 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:07,030 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:07,030 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 200212a9-56a9-4ce3-a2ae-f5c25dd57674, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:02:07,031 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 200212a9-56a9-4ce3-a2ae-f5c25dd57674, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:02:07,032 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 200212a9-56a9-4ce3-a2ae-f5c25dd57674, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:07,307 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:07,308 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:07,309 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, fca3ae97-2149-431a-8478-e91bcd7c9bf3, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:02:07,310 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, fca3ae97-2149-431a-8478-e91bcd7c9bf3, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:02:07,313 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, fca3ae97-2149-431a-8478-e91bcd7c9bf3, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:07,862 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:07,863 - 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-10 10:02:07,864 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:07,865 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 171ae51c-350c-461e-9c2a-26eb39a2fed5, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:02:07,866 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 171ae51c-350c-461e-9c2a-26eb39a2fed5, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:02:07,873 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 171ae51c-350c-461e-9c2a-26eb39a2fed5, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:08,906 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:08,907 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:08,908 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 02460357-d12b-427b-98b6-672d91d80183, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:02:08,909 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 02460357-d12b-427b-98b6-672d91d80183, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:02:08,912 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 02460357-d12b-427b-98b6-672d91d80183, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:09,204 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:09,204 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:09,205 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 50d7ec96-e233-4ffb-b32c-32d793cbeb07, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:02:09,206 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 50d7ec96-e233-4ffb-b32c-32d793cbeb07, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:02:09,207 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 50d7ec96-e233-4ffb-b32c-32d793cbeb07, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:09,734 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:09,735 - 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-10 10:02:09,735 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:09,736 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 68bb70ca-a16b-4be7-99cf-f8eae091a016, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:02:09,739 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 68bb70ca-a16b-4be7-99cf-f8eae091a016, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:02:09,740 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 68bb70ca-a16b-4be7-99cf-f8eae091a016, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:10,809 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:10,810 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:10,811 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3e905a77-1ea0-4f15-b0f2-0c0507a447b3, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:02:10,811 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3e905a77-1ea0-4f15-b0f2-0c0507a447b3, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:02:10,813 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3e905a77-1ea0-4f15-b0f2-0c0507a447b3, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:11,070 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:11,071 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:11,072 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8658ad9e-e619-43a1-9f98-4ca4d147f61b, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:02:11,073 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8658ad9e-e619-43a1-9f98-4ca4d147f61b, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:02:11,085 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8658ad9e-e619-43a1-9f98-4ca4d147f61b, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:11,629 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:11,630 - 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-10 10:02:11,631 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:11,631 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 44a634ef-b882-47a6-ae59-71a29fa05979, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:02:11,632 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 44a634ef-b882-47a6-ae59-71a29fa05979, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:02:11,633 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 44a634ef-b882-47a6-ae59-71a29fa05979, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:12,937 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:12,938 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:12,939 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b6d83717-eb67-47f2-9819-999cf9f672b8, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:02:12,940 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b6d83717-eb67-47f2-9819-999cf9f672b8, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:02:12,941 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b6d83717-eb67-47f2-9819-999cf9f672b8, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:13,273 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:13,274 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:13,275 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 37c1e19b-feab-4c75-bb93-3472c538996f, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:02:13,276 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 37c1e19b-feab-4c75-bb93-3472c538996f, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:02:13,277 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 37c1e19b-feab-4c75-bb93-3472c538996f, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:13,862 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:13,863 - 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-10 10:02:13,863 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:13,864 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 98fc9f07-a4fa-4e4e-bfcc-e1dab749100c, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:02:13,866 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 98fc9f07-a4fa-4e4e-bfcc-e1dab749100c, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:02:13,867 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 98fc9f07-a4fa-4e4e-bfcc-e1dab749100c, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:14,863 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:14,864 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:14,864 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c2b169b8-aef1-4b3f-ac2f-36cfea64177f, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:02:14,866 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c2b169b8-aef1-4b3f-ac2f-36cfea64177f, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:02:14,871 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c2b169b8-aef1-4b3f-ac2f-36cfea64177f, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:15,160 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:15,161 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:15,162 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 31d57a3f-13c2-4f7a-8386-2d91bc12fd44, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:02:15,163 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 31d57a3f-13c2-4f7a-8386-2d91bc12fd44, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:02:15,165 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 31d57a3f-13c2-4f7a-8386-2d91bc12fd44, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:15,833 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:15,834 - 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-10 10:02:15,834 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:15,835 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e460d013-b6bb-4218-b526-15daee45da1c, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:02:15,836 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e460d013-b6bb-4218-b526-15daee45da1c, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:02:15,837 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e460d013-b6bb-4218-b526-15daee45da1c, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:17,011 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:17,012 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:17,013 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2c2ddaef-8757-4e30-babe-6cb5023864d1, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:02:17,013 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2c2ddaef-8757-4e30-babe-6cb5023864d1, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:02:17,015 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2c2ddaef-8757-4e30-babe-6cb5023864d1, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:17,253 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:17,254 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:17,255 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, cc308ad7-06ef-4cde-902a-f2582e76ef47, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:02:17,255 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, cc308ad7-06ef-4cde-902a-f2582e76ef47, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:02:17,256 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, cc308ad7-06ef-4cde-902a-f2582e76ef47, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:17,896 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:17,896 - 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-10 10:02:17,897 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:17,897 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e5a511d1-899e-47dd-a7e8-4caea1d3080a, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:02:17,898 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e5a511d1-899e-47dd-a7e8-4caea1d3080a, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:02:17,900 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e5a511d1-899e-47dd-a7e8-4caea1d3080a, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:18,981 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:18,982 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:18,982 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8c526726-4b20-4c04-83fe-a4c029a08af6, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:02:18,983 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8c526726-4b20-4c04-83fe-a4c029a08af6, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:02:18,985 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8c526726-4b20-4c04-83fe-a4c029a08af6, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:19,254 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:19,255 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:19,255 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, cd14639d-ab5f-4c65-a81b-b1e206233449, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:02:19,256 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, cd14639d-ab5f-4c65-a81b-b1e206233449, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:02:19,261 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, cd14639d-ab5f-4c65-a81b-b1e206233449, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:19,548 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:19,549 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:19,549 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8bfa9b21-c0db-4e0f-a3bc-b2a59d89e272, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:02:19,550 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8bfa9b21-c0db-4e0f-a3bc-b2a59d89e272, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:02:19,552 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8bfa9b21-c0db-4e0f-a3bc-b2a59d89e272, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:23,517 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:33,581 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:33,582 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 473cd986-2ebe-4e6f-a898-91486524faa5, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:02:33,582 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 473cd986-2ebe-4e6f-a898-91486524faa5, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:02:33,584 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 473cd986-2ebe-4e6f-a898-91486524faa5, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:36,865 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:36,908 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_4_compression`, volumes `value` (8000000, 1595968)
2025-11-10 10:02:36,909 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:36,910 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2a774ee0-6b65-4c92-ae6f-43ce300f2b93, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:02:36,911 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2a774ee0-6b65-4c92-ae6f-43ce300f2b93, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:02:36,912 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2a774ee0-6b65-4c92-ae6f-43ce300f2b93, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:37,237 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:37,238 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:37,239 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 43bf8196-7122-49de-8f5a-a8682d34a301, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:02:37,240 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 43bf8196-7122-49de-8f5a-a8682d34a301, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:02:37,242 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 43bf8196-7122-49de-8f5a-a8682d34a301, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:40,573 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:43,952 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-10 10:02:43,953 - 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-10 10:02:43,971 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-10 10:02:43,971 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 154a605d-0d79-432e-9447-fe68bd356fc1, localhost:2340): creating call state
2025-11-10 10:02:43,972 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 154a605d-0d79-432e-9447-fe68bd356fc1, localhost:2340): request = { database: "/Root" }
2025-11-10 10:02:43,977 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 154a605d-0d79-432e-9447-fe68bd356fc1, localhost:2340): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-2dyy577wua.auto.internal" port: 2340 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-10 10:02:43,977 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-2dyy577wua.auto.internal:2340, location 1, ssl: False>]>
2025-11-10 10:02:43,978 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:2340
2025-11-10 10:02:50,613 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:02:50,614 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 87a8e163-1136-4842-add9-382e35c05237, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:02:50,615 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 87a8e163-1136-4842-add9-382e35c05237, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:02:50,616 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 87a8e163-1136-4842-add9-382e35c05237, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:53,592 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:03:03,641 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:03:03,642 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4d3fb3db-c994-463a-a472-8596bdc6aeee, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:03:03,643 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4d3fb3db-c994-463a-a472-8596bdc6aeee, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:03:03,644 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4d3fb3db-c994-463a-a472-8596bdc6aeee, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:03:04,339 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:03:14,345 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:03:14,346 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, beee2b35-03bf-4ed4-8416-940e3975fd39, ghrun-2dyy577wua.auto.internal:2340): creating call state
2025-11-10 10:03:14,346 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, beee2b35-03bf-4ed4-8416-940e3975fd39, ghrun-2dyy577wua.auto.internal:2340): request = { session_id: "ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=" 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-10 10:03:14,348 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, beee2b35-03bf-4ed4-8416-940e3975fd39, ghrun-2dyy577wua.auto.internal:2340): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:03:15,501 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmZjZDdlM2UtZDY4YWE2ODgtNzdiNDcxMzktZDZhMzhmZWE=
2025-11-10 10:03:15,505 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_4_compression`, volumes `value` (8000000, 1466456)
2025-11-10 10:03:15,506 - INFO - root - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_4_compression` 8092160 / 1466456: 5.518174428690666
2025-11-10 10:03:15,508 - INFO - ya.test - pytest_runtest_teardown: Test teardown
