2025-11-10 10:01:19,294 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-10 10:01:19,294 - INFO - ya.test - pytest_runtest_setup: test_all_supported_compression[zstd_20_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 20]
2025-11-10 10:01:19,295 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-10 10:01:19,295 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-10 10:01:19,297 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-11-10 10:01:19,298 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-11-10 10:01:19,298 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/fhvo/0021be/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-10 10:01:19,300 - DEBUG - ya.test - execute: Command pid: 464910
2025-11-10 10:01:20,129 - DEBUG - ya.test - _save_outputs: Command (pid 464910) rc: 0
2025-11-10 10:01:20,129 - DEBUG - ya.test - _save_outputs: Command (pid 464910) elapsed time (sec): 0.8278565406799316
2025-11-10 10:01:20,130 - DEBUG - ya.test - _save_outputs: Command (pid 464910) idrss: 0
2025-11-10 10:01:20,130 - DEBUG - ya.test - _save_outputs: Command (pid 464910) inblock: 0
2025-11-10 10:01:20,130 - DEBUG - ya.test - _save_outputs: Command (pid 464910) isrss: 0
2025-11-10 10:01:20,130 - DEBUG - ya.test - _save_outputs: Command (pid 464910) ixrss: 0
2025-11-10 10:01:20,131 - DEBUG - ya.test - _save_outputs: Command (pid 464910) majflt: 0
2025-11-10 10:01:20,131 - DEBUG - ya.test - _save_outputs: Command (pid 464910) maxrss: 492904
2025-11-10 10:01:20,131 - DEBUG - ya.test - _save_outputs: Command (pid 464910) minflt: 45368
2025-11-10 10:01:20,132 - DEBUG - ya.test - _save_outputs: Command (pid 464910) msgrcv: 0
2025-11-10 10:01:20,132 - DEBUG - ya.test - _save_outputs: Command (pid 464910) msgsnd: 0
2025-11-10 10:01:20,132 - DEBUG - ya.test - _save_outputs: Command (pid 464910) nivcsw: 120
2025-11-10 10:01:20,132 - DEBUG - ya.test - _save_outputs: Command (pid 464910) nsignals: 0
2025-11-10 10:01:20,133 - DEBUG - ya.test - _save_outputs: Command (pid 464910) nswap: 0
2025-11-10 10:01:20,135 - DEBUG - ya.test - _save_outputs: Command (pid 464910) nvcsw: 14
2025-11-10 10:01:20,136 - DEBUG - ya.test - _save_outputs: Command (pid 464910) oublock: 8
2025-11-10 10:01:20,136 - DEBUG - ya.test - _save_outputs: Command (pid 464910) stime: 0.235481
2025-11-10 10:01:20,136 - DEBUG - ya.test - _save_outputs: Command (pid 464910) utime: 0.454265
2025-11-10 10:01:20,136 - DEBUG - ya.test - _save_outputs: Command (pid 464910) wtime: 0.83
2025-11-10 10:01:20,137 - DEBUG - ya.test - _save_outputs: Command (pid 464910) 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:01:20,137 - DEBUG - ya.test - _save_outputs: Command (pid 464910) errors:

2025-11-10 10:01:20,138 - 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:01:20,346 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/fhvo/0021be/ydb/apps/ydbd/ydbd
2025-11-10 10:01:20,348 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/21079
2025-11-10 10:01:20,350 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/fhvo/0021be/r3tmp/kikimr_cluster_muf0_u_5
2025-11-10 10:01:20,386 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/fhvo/0021be/ydb/apps/ydbd/ydbd
2025-11-10 10:01:20,387 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/12366
2025-11-10 10:01:20,388 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/14274
2025-11-10 10:01:20,388 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/7092
2025-11-10 10:01:20,389 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/3884
2025-11-10 10:01:20,390 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/fhvo/0021be/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk4/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_20_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.20/cluster/kikimr_configs"
2025-11-10 10:01:20,390 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/fhvo/0021be/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/0021be/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk4/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_20_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.20/cluster/node_1/logfile_0ynkqgnz.log --grpc-port=12366 --mon-port=14274 --ic-port=21079
2025-11-10 10:01:20,390 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:12366/1, disk_size 68719476736
2025-11-10 10:01:20,391 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/fhvo/0021be/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk4/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_20_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.20/cluster/kikimr_configs"
2025-11-10 10:01:20,391 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/fhvo/0021be/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/0021be/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk4/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_20_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.20/cluster/node_1/logfile_0ynkqgnz.log --grpc-port=12366 --mon-port=14274 --ic-port=21079
2025-11-10 10:01:20,392 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/fhvo/0021be/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/fhvo/0021be/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk4/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_20_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.20/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/fhvo/0021be/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk4/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_20_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.20/cluster/node_1/logfile_0ynkqgnz.log', '--grpc-port=12366', '--mon-port=14274', '--ic-port=21079')' in '/home/runner/.ya/build/build_root/fhvo/0021be/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk4/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_20_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.20/cluster/node_1' (no wait)
2025-11-10 10:01:20,395 - DEBUG - ya.test - execute: Command pid: 464942
2025-11-10 10:01:20,396 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:12366/1
2025-11-10 10:01:20,398 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-11-10 10:01:20,398 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-11-10 10:01:20,399 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/fhvo/0021be/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-10 10:01:20,401 - DEBUG - ya.test - execute: Command pid: 464943
2025-11-10 10:01:21,213 - DEBUG - ya.test - _save_outputs: Command (pid 464943) rc: 0
2025-11-10 10:01:21,214 - DEBUG - ya.test - _save_outputs: Command (pid 464943) elapsed time (sec): 0.8110189437866211
2025-11-10 10:01:21,214 - DEBUG - ya.test - _save_outputs: Command (pid 464943) idrss: 0
2025-11-10 10:01:21,214 - DEBUG - ya.test - _save_outputs: Command (pid 464943) inblock: 0
2025-11-10 10:01:21,215 - DEBUG - ya.test - _save_outputs: Command (pid 464943) isrss: 0
2025-11-10 10:01:21,215 - DEBUG - ya.test - _save_outputs: Command (pid 464943) ixrss: 0
2025-11-10 10:01:21,215 - DEBUG - ya.test - _save_outputs: Command (pid 464943) majflt: 0
2025-11-10 10:01:21,216 - DEBUG - ya.test - _save_outputs: Command (pid 464943) maxrss: 497920
2025-11-10 10:01:21,216 - DEBUG - ya.test - _save_outputs: Command (pid 464943) minflt: 45349
2025-11-10 10:01:21,216 - DEBUG - ya.test - _save_outputs: Command (pid 464943) msgrcv: 0
2025-11-10 10:01:21,217 - DEBUG - ya.test - _save_outputs: Command (pid 464943) msgsnd: 0
2025-11-10 10:01:21,217 - DEBUG - ya.test - _save_outputs: Command (pid 464943) nivcsw: 145
2025-11-10 10:01:21,217 - DEBUG - ya.test - _save_outputs: Command (pid 464943) nsignals: 0
2025-11-10 10:01:21,218 - DEBUG - ya.test - _save_outputs: Command (pid 464943) nswap: 0
2025-11-10 10:01:21,218 - DEBUG - ya.test - _save_outputs: Command (pid 464943) nvcsw: 15
2025-11-10 10:01:21,218 - DEBUG - ya.test - _save_outputs: Command (pid 464943) oublock: 8
2025-11-10 10:01:21,218 - DEBUG - ya.test - _save_outputs: Command (pid 464943) stime: 0.186694
2025-11-10 10:01:21,219 - DEBUG - ya.test - _save_outputs: Command (pid 464943) utime: 0.499727
2025-11-10 10:01:21,219 - DEBUG - ya.test - _save_outputs: Command (pid 464943) wtime: 0.814
2025-11-10 10:01:21,219 - DEBUG - ya.test - _save_outputs: Command (pid 464943) 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:01:21,220 - DEBUG - ya.test - _save_outputs: Command (pid 464943) errors:

2025-11-10 10:01:21,220 - 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:01:26,000 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/fhvo/0021be/ydb/apps/ydbd/ydbd
2025-11-10 10:01:26,000 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/fhvo/0021be/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:12366', '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: 21079\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-10 10:01:26,001 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-11-10 10:01:26,002 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-11-10 10:01:26,002 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/fhvo/0021be/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:12366', '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: 21079\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-10 10:01:26,009 - DEBUG - ya.test - execute: Command pid: 465402
2025-11-10 10:01:26,965 - DEBUG - ya.test - _save_outputs: Command (pid 465402) rc: 0
2025-11-10 10:01:26,966 - DEBUG - ya.test - _save_outputs: Command (pid 465402) elapsed time (sec): 0.9550173282623291
2025-11-10 10:01:26,966 - DEBUG - ya.test - _save_outputs: Command (pid 465402) idrss: 0
2025-11-10 10:01:26,966 - DEBUG - ya.test - _save_outputs: Command (pid 465402) inblock: 0
2025-11-10 10:01:26,966 - DEBUG - ya.test - _save_outputs: Command (pid 465402) isrss: 0
2025-11-10 10:01:26,967 - DEBUG - ya.test - _save_outputs: Command (pid 465402) ixrss: 0
2025-11-10 10:01:26,967 - DEBUG - ya.test - _save_outputs: Command (pid 465402) majflt: 0
2025-11-10 10:01:26,967 - DEBUG - ya.test - _save_outputs: Command (pid 465402) maxrss: 596352
2025-11-10 10:01:26,967 - DEBUG - ya.test - _save_outputs: Command (pid 465402) minflt: 51594
2025-11-10 10:01:26,968 - DEBUG - ya.test - _save_outputs: Command (pid 465402) msgrcv: 0
2025-11-10 10:01:26,968 - DEBUG - ya.test - _save_outputs: Command (pid 465402) msgsnd: 0
2025-11-10 10:01:26,968 - DEBUG - ya.test - _save_outputs: Command (pid 465402) nivcsw: 147
2025-11-10 10:01:26,968 - DEBUG - ya.test - _save_outputs: Command (pid 465402) nsignals: 0
2025-11-10 10:01:26,970 - DEBUG - ya.test - _save_outputs: Command (pid 465402) nswap: 0
2025-11-10 10:01:26,970 - DEBUG - ya.test - _save_outputs: Command (pid 465402) nvcsw: 759
2025-11-10 10:01:26,970 - DEBUG - ya.test - _save_outputs: Command (pid 465402) oublock: 8
2025-11-10 10:01:26,970 - DEBUG - ya.test - _save_outputs: Command (pid 465402) stime: 0.27926
2025-11-10 10:01:26,971 - DEBUG - ya.test - _save_outputs: Command (pid 465402) utime: 0.576507
2025-11-10 10:01:26,971 - DEBUG - ya.test - _save_outputs: Command (pid 465402) wtime: 0.963
2025-11-10 10:01:26,971 - DEBUG - ya.test - _save_outputs: Command (pid 465402) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-10 10:01:26,972 - DEBUG - ya.test - _save_outputs: Command (pid 465402) errors:

2025-11-10 10:01:26,976 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/fhvo/0021be/ydb/apps/ydbd/ydbd
2025-11-10 10:01:26,977 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/fhvo/0021be/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:12366', '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:01:26,978 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-11-10 10:01:26,979 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-11-10 10:01:26,979 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/fhvo/0021be/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:12366', '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:01:26,985 - DEBUG - ya.test - execute: Command pid: 465585
2025-11-10 10:01:27,956 - DEBUG - ya.test - _save_outputs: Command (pid 465585) rc: 0
2025-11-10 10:01:27,957 - DEBUG - ya.test - _save_outputs: Command (pid 465585) elapsed time (sec): 0.970717191696167
2025-11-10 10:01:27,957 - DEBUG - ya.test - _save_outputs: Command (pid 465585) idrss: 0
2025-11-10 10:01:27,958 - DEBUG - ya.test - _save_outputs: Command (pid 465585) inblock: 0
2025-11-10 10:01:27,958 - DEBUG - ya.test - _save_outputs: Command (pid 465585) isrss: 0
2025-11-10 10:01:27,958 - DEBUG - ya.test - _save_outputs: Command (pid 465585) ixrss: 0
2025-11-10 10:01:27,958 - DEBUG - ya.test - _save_outputs: Command (pid 465585) majflt: 0
2025-11-10 10:01:27,959 - DEBUG - ya.test - _save_outputs: Command (pid 465585) maxrss: 596684
2025-11-10 10:01:27,959 - DEBUG - ya.test - _save_outputs: Command (pid 465585) minflt: 51607
2025-11-10 10:01:27,959 - DEBUG - ya.test - _save_outputs: Command (pid 465585) msgrcv: 0
2025-11-10 10:01:27,959 - DEBUG - ya.test - _save_outputs: Command (pid 465585) msgsnd: 0
2025-11-10 10:01:27,960 - DEBUG - ya.test - _save_outputs: Command (pid 465585) nivcsw: 208
2025-11-10 10:01:27,960 - DEBUG - ya.test - _save_outputs: Command (pid 465585) nsignals: 0
2025-11-10 10:01:27,960 - DEBUG - ya.test - _save_outputs: Command (pid 465585) nswap: 0
2025-11-10 10:01:27,960 - DEBUG - ya.test - _save_outputs: Command (pid 465585) nvcsw: 367
2025-11-10 10:01:27,963 - DEBUG - ya.test - _save_outputs: Command (pid 465585) oublock: 8
2025-11-10 10:01:27,964 - DEBUG - ya.test - _save_outputs: Command (pid 465585) stime: 0.292572
2025-11-10 10:01:27,964 - DEBUG - ya.test - _save_outputs: Command (pid 465585) utime: 0.5151439999999999
2025-11-10 10:01:27,964 - DEBUG - ya.test - _save_outputs: Command (pid 465585) wtime: 0.976
2025-11-10 10:01:27,964 - DEBUG - ya.test - _save_outputs: Command (pid 465585) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-11-10 10:01:27,965 - DEBUG - ya.test - _save_outputs: Command (pid 465585) errors:

2025-11-10 10:01:27,965 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-10 10:01:28,133 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-11-10 10:01:28,180 - 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:01:28,183 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-10 10:01:28,186 - 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:01:28,200 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-10 10:01:28,201 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 2e430975-6ecf-467f-abe9-eecbcc651323, localhost:12366): creating call state
2025-11-10 10:01:28,201 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 2e430975-6ecf-467f-abe9-eecbcc651323, localhost:12366): request = { database: "/Root" }
2025-11-10 10:01:28,222 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 2e430975-6ecf-467f-abe9-eecbcc651323, localhost:12366): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-2dyy577wua.auto.internal" port: 12366 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:01:28,223 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-2dyy577wua.auto.internal:12366, location 1, ssl: False>]>
2025-11-10 10:01:28,224 - 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:01:28,240 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:12366
2025-11-10 10:01:28,241 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-10 10:01:28,243 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, fca81597-5957-48eb-afd1-6d90775b1b92, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:28,244 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, fca81597-5957-48eb-afd1-6d90775b1b92, ghrun-2dyy577wua.auto.internal:12366): request = {  }
2025-11-10 10:01:28,253 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, fca81597-5957-48eb-afd1-6d90775b1b92, ghrun-2dyy577wua.auto.internal:12366): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" node_id: 1 }
2025-11-10 10:01:28,255 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, c84a0a2f-2bb9-4396-87d6-5dde9750dbf9, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:28,255 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, c84a0a2f-2bb9-4396-87d6-5dde9750dbf9, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" }
2025-11-10 10:01:28,261 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, c84a0a2f-2bb9-4396-87d6-5dde9750dbf9, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:28,269 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:28,270 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 48a9ecda-ad4e-4abc-bdb0-68205f51f8a6, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:28,271 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 48a9ecda-ad4e-4abc-bdb0-68205f51f8a6, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:01:28,272 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 48a9ecda-ad4e-4abc-bdb0-68205f51f8a6, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:30,660 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:30,661 - INFO - __tests__.alter_compression - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-11-10 10:01:30,662 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:30,662 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 18095a57-fea0-4395-8bf4-03b00a41172b, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:30,663 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 18095a57-fea0-4395-8bf4-03b00a41172b, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:30,664 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 18095a57-fea0-4395-8bf4-03b00a41172b, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:31,683 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:31,684 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:31,685 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 63f8d78d-9a8f-4381-9ba9-315f4aac50c7, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:31,686 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 63f8d78d-9a8f-4381-9ba9-315f4aac50c7, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:31,687 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 63f8d78d-9a8f-4381-9ba9-315f4aac50c7, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:32,668 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:32,669 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:32,669 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0e4f054a-300e-4fcf-80db-7fbf80538a66, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:32,670 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0e4f054a-300e-4fcf-80db-7fbf80538a66, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:32,672 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0e4f054a-300e-4fcf-80db-7fbf80538a66, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:33,411 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:33,412 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:33,413 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3788f96a-2144-4e63-826e-9b27f5e80da3, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:33,413 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3788f96a-2144-4e63-826e-9b27f5e80da3, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:33,415 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3788f96a-2144-4e63-826e-9b27f5e80da3, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:34,655 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:34,656 - 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:34,656 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:34,657 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 009a9726-2e80-47ca-bb08-51d61c4dbf62, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:34,658 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 009a9726-2e80-47ca-bb08-51d61c4dbf62, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:34,660 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 009a9726-2e80-47ca-bb08-51d61c4dbf62, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:35,501 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:35,502 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:35,503 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f51cd9dd-14ac-4334-967e-3d2f9e0757f8, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:35,503 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f51cd9dd-14ac-4334-967e-3d2f9e0757f8, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:35,504 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f51cd9dd-14ac-4334-967e-3d2f9e0757f8, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:35,717 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:35,718 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:35,719 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1fd70717-74a5-4d24-a847-c33e83a84885, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:35,720 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1fd70717-74a5-4d24-a847-c33e83a84885, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:35,724 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1fd70717-74a5-4d24-a847-c33e83a84885, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:36,004 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:36,005 - 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:36,005 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:36,006 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, fe6b5cec-5968-40eb-96a2-3e1dcee5a3f5, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:36,006 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, fe6b5cec-5968-40eb-96a2-3e1dcee5a3f5, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:36,007 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, fe6b5cec-5968-40eb-96a2-3e1dcee5a3f5, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:36,723 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:36,724 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:36,724 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0cf23dda-1157-47b5-821b-c550fe8f682e, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:36,725 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0cf23dda-1157-47b5-821b-c550fe8f682e, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:36,726 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0cf23dda-1157-47b5-821b-c550fe8f682e, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:36,911 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:36,912 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:36,912 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 44e0a1a5-3745-4d57-8fd7-995c252b4431, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:36,913 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 44e0a1a5-3745-4d57-8fd7-995c252b4431, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:36,914 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 44e0a1a5-3745-4d57-8fd7-995c252b4431, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:37,178 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:37,179 - 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:37,179 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:37,180 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 80a91898-7a9f-4c7a-90f3-6ec7168910ac, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:37,181 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 80a91898-7a9f-4c7a-90f3-6ec7168910ac, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:37,182 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 80a91898-7a9f-4c7a-90f3-6ec7168910ac, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:37,903 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:37,904 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:37,905 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ee37cd7e-95e5-465f-8dfc-6cc58ed86983, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:37,905 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ee37cd7e-95e5-465f-8dfc-6cc58ed86983, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:37,907 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ee37cd7e-95e5-465f-8dfc-6cc58ed86983, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:38,078 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:38,079 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:38,079 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 775ab9bc-29f7-476b-881e-ea2c5061aa49, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:38,080 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 775ab9bc-29f7-476b-881e-ea2c5061aa49, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:38,081 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 775ab9bc-29f7-476b-881e-ea2c5061aa49, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:38,349 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:38,350 - 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:38,350 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:38,351 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f228783f-f055-4b31-bb3e-424a760b16ec, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:38,352 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f228783f-f055-4b31-bb3e-424a760b16ec, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:38,353 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f228783f-f055-4b31-bb3e-424a760b16ec, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:39,116 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:39,116 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:39,117 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 534081ae-a561-4e01-be2a-da2146b3bf32, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:39,118 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 534081ae-a561-4e01-be2a-da2146b3bf32, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:39,119 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 534081ae-a561-4e01-be2a-da2146b3bf32, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:39,267 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:39,268 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:39,268 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c1fa9ed5-1e6f-420c-8d03-8bffdedcde68, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:39,269 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c1fa9ed5-1e6f-420c-8d03-8bffdedcde68, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:39,270 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c1fa9ed5-1e6f-420c-8d03-8bffdedcde68, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:39,566 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:39,567 - 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:39,567 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:39,568 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 361331d2-000c-46b7-9786-c4e5d5b677ab, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:39,569 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 361331d2-000c-46b7-9786-c4e5d5b677ab, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:39,570 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 361331d2-000c-46b7-9786-c4e5d5b677ab, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:40,369 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:40,369 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:40,370 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 99d951f2-5e9b-42a6-9e66-e0fffb8cf114, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:40,371 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 99d951f2-5e9b-42a6-9e66-e0fffb8cf114, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:40,372 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 99d951f2-5e9b-42a6-9e66-e0fffb8cf114, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:40,557 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:40,558 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:40,559 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9d138db9-907c-46b2-af63-93270bfdbde4, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:40,560 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9d138db9-907c-46b2-af63-93270bfdbde4, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:40,561 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9d138db9-907c-46b2-af63-93270bfdbde4, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:40,934 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:40,934 - 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:40,935 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:40,935 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2fcc0d17-3bd0-4284-9fc5-1685ccac0741, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:40,936 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2fcc0d17-3bd0-4284-9fc5-1685ccac0741, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:40,937 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2fcc0d17-3bd0-4284-9fc5-1685ccac0741, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:41,727 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:41,728 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:41,728 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3922555b-e286-461b-9211-70ce7fbaa8e9, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:41,729 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3922555b-e286-461b-9211-70ce7fbaa8e9, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:41,730 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3922555b-e286-461b-9211-70ce7fbaa8e9, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:41,914 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:41,914 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:41,914 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2d4070ce-1dd6-4b64-a68a-395d72b0d248, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:41,915 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2d4070ce-1dd6-4b64-a68a-395d72b0d248, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:41,916 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2d4070ce-1dd6-4b64-a68a-395d72b0d248, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:42,325 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:42,326 - 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:42,327 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:42,327 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3c10f5ea-237a-4030-a552-54d8447a1b4f, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:42,328 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3c10f5ea-237a-4030-a552-54d8447a1b4f, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:42,330 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3c10f5ea-237a-4030-a552-54d8447a1b4f, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:43,298 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:43,298 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:43,299 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7a8bbd64-d505-4b47-b89b-b8323d8b488a, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:43,300 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7a8bbd64-d505-4b47-b89b-b8323d8b488a, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:43,301 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7a8bbd64-d505-4b47-b89b-b8323d8b488a, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:43,518 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:43,519 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:43,520 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 55e92b19-aaa4-45fc-9ca6-521d2f670aca, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:43,520 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 55e92b19-aaa4-45fc-9ca6-521d2f670aca, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:43,522 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 55e92b19-aaa4-45fc-9ca6-521d2f670aca, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:43,978 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:43,979 - 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:43,979 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:43,980 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a9afa95d-ad5e-4f78-9a0d-2aeebf77fe0d, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:43,981 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a9afa95d-ad5e-4f78-9a0d-2aeebf77fe0d, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:43,983 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a9afa95d-ad5e-4f78-9a0d-2aeebf77fe0d, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:44,868 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:44,869 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:44,870 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4e0eb8d6-ae91-4827-bb7b-c8b43ab84c75, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:44,871 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4e0eb8d6-ae91-4827-bb7b-c8b43ab84c75, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:44,872 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4e0eb8d6-ae91-4827-bb7b-c8b43ab84c75, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:45,105 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:45,106 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:45,107 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 82f53192-0e07-4834-9d5e-bbffa493050d, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:45,108 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 82f53192-0e07-4834-9d5e-bbffa493050d, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:45,110 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 82f53192-0e07-4834-9d5e-bbffa493050d, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:45,614 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:45,615 - 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:45,615 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:45,616 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 254ae1bf-f141-4231-be57-eac2d1000572, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:45,616 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 254ae1bf-f141-4231-be57-eac2d1000572, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:45,618 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 254ae1bf-f141-4231-be57-eac2d1000572, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:46,502 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:46,502 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:46,503 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, fe963cc5-26f0-4469-8408-47d08f0c023a, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:46,504 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, fe963cc5-26f0-4469-8408-47d08f0c023a, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:46,505 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, fe963cc5-26f0-4469-8408-47d08f0c023a, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:46,782 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:46,783 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:46,783 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, aa2741e4-2dd3-4293-9403-0ccd3aa2ac7c, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:46,784 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, aa2741e4-2dd3-4293-9403-0ccd3aa2ac7c, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:46,785 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, aa2741e4-2dd3-4293-9403-0ccd3aa2ac7c, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:47,413 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:47,413 - 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:47,414 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:47,414 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, dc73744a-f714-480f-9735-0edfc9fdbdb1, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:47,415 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, dc73744a-f714-480f-9735-0edfc9fdbdb1, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:47,416 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, dc73744a-f714-480f-9735-0edfc9fdbdb1, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:48,401 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:48,402 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:48,403 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 677d7ec9-7dbe-4414-b363-a146183f5fdb, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:48,403 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 677d7ec9-7dbe-4414-b363-a146183f5fdb, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:48,409 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 677d7ec9-7dbe-4414-b363-a146183f5fdb, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:48,638 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:48,639 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:48,640 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, cd4983fb-0759-4128-a777-188adf576170, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:48,641 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, cd4983fb-0759-4128-a777-188adf576170, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:48,642 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, cd4983fb-0759-4128-a777-188adf576170, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:48,869 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:48,870 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:01:48,871 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 30464d3f-aed1-44b0-af14-fbd4b2ae356c, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:01:48,872 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 30464d3f-aed1-44b0-af14-fbd4b2ae356c, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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,877 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 30464d3f-aed1-44b0-af14-fbd4b2ae356c, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:01:51,986 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:02,025 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:02,026 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ebfb1684-1bbb-4c9c-8558-052d75ff616c, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:02:02,027 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ebfb1684-1bbb-4c9c-8558-052d75ff616c, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:02:02,028 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ebfb1684-1bbb-4c9c-8558-052d75ff616c, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:05,804 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:05,848 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-11-10 10:02:05,849 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:05,850 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 672f827c-287e-4a75-a45b-96487f566db3, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:02:05,850 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 672f827c-287e-4a75-a45b-96487f566db3, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:02:05,852 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 672f827c-287e-4a75-a45b-96487f566db3, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:08,695 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:18,729 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:18,730 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a250f68f-2c26-42ea-aaf0-d8b495a5cd67, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:02:18,731 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a250f68f-2c26-42ea-aaf0-d8b495a5cd67, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:02:18,732 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a250f68f-2c26-42ea-aaf0-d8b495a5cd67, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:22,079 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:22,116 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-11-10 10:02:22,117 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:22,118 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 11a5db51-0a3b-4cf5-8dd5-8b69d53dc839, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:02:22,119 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 11a5db51-0a3b-4cf5-8dd5-8b69d53dc839, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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:02:22,120 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 11a5db51-0a3b-4cf5-8dd5-8b69d53dc839, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:22,481 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:22,484 - INFO - ya.test - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_20_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 20])
2025-11-10 10:02:22,485 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:22,485 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ad3717e1-2cf4-4871-a8b5-1a5aba20ec53, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:02:22,486 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ad3717e1-2cf4-4871-a8b5-1a5aba20ec53, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_20_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 20)\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-11-10 10:02:22,487 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ad3717e1-2cf4-4871-a8b5-1a5aba20ec53, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:25,598 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:25,599 - INFO - __tests__.alter_compression - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_20_compression created
2025-11-10 10:02:25,599 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:25,600 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 88251ab7-31d5-420c-8c36-8d959175a0e8, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:02:25,601 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 88251ab7-31d5-420c-8c36-8d959175a0e8, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_20_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-10 10:02:25,602 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 88251ab7-31d5-420c-8c36-8d959175a0e8, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:26,466 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:26,467 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:26,467 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, bb0c309a-856b-4a1e-a5f1-8caf08946e69, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:02:26,468 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, bb0c309a-856b-4a1e-a5f1-8caf08946e69, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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_20_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-10 10:02:26,472 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, bb0c309a-856b-4a1e-a5f1-8caf08946e69, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:31,026 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:31,027 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:31,028 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 51feed37-6891-494e-aeef-0c83f9573355, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:02:31,029 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 51feed37-6891-494e-aeef-0c83f9573355, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-10 10:02:31,030 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 51feed37-6891-494e-aeef-0c83f9573355, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:31,965 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:31,967 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:31,967 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, adb64b52-1b4f-47f7-b4d0-3944a2a28ba9, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:02:31,968 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, adb64b52-1b4f-47f7-b4d0-3944a2a28ba9, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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_20_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:31,970 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, adb64b52-1b4f-47f7-b4d0-3944a2a28ba9, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:33,809 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:33,810 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_20_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318528, 'BlobCount': 128}}
2025-11-10 10:02:33,811 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:33,811 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, caada74f-45d6-4b67-98e1-6b42886283da, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:02:33,812 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, caada74f-45d6-4b67-98e1-6b42886283da, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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_20_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-10 10:02:33,818 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, caada74f-45d6-4b67-98e1-6b42886283da, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:38,061 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:38,062 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:38,063 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ddd25162-b8e7-4da4-8fc1-406e911b9909, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:02:38,063 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ddd25162-b8e7-4da4-8fc1-406e911b9909, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-10 10:02:38,065 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ddd25162-b8e7-4da4-8fc1-406e911b9909, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:38,346 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:38,347 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:38,348 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 23539939-5ad4-426c-a185-d245346b3b0b, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:02:38,349 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 23539939-5ad4-426c-a185-d245346b3b0b, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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_20_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:38,351 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 23539939-5ad4-426c-a185-d245346b3b0b, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:38,667 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:38,668 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_20_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 637920, 'BlobCount': 256}}
2025-11-10 10:02:38,668 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:38,669 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6b3ee777-c8e2-4829-82a6-7f4b09cab735, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:02:38,670 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6b3ee777-c8e2-4829-82a6-7f4b09cab735, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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_20_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-10 10:02:38,672 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6b3ee777-c8e2-4829-82a6-7f4b09cab735, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:42,018 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:42,019 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:42,019 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 59d11f20-e0db-4022-9091-dd9e6ac3aab6, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:02:42,020 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 59d11f20-e0db-4022-9091-dd9e6ac3aab6, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-10 10:02:42,025 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 59d11f20-e0db-4022-9091-dd9e6ac3aab6, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:42,329 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:42,330 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:42,330 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, aedd60b9-728e-4a05-8532-c2c8d50a4991, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:02:42,331 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, aedd60b9-728e-4a05-8532-c2c8d50a4991, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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_20_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:42,333 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, aedd60b9-728e-4a05-8532-c2c8d50a4991, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:42,725 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:42,726 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_20_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 956816, 'BlobCount': 384}}
2025-11-10 10:02:42,727 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:42,728 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ce0dcb66-c9ca-4c51-8bbe-ffb833301127, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:02:42,728 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ce0dcb66-c9ca-4c51-8bbe-ffb833301127, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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_20_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-10 10:02:42,730 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ce0dcb66-c9ca-4c51-8bbe-ffb833301127, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:46,110 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:46,111 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:46,111 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, cca9962c-93bb-4fc1-87f4-82f66ab9332f, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:02:46,112 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, cca9962c-93bb-4fc1-87f4-82f66ab9332f, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-10 10:02:46,114 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, cca9962c-93bb-4fc1-87f4-82f66ab9332f, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:46,377 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:46,378 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:46,379 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f9839a78-0f49-4e57-85c1-521890cb4b09, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:02:46,380 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f9839a78-0f49-4e57-85c1-521890cb4b09, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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_20_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:46,381 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f9839a78-0f49-4e57-85c1-521890cb4b09, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:46,738 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:46,739 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_20_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1276240, 'BlobCount': 512}}
2025-11-10 10:02:46,739 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:46,740 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2ec87dd2-a6ad-45fa-814c-669014fcd0e9, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:02:46,741 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2ec87dd2-a6ad-45fa-814c-669014fcd0e9, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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_20_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-10 10:02:46,743 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2ec87dd2-a6ad-45fa-814c-669014fcd0e9, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:50,657 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:50,658 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:50,659 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 82739136-64b9-4dfa-a501-cddbbb429710, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:02:50,659 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 82739136-64b9-4dfa-a501-cddbbb429710, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-10 10:02:50,665 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 82739136-64b9-4dfa-a501-cddbbb429710, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:50,921 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:50,922 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:50,923 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5dca4df3-6278-485d-aab5-8aa08fbd9ce4, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:02:50,924 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5dca4df3-6278-485d-aab5-8aa08fbd9ce4, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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_20_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:50,925 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5dca4df3-6278-485d-aab5-8aa08fbd9ce4, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:51,399 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:51,399 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_20_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1595136, 'BlobCount': 640}}
2025-11-10 10:02:51,400 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:51,401 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0e5f0056-7c2f-4ea2-b285-50e3aca33b0e, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:02:51,401 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0e5f0056-7c2f-4ea2-b285-50e3aca33b0e, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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_20_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-10 10:02:51,426 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0e5f0056-7c2f-4ea2-b285-50e3aca33b0e, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:55,368 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:55,369 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:55,369 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 059d2e03-24fa-4280-b870-490d42fd49ac, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:02:55,370 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 059d2e03-24fa-4280-b870-490d42fd49ac, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-10 10:02:55,371 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 059d2e03-24fa-4280-b870-490d42fd49ac, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:55,660 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:55,661 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:55,662 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 463900db-b444-4005-92ba-fdd52fcd9b57, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:02:55,662 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 463900db-b444-4005-92ba-fdd52fcd9b57, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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_20_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:55,663 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 463900db-b444-4005-92ba-fdd52fcd9b57, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:56,133 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:56,134 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_20_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1914416, 'BlobCount': 768}}
2025-11-10 10:02:56,134 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:02:56,135 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 603c931d-50c9-48af-8ca6-f4ad42cf809e, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:02:56,136 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 603c931d-50c9-48af-8ca6-f4ad42cf809e, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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_20_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-10 10:02:56,137 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 603c931d-50c9-48af-8ca6-f4ad42cf809e, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:02:59,025 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-10 10:02:59,025 - 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:59,057 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-10 10:02:59,058 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, e9b567e3-4f8b-4cfa-8f7b-9d099a66d3cb, localhost:12366): creating call state
2025-11-10 10:02:59,059 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, e9b567e3-4f8b-4cfa-8f7b-9d099a66d3cb, localhost:12366): request = { database: "/Root" }
2025-11-10 10:02:59,068 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, e9b567e3-4f8b-4cfa-8f7b-9d099a66d3cb, localhost:12366): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-2dyy577wua.auto.internal" port: 12366 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:59,069 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-2dyy577wua.auto.internal:12366, location 1, ssl: False>]>
2025-11-10 10:02:59,069 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:12366
2025-11-10 10:03:00,075 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:03:00,076 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:03:00,077 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 72d907fd-b7fb-44ae-80bd-31336a983307, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:03:00,078 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 72d907fd-b7fb-44ae-80bd-31336a983307, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-10 10:03:00,079 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 72d907fd-b7fb-44ae-80bd-31336a983307, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:03:00,388 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:03:00,389 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:03:00,390 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, defa1d3d-973f-437b-af01-a9e39af77699, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:03:00,391 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, defa1d3d-973f-437b-af01-a9e39af77699, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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_20_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-10 10:03:00,397 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, defa1d3d-973f-437b-af01-a9e39af77699, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:03:00,977 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:03:00,978 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_20_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2233456, 'BlobCount': 896}}
2025-11-10 10:03:00,979 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:03:00,979 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e659c41d-1779-4bd4-8961-3fad8b74035c, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:03:00,980 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e659c41d-1779-4bd4-8961-3fad8b74035c, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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_20_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-10 10:03:00,982 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e659c41d-1779-4bd4-8961-3fad8b74035c, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:03:04,731 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:03:04,732 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:03:04,732 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8a98b25b-7d5f-41a8-8870-8f599744e2ab, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:03:04,733 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8a98b25b-7d5f-41a8-8870-8f599744e2ab, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-10 10:03:04,735 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8a98b25b-7d5f-41a8-8870-8f599744e2ab, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:03:05,041 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:03:05,042 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:03:05,043 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ab907263-b089-4f51-aff8-6e19ec83848c, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:03:05,044 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ab907263-b089-4f51-aff8-6e19ec83848c, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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_20_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-10 10:03:05,045 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ab907263-b089-4f51-aff8-6e19ec83848c, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:03:05,665 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:03:05,665 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_20_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2552960, 'BlobCount': 1024}}
2025-11-10 10:03:05,666 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:03:05,667 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f0b4b658-eecd-420d-b889-1517bb9fd9c3, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:03:05,668 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f0b4b658-eecd-420d-b889-1517bb9fd9c3, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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_20_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-10 10:03:05,669 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f0b4b658-eecd-420d-b889-1517bb9fd9c3, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:03:09,608 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:03:09,609 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:03:09,610 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3f665147-5abf-4b30-96fc-9cd2b9763ff1, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:03:09,611 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3f665147-5abf-4b30-96fc-9cd2b9763ff1, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-10 10:03:09,612 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3f665147-5abf-4b30-96fc-9cd2b9763ff1, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:03:09,937 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:03:09,938 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:03:09,939 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c218a44c-c44a-4204-be3e-4805b9c2bcf0, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:03:09,940 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c218a44c-c44a-4204-be3e-4805b9c2bcf0, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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_20_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-10 10:03:09,942 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c218a44c-c44a-4204-be3e-4805b9c2bcf0, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:03:10,737 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:03:10,738 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_20_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2871840, 'BlobCount': 1152}}
2025-11-10 10:03:10,738 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:03:10,739 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c6bfedbc-ac10-4351-8eb1-737fb42ceb6b, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:03:10,740 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c6bfedbc-ac10-4351-8eb1-737fb42ceb6b, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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_20_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-10 10:03:10,741 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c6bfedbc-ac10-4351-8eb1-737fb42ceb6b, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:03:14,817 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:03:14,818 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:03:14,819 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8e263560-1fba-4a90-9bb8-e81481f1566b, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:03:14,820 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8e263560-1fba-4a90-9bb8-e81481f1566b, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-10 10:03:14,821 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8e263560-1fba-4a90-9bb8-e81481f1566b, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:03:15,118 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:03:15,119 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:03:15,120 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0b3f6709-3bcb-4b8b-9cb2-f60d9029ddf3, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:03:15,121 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0b3f6709-3bcb-4b8b-9cb2-f60d9029ddf3, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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_20_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-10 10:03:15,128 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0b3f6709-3bcb-4b8b-9cb2-f60d9029ddf3, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:03:15,820 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:03:15,821 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_20_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3191408, 'BlobCount': 1280}}
2025-11-10 10:03:15,821 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:03:15,822 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f5b14e58-5554-4e30-a24b-ca93eb0f90bd, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:03:15,822 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f5b14e58-5554-4e30-a24b-ca93eb0f90bd, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_20_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-10 10:03:15,823 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f5b14e58-5554-4e30-a24b-ca93eb0f90bd, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:03:17,574 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:03:17,575 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:03:17,576 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 77985788-7b8d-444a-89fd-86dbf53ca3f2, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:03:17,577 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 77985788-7b8d-444a-89fd-86dbf53ca3f2, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-10 10:03:17,578 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 77985788-7b8d-444a-89fd-86dbf53ca3f2, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:03:17,830 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:03:17,831 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:03:17,832 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9d22791e-6b67-4976-b821-a59792f98cb1, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:03:17,833 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9d22791e-6b67-4976-b821-a59792f98cb1, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-10 10:03:17,835 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9d22791e-6b67-4976-b821-a59792f98cb1, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:03:18,255 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:03:18,256 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:03:18,256 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c1f60571-6b01-49a3-917b-8e785441c0a3, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:03:18,257 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c1f60571-6b01-49a3-917b-8e785441c0a3, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_20_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-10 10:03:18,259 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c1f60571-6b01-49a3-917b-8e785441c0a3, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:03:22,871 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:03:32,929 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:03:32,930 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 85499dba-b0b5-4bd3-8916-d2535a8edf3a, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:03:32,931 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 85499dba-b0b5-4bd3-8916-d2535a8edf3a, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_20_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-10 10:03:32,933 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 85499dba-b0b5-4bd3-8916-d2535a8edf3a, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:03:36,562 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:03:36,588 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_20_compression`, volumes `value` (8000000, 1563232)
2025-11-10 10:03:36,589 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:03:36,590 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, dba440cd-61ab-425c-b16b-55a9e4c2aec6, ghrun-2dyy577wua.auto.internal:12366): creating call state
2025-11-10 10:03:36,591 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, dba440cd-61ab-425c-b16b-55a9e4c2aec6, ghrun-2dyy577wua.auto.internal:12366): request = { session_id: "ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-10 10:03:36,592 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, dba440cd-61ab-425c-b16b-55a9e4c2aec6, ghrun-2dyy577wua.auto.internal:12366): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:03:37,049 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2IwMWEyODUtMjQ1ZGIyNjktODEzYmRhOWUtY2RiMWMwOTk=
2025-11-10 10:03:37,812 - ERROR - ya.test - logreport: ydb/tests/olap/column_family/compression/alter_compression.py:194: in test_all_supported_compression
    assert table.get_portion_stat_by_tier()['__DEFAULT']['Rows'] == expected_raw // 8
E   assert 1015560 == (8000000 // 8)
2025-11-10 10:03:37,815 - INFO - ya.test - pytest_runtest_teardown: Test teardown
