2025-11-01 16:19:05,653 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 16:19:05,654 - INFO - ya.test - pytest_runtest_setup: test_all_supported_compression[zstd_compression-COMPRESSION = "zstd"]
2025-11-01 16:19:05,654 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 16:19:05,654 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-01 16:19:05,657 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-11-01 16:19:05,657 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-11-01 16:19:05,658 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/y72z/002508/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 16:19:05,659 - DEBUG - ya.test - execute: Command pid: 516456
2025-11-01 16:19:06,405 - DEBUG - ya.test - _save_outputs: Command (pid 516456) rc: 0
2025-11-01 16:19:06,406 - DEBUG - ya.test - _save_outputs: Command (pid 516456) elapsed time (sec): 0.7449586391448975
2025-11-01 16:19:06,406 - DEBUG - ya.test - _save_outputs: Command (pid 516456) idrss: 0
2025-11-01 16:19:06,407 - DEBUG - ya.test - _save_outputs: Command (pid 516456) inblock: 0
2025-11-01 16:19:06,407 - DEBUG - ya.test - _save_outputs: Command (pid 516456) isrss: 0
2025-11-01 16:19:06,407 - DEBUG - ya.test - _save_outputs: Command (pid 516456) ixrss: 0
2025-11-01 16:19:06,407 - DEBUG - ya.test - _save_outputs: Command (pid 516456) majflt: 0
2025-11-01 16:19:06,408 - DEBUG - ya.test - _save_outputs: Command (pid 516456) maxrss: 492412
2025-11-01 16:19:06,408 - DEBUG - ya.test - _save_outputs: Command (pid 516456) minflt: 45386
2025-11-01 16:19:06,408 - DEBUG - ya.test - _save_outputs: Command (pid 516456) msgrcv: 0
2025-11-01 16:19:06,409 - DEBUG - ya.test - _save_outputs: Command (pid 516456) msgsnd: 0
2025-11-01 16:19:06,409 - DEBUG - ya.test - _save_outputs: Command (pid 516456) nivcsw: 108
2025-11-01 16:19:06,409 - DEBUG - ya.test - _save_outputs: Command (pid 516456) nsignals: 0
2025-11-01 16:19:06,409 - DEBUG - ya.test - _save_outputs: Command (pid 516456) nswap: 0
2025-11-01 16:19:06,410 - DEBUG - ya.test - _save_outputs: Command (pid 516456) nvcsw: 15
2025-11-01 16:19:06,410 - DEBUG - ya.test - _save_outputs: Command (pid 516456) oublock: 8
2025-11-01 16:19:06,410 - DEBUG - ya.test - _save_outputs: Command (pid 516456) stime: 0.22613
2025-11-01 16:19:06,410 - DEBUG - ya.test - _save_outputs: Command (pid 516456) utime: 0.441739
2025-11-01 16:19:06,411 - DEBUG - ya.test - _save_outputs: Command (pid 516456) wtime: 0.747
2025-11-01 16:19:06,411 - DEBUG - ya.test - _save_outputs: Command (pid 516456) output:
Git info:
    Commit: b759454d1e40b275ba8b2f5964202fc9f08a1c3c
    Branch: 
    Author: Denis Khalikov <dennis.khalikov@gmail.com>
    Summary: Merge b3001557f326a9ac3df9852d3eea5c83a6651a93 into 88f362bbf1115d2653ecf70400035099c5165741

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-cjocww3of4
    Host information: 
        Linux ghrun-cjocww3of4 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

    
Build info:
    Compiler: /home/runner/.ya/tools/v4/9944335923/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9944335923/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -DCATBOOST_OPENSOURCE=yes -fsanitize=address -Daddress_sanitizer_enabled -fno-omit-frame-pointer -fsanitize-blacklist=/home/runner/actions_runner/_work/ydb/ydb/build/sanitize-blacklist.txt -fno-sanitize-link-runtime -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -std=c++20 -Wimport-preprocessor-directive-pedantic -Woverloaded-virtual -Wno-ambiguous-reversed-operator -Wno-defaulted-function-deleted -Wno-deprecated-anon-enum-enum-conversion -Wno-deprecated-enum-enum-conversion -Wno-deprecated-enum-float-conversion -Wno-deprecated-volatile -Wno-pessimizing-move -Wno-undefined-var-template -nostdinc++ -DCATBOOST_OPENSOURCE=yes -nostdinc++

2025-11-01 16:19:06,411 - DEBUG - ya.test - _save_outputs: Command (pid 516456) errors:

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

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-cjocww3of4
    Host information: 
        Linux ghrun-cjocww3of4 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

    
Build info:
    Compiler: /home/runner/.ya/tools/v4/9944335923/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9944335923/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -DCATBOOST_OPENSOURCE=yes -fsanitize=address -Daddress_sanitizer_enabled -fno-omit-frame-pointer -fsanitize-blacklist=/home/runner/actions_runner/_work/ydb/ydb/build/sanitize-blacklist.txt -fno-sanitize-link-runtime -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -std=c++20 -Wimport-preprocessor-directive-pedantic -Woverloaded-virtual -Wno-ambiguous-reversed-operator -Wno-defaulted-function-deleted -Wno-deprecated-anon-enum-enum-conversion -Wno-deprecated-enum-enum-conversion -Wno-deprecated-enum-float-conversion -Wno-deprecated-volatile -Wno-pessimizing-move -Wno-undefined-var-template -nostdinc++ -DCATBOOST_OPENSOURCE=yes -nostdinc++

2025-11-01 16:19:06,518 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/y72z/002508/ydb/apps/ydbd/ydbd
2025-11-01 16:19:06,519 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/5019
2025-11-01 16:19:06,521 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/y72z/002508/r3tmp/kikimr_cluster_urven17c
2025-11-01 16:19:06,558 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/y72z/002508/ydb/apps/ydbd/ydbd
2025-11-01 16:19:06,559 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/19493
2025-11-01 16:19:06,560 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/24309
2025-11-01 16:19:06,560 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/63286
2025-11-01 16:19:06,561 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/9473
2025-11-01 16:19:06,562 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/y72z/002508/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_compression-COMPRESSION.=.zstd/cluster/kikimr_configs"
2025-11-01 16:19:06,562 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/y72z/002508/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node=1 --log-file-name=/home/runner/.ya/build/build_root/y72z/002508/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_compression-COMPRESSION.=.zstd/cluster/node_1/logfile_hfkviylt.log --grpc-port=19493 --mon-port=24309 --ic-port=5019
2025-11-01 16:19:06,562 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:19493/1, disk_size 68719476736
2025-11-01 16:19:06,563 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/y72z/002508/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_compression-COMPRESSION.=.zstd/cluster/kikimr_configs"
2025-11-01 16:19:06,563 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/y72z/002508/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node=1 --log-file-name=/home/runner/.ya/build/build_root/y72z/002508/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_compression-COMPRESSION.=.zstd/cluster/node_1/logfile_hfkviylt.log --grpc-port=19493 --mon-port=24309 --ic-port=5019
2025-11-01 16:19:06,564 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/y72z/002508/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/y72z/002508/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_compression-COMPRESSION.=.zstd/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/y72z/002508/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_compression-COMPRESSION.=.zstd/cluster/node_1/logfile_hfkviylt.log', '--grpc-port=19493', '--mon-port=24309', '--ic-port=5019')' in '/home/runner/.ya/build/build_root/y72z/002508/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_compression-COMPRESSION.=.zstd/cluster/node_1' (no wait)
2025-11-01 16:19:06,567 - DEBUG - ya.test - execute: Command pid: 516975
2025-11-01 16:19:06,567 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:19493/1
2025-11-01 16:19:06,569 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-11-01 16:19:06,569 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-11-01 16:19:06,570 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/y72z/002508/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 16:19:06,571 - DEBUG - ya.test - execute: Command pid: 516976
2025-11-01 16:19:07,315 - DEBUG - ya.test - _save_outputs: Command (pid 516976) rc: 0
2025-11-01 16:19:07,315 - DEBUG - ya.test - _save_outputs: Command (pid 516976) elapsed time (sec): 0.7428350448608398
2025-11-01 16:19:07,316 - DEBUG - ya.test - _save_outputs: Command (pid 516976) idrss: 0
2025-11-01 16:19:07,316 - DEBUG - ya.test - _save_outputs: Command (pid 516976) inblock: 0
2025-11-01 16:19:07,316 - DEBUG - ya.test - _save_outputs: Command (pid 516976) isrss: 0
2025-11-01 16:19:07,316 - DEBUG - ya.test - _save_outputs: Command (pid 516976) ixrss: 0
2025-11-01 16:19:07,317 - DEBUG - ya.test - _save_outputs: Command (pid 516976) majflt: 0
2025-11-01 16:19:07,317 - DEBUG - ya.test - _save_outputs: Command (pid 516976) maxrss: 501444
2025-11-01 16:19:07,317 - DEBUG - ya.test - _save_outputs: Command (pid 516976) minflt: 45306
2025-11-01 16:19:07,317 - DEBUG - ya.test - _save_outputs: Command (pid 516976) msgrcv: 0
2025-11-01 16:19:07,318 - DEBUG - ya.test - _save_outputs: Command (pid 516976) msgsnd: 0
2025-11-01 16:19:07,318 - DEBUG - ya.test - _save_outputs: Command (pid 516976) nivcsw: 65
2025-11-01 16:19:07,318 - DEBUG - ya.test - _save_outputs: Command (pid 516976) nsignals: 0
2025-11-01 16:19:07,318 - DEBUG - ya.test - _save_outputs: Command (pid 516976) nswap: 0
2025-11-01 16:19:07,319 - DEBUG - ya.test - _save_outputs: Command (pid 516976) nvcsw: 14
2025-11-01 16:19:07,319 - DEBUG - ya.test - _save_outputs: Command (pid 516976) oublock: 8
2025-11-01 16:19:07,319 - DEBUG - ya.test - _save_outputs: Command (pid 516976) stime: 0.181447
2025-11-01 16:19:07,319 - DEBUG - ya.test - _save_outputs: Command (pid 516976) utime: 0.47261
2025-11-01 16:19:07,320 - DEBUG - ya.test - _save_outputs: Command (pid 516976) wtime: 0.744
2025-11-01 16:19:07,320 - DEBUG - ya.test - _save_outputs: Command (pid 516976) output:
Git info:
    Commit: b759454d1e40b275ba8b2f5964202fc9f08a1c3c
    Branch: 
    Author: Denis Khalikov <dennis.khalikov@gmail.com>
    Summary: Merge b3001557f326a9ac3df9852d3eea5c83a6651a93 into 88f362bbf1115d2653ecf70400035099c5165741

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-cjocww3of4
    Host information: 
        Linux ghrun-cjocww3of4 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

    
Build info:
    Compiler: /home/runner/.ya/tools/v4/9944335923/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9944335923/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -DCATBOOST_OPENSOURCE=yes -fsanitize=address -Daddress_sanitizer_enabled -fno-omit-frame-pointer -fsanitize-blacklist=/home/runner/actions_runner/_work/ydb/ydb/build/sanitize-blacklist.txt -fno-sanitize-link-runtime -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -std=c++20 -Wimport-preprocessor-directive-pedantic -Woverloaded-virtual -Wno-ambiguous-reversed-operator -Wno-defaulted-function-deleted -Wno-deprecated-anon-enum-enum-conversion -Wno-deprecated-enum-enum-conversion -Wno-deprecated-enum-float-conversion -Wno-deprecated-volatile -Wno-pessimizing-move -Wno-undefined-var-template -nostdinc++ -DCATBOOST_OPENSOURCE=yes -nostdinc++

2025-11-01 16:19:07,320 - DEBUG - ya.test - _save_outputs: Command (pid 516976) errors:

2025-11-01 16:19:07,321 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: b759454d1e40b275ba8b2f5964202fc9f08a1c3c
    Branch: 
    Author: Denis Khalikov <dennis.khalikov@gmail.com>
    Summary: Merge b3001557f326a9ac3df9852d3eea5c83a6651a93 into 88f362bbf1115d2653ecf70400035099c5165741
2025-11-01 16:19:12,338 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/y72z/002508/ydb/apps/ydbd/ydbd
2025-11-01 16:19:12,339 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/y72z/002508/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:19493', '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: 5019\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-01 16:19:12,340 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-11-01 16:19:12,349 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-11-01 16:19:12,349 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/y72z/002508/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:19493', '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: 5019\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-01 16:19:12,357 - DEBUG - ya.test - execute: Command pid: 519830
2025-11-01 16:19:13,423 - DEBUG - ya.test - _save_outputs: Command (pid 519830) rc: 0
2025-11-01 16:19:13,424 - DEBUG - ya.test - _save_outputs: Command (pid 519830) elapsed time (sec): 1.0657086372375488
2025-11-01 16:19:13,424 - DEBUG - ya.test - _save_outputs: Command (pid 519830) idrss: 0
2025-11-01 16:19:13,424 - DEBUG - ya.test - _save_outputs: Command (pid 519830) inblock: 0
2025-11-01 16:19:13,425 - DEBUG - ya.test - _save_outputs: Command (pid 519830) isrss: 0
2025-11-01 16:19:13,425 - DEBUG - ya.test - _save_outputs: Command (pid 519830) ixrss: 0
2025-11-01 16:19:13,425 - DEBUG - ya.test - _save_outputs: Command (pid 519830) majflt: 0
2025-11-01 16:19:13,425 - DEBUG - ya.test - _save_outputs: Command (pid 519830) maxrss: 595112
2025-11-01 16:19:13,425 - DEBUG - ya.test - _save_outputs: Command (pid 519830) minflt: 51583
2025-11-01 16:19:13,426 - DEBUG - ya.test - _save_outputs: Command (pid 519830) msgrcv: 0
2025-11-01 16:19:13,426 - DEBUG - ya.test - _save_outputs: Command (pid 519830) msgsnd: 0
2025-11-01 16:19:13,426 - DEBUG - ya.test - _save_outputs: Command (pid 519830) nivcsw: 236
2025-11-01 16:19:13,426 - DEBUG - ya.test - _save_outputs: Command (pid 519830) nsignals: 0
2025-11-01 16:19:13,427 - DEBUG - ya.test - _save_outputs: Command (pid 519830) nswap: 0
2025-11-01 16:19:13,427 - DEBUG - ya.test - _save_outputs: Command (pid 519830) nvcsw: 453
2025-11-01 16:19:13,427 - DEBUG - ya.test - _save_outputs: Command (pid 519830) oublock: 8
2025-11-01 16:19:13,427 - DEBUG - ya.test - _save_outputs: Command (pid 519830) stime: 0.262631
2025-11-01 16:19:13,428 - DEBUG - ya.test - _save_outputs: Command (pid 519830) utime: 0.541995
2025-11-01 16:19:13,428 - DEBUG - ya.test - _save_outputs: Command (pid 519830) wtime: 1.073
2025-11-01 16:19:13,428 - DEBUG - ya.test - _save_outputs: Command (pid 519830) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-01 16:19:13,428 - DEBUG - ya.test - _save_outputs: Command (pid 519830) errors:

2025-11-01 16:19:13,430 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/y72z/002508/ydb/apps/ydbd/ydbd
2025-11-01 16:19:13,430 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/y72z/002508/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:19493', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']
2025-11-01 16:19:13,431 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-11-01 16:19:13,432 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-11-01 16:19:13,433 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/y72z/002508/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:19493', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-01 16:19:13,449 - DEBUG - ya.test - execute: Command pid: 520539
2025-11-01 16:19:14,332 - DEBUG - ya.test - _save_outputs: Command (pid 520539) rc: 0
2025-11-01 16:19:14,333 - DEBUG - ya.test - _save_outputs: Command (pid 520539) elapsed time (sec): 0.8828349113464355
2025-11-01 16:19:14,333 - DEBUG - ya.test - _save_outputs: Command (pid 520539) idrss: 0
2025-11-01 16:19:14,333 - DEBUG - ya.test - _save_outputs: Command (pid 520539) inblock: 0
2025-11-01 16:19:14,334 - DEBUG - ya.test - _save_outputs: Command (pid 520539) isrss: 0
2025-11-01 16:19:14,334 - DEBUG - ya.test - _save_outputs: Command (pid 520539) ixrss: 0
2025-11-01 16:19:14,334 - DEBUG - ya.test - _save_outputs: Command (pid 520539) majflt: 0
2025-11-01 16:19:14,334 - DEBUG - ya.test - _save_outputs: Command (pid 520539) maxrss: 595560
2025-11-01 16:19:14,335 - DEBUG - ya.test - _save_outputs: Command (pid 520539) minflt: 51674
2025-11-01 16:19:14,335 - DEBUG - ya.test - _save_outputs: Command (pid 520539) msgrcv: 0
2025-11-01 16:19:14,335 - DEBUG - ya.test - _save_outputs: Command (pid 520539) msgsnd: 0
2025-11-01 16:19:14,335 - DEBUG - ya.test - _save_outputs: Command (pid 520539) nivcsw: 142
2025-11-01 16:19:14,336 - DEBUG - ya.test - _save_outputs: Command (pid 520539) nsignals: 0
2025-11-01 16:19:14,336 - DEBUG - ya.test - _save_outputs: Command (pid 520539) nswap: 0
2025-11-01 16:19:14,336 - DEBUG - ya.test - _save_outputs: Command (pid 520539) nvcsw: 550
2025-11-01 16:19:14,337 - DEBUG - ya.test - _save_outputs: Command (pid 520539) oublock: 8
2025-11-01 16:19:14,338 - DEBUG - ya.test - _save_outputs: Command (pid 520539) stime: 0.20431
2025-11-01 16:19:14,338 - DEBUG - ya.test - _save_outputs: Command (pid 520539) utime: 0.528054
2025-11-01 16:19:14,338 - DEBUG - ya.test - _save_outputs: Command (pid 520539) wtime: 0.899
2025-11-01 16:19:14,339 - DEBUG - ya.test - _save_outputs: Command (pid 520539) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-11-01 16:19:14,339 - DEBUG - ya.test - _save_outputs: Command (pid 520539) errors:

2025-11-01 16:19:14,339 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-01 16:19:14,500 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-11-01 16:19:14,561 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 16:19:14,569 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 16:19:14,569 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 16:19:14,620 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-01 16:19:14,621 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 7469b65f-aa0d-402f-a7fa-540849206128, localhost:19493): creating call state
2025-11-01 16:19:14,622 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 7469b65f-aa0d-402f-a7fa-540849206128, localhost:19493): request = { database: "/Root" }
2025-11-01 16:19:14,640 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 7469b65f-aa0d-402f-a7fa-540849206128, localhost:19493): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-cjocww3of4.auto.internal" port: 19493 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-11-01 16:19:14,641 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-cjocww3of4.auto.internal:19493, location 1, ssl: False>]>
2025-11-01 16:19:14,642 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 16:19:14,690 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:19493
2025-11-01 16:19:14,691 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 16:19:14,692 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, d6abf728-9719-451a-8a95-cd9a2d0770a3, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:14,693 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, d6abf728-9719-451a-8a95-cd9a2d0770a3, ghrun-cjocww3of4.auto.internal:19493): request = {  }
2025-11-01 16:19:14,700 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, d6abf728-9719-451a-8a95-cd9a2d0770a3, ghrun-cjocww3of4.auto.internal:19493): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" node_id: 1 }
2025-11-01 16:19:14,701 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, 2d8fd972-fc68-4699-b063-6c8c8d0e962a, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:14,701 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, 2d8fd972-fc68-4699-b063-6c8c8d0e962a, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" }
2025-11-01 16:19:14,704 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, 2d8fd972-fc68-4699-b063-6c8c8d0e962a, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:14,713 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:14,714 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 327e37ff-1b33-4c7e-86b1-a364708b9f6b, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:14,715 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 327e37ff-1b33-4c7e-86b1-a364708b9f6b, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/off_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"off\")\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:14,717 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 327e37ff-1b33-4c7e-86b1-a364708b9f6b, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:17,565 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:17,566 - INFO - __tests__.alter_compression - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-11-01 16:19:17,566 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:17,567 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f7a07f8d-2d2d-4c83-b811-768dc239622c, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:17,568 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f7a07f8d-2d2d-4c83-b811-768dc239622c, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/off_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:17,571 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f7a07f8d-2d2d-4c83-b811-768dc239622c, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:18,518 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:18,519 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:18,520 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3c10d552-fd18-4ef1-94b8-35a7b7c16128, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:18,520 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3c10d552-fd18-4ef1-94b8-35a7b7c16128, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 0;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:18,522 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3c10d552-fd18-4ef1-94b8-35a7b7c16128, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:19,594 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:19,595 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:19,595 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 950139a2-b7be-4d38-9bd5-a419cdfd23e3, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:19,596 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 950139a2-b7be-4d38-9bd5-a419cdfd23e3, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:19,597 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 950139a2-b7be-4d38-9bd5-a419cdfd23e3, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:20,293 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:20,293 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:20,294 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ae31867f-ccb8-41f7-a683-76cf7d7990e5, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:20,295 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ae31867f-ccb8-41f7-a683-76cf7d7990e5, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:20,296 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ae31867f-ccb8-41f7-a683-76cf7d7990e5, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:21,595 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:21,596 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 1618432, 'BlobCount': 128}}
2025-11-01 16:19:21,596 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:21,597 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7c622294-cec6-4013-a030-8a52ad2065a8, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:21,597 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7c622294-cec6-4013-a030-8a52ad2065a8, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 100000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:21,599 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7c622294-cec6-4013-a030-8a52ad2065a8, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:22,444 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:22,445 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:22,446 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c9299a32-4fd9-45e3-9066-e340074bc18d, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:22,446 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c9299a32-4fd9-45e3-9066-e340074bc18d, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:22,448 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c9299a32-4fd9-45e3-9066-e340074bc18d, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:22,761 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:22,762 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:22,762 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 238c998d-17a2-4bfa-8b5d-117b5f8309cb, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:22,763 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 238c998d-17a2-4bfa-8b5d-117b5f8309cb, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:22,764 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 238c998d-17a2-4bfa-8b5d-117b5f8309cb, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:23,085 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:23,085 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 3236864, 'BlobCount': 256}}
2025-11-01 16:19:23,085 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:23,086 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, fcf7e093-3987-4b30-84e2-3eca308deb0e, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:23,086 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, fcf7e093-3987-4b30-84e2-3eca308deb0e, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 200000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:23,087 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, fcf7e093-3987-4b30-84e2-3eca308deb0e, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:24,096 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:24,097 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:24,098 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a6bc55c4-fff6-4806-b08b-a831cfa809c6, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:24,099 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a6bc55c4-fff6-4806-b08b-a831cfa809c6, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:24,100 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a6bc55c4-fff6-4806-b08b-a831cfa809c6, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:24,317 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:24,318 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:24,319 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 85ca1df4-2f7f-4ef2-a207-466dffaf21c3, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:24,320 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 85ca1df4-2f7f-4ef2-a207-466dffaf21c3, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:24,321 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 85ca1df4-2f7f-4ef2-a207-466dffaf21c3, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:24,714 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:24,715 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 4855296, 'BlobCount': 384}}
2025-11-01 16:19:24,716 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:24,717 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5e5ed22f-f52b-409f-b7fc-6ef8bfde6486, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:24,718 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5e5ed22f-f52b-409f-b7fc-6ef8bfde6486, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 300000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:24,719 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5e5ed22f-f52b-409f-b7fc-6ef8bfde6486, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:25,470 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:25,471 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:25,471 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3dfb2b13-09ac-4277-af08-415abb8910ec, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:25,472 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3dfb2b13-09ac-4277-af08-415abb8910ec, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:25,474 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3dfb2b13-09ac-4277-af08-415abb8910ec, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:25,731 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:25,732 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:25,733 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, beb667b8-1598-4903-b848-6bf1e1bf7ed9, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:25,734 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, beb667b8-1598-4903-b848-6bf1e1bf7ed9, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:25,735 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, beb667b8-1598-4903-b848-6bf1e1bf7ed9, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:26,134 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:26,135 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 6473728, 'BlobCount': 512}}
2025-11-01 16:19:26,135 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:26,136 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f374d0ba-a838-479e-a602-7f47ec768fd4, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:26,137 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f374d0ba-a838-479e-a602-7f47ec768fd4, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 400000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:26,138 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f374d0ba-a838-479e-a602-7f47ec768fd4, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:27,148 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:27,149 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:27,150 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, be11d06c-9501-46f1-a5ee-355fdd328daf, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:27,151 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, be11d06c-9501-46f1-a5ee-355fdd328daf, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:27,152 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, be11d06c-9501-46f1-a5ee-355fdd328daf, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:27,455 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:27,455 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:27,456 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 058761b2-b4eb-4556-bd4f-b7afd25aa014, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:27,457 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 058761b2-b4eb-4556-bd4f-b7afd25aa014, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:27,458 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 058761b2-b4eb-4556-bd4f-b7afd25aa014, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:28,010 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:28,010 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 8092160, 'BlobCount': 640}}
2025-11-01 16:19:28,011 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:28,011 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a19b1381-c25e-408e-806f-ad7b9488fb4a, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:28,012 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a19b1381-c25e-408e-806f-ad7b9488fb4a, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 500000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:28,013 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a19b1381-c25e-408e-806f-ad7b9488fb4a, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:29,073 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:29,074 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:29,074 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 597b1b43-f826-48a7-bb53-3e601247708d, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:29,075 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 597b1b43-f826-48a7-bb53-3e601247708d, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:29,082 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 597b1b43-f826-48a7-bb53-3e601247708d, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:29,398 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:29,399 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:29,399 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0dfc79d3-5815-4328-93cf-d0f79c5b9aa8, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:29,404 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0dfc79d3-5815-4328-93cf-d0f79c5b9aa8, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:29,406 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0dfc79d3-5815-4328-93cf-d0f79c5b9aa8, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:30,076 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:30,077 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 9710592, 'BlobCount': 768}}
2025-11-01 16:19:30,077 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:30,078 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7b95caa3-7f66-4994-a931-9b0ab8130cbd, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:30,079 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7b95caa3-7f66-4994-a931-9b0ab8130cbd, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 600000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:30,080 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7b95caa3-7f66-4994-a931-9b0ab8130cbd, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:31,178 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:31,179 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:31,179 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e6b52c09-6e52-47ef-a0b6-080d70d64c74, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:31,180 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e6b52c09-6e52-47ef-a0b6-080d70d64c74, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:31,181 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e6b52c09-6e52-47ef-a0b6-080d70d64c74, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:31,450 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:31,451 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:31,451 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e9264e34-b790-4709-bd95-18fffb0b73c1, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:31,452 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e9264e34-b790-4709-bd95-18fffb0b73c1, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:31,454 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e9264e34-b790-4709-bd95-18fffb0b73c1, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:32,077 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:32,078 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 11329024, 'BlobCount': 896}}
2025-11-01 16:19:32,078 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:32,079 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6865bed2-3d61-4301-8863-6ff5beafa846, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:32,080 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6865bed2-3d61-4301-8863-6ff5beafa846, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 700000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:32,085 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6865bed2-3d61-4301-8863-6ff5beafa846, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:33,089 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:33,090 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:33,090 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6d6f69fb-52ab-4a19-ba3c-a398778b2564, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:33,091 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6d6f69fb-52ab-4a19-ba3c-a398778b2564, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:33,092 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6d6f69fb-52ab-4a19-ba3c-a398778b2564, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:33,318 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:33,319 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:33,319 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c8ca8a83-544e-4980-99e7-691bded6dda3, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:33,320 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c8ca8a83-544e-4980-99e7-691bded6dda3, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:33,322 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c8ca8a83-544e-4980-99e7-691bded6dda3, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:33,858 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:33,859 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 12947456, 'BlobCount': 1024}}
2025-11-01 16:19:33,859 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:33,860 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, fe0e98d3-1b7a-423d-ba99-37b5745e6ae1, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:33,861 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, fe0e98d3-1b7a-423d-ba99-37b5745e6ae1, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 800000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:33,862 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, fe0e98d3-1b7a-423d-ba99-37b5745e6ae1, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:34,910 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:34,910 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:34,911 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a7788ac7-27c8-4c68-a11f-35290656470d, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:34,912 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a7788ac7-27c8-4c68-a11f-35290656470d, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:34,913 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a7788ac7-27c8-4c68-a11f-35290656470d, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:35,286 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:35,287 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:35,287 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 16c77806-a930-420b-8f3d-a3f5238baccc, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:35,288 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 16c77806-a930-420b-8f3d-a3f5238baccc, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:35,289 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 16c77806-a930-420b-8f3d-a3f5238baccc, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:35,876 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:35,877 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 14565888, 'BlobCount': 1152}}
2025-11-01 16:19:35,877 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:35,878 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 356f6eac-9465-499d-9839-3015db61ab6b, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:35,878 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 356f6eac-9465-499d-9839-3015db61ab6b, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 900000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:35,883 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 356f6eac-9465-499d-9839-3015db61ab6b, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:37,107 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:37,108 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:37,109 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d3888b40-d012-49aa-b0df-50f9a37f4097, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:37,110 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d3888b40-d012-49aa-b0df-50f9a37f4097, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:37,111 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d3888b40-d012-49aa-b0df-50f9a37f4097, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:37,405 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:37,406 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:37,407 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 039b80eb-0eac-4413-a87f-05469c83422a, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:37,407 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 039b80eb-0eac-4413-a87f-05469c83422a, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:37,409 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 039b80eb-0eac-4413-a87f-05469c83422a, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:38,183 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:38,183 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 16184320, 'BlobCount': 1280}}
2025-11-01 16:19:38,184 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:38,184 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4e3e866c-8a40-4114-81a4-28dc78ecafcc, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:38,185 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4e3e866c-8a40-4114-81a4-28dc78ecafcc, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/off_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:38,186 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4e3e866c-8a40-4114-81a4-28dc78ecafcc, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:39,182 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:39,183 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:39,184 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, bebac9b9-d481-4b18-9884-8d531339e197, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:39,185 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, bebac9b9-d481-4b18-9884-8d531339e197, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:39,186 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, bebac9b9-d481-4b18-9884-8d531339e197, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:39,485 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:39,486 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:39,487 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2b1a33a6-9207-4732-bf90-24a7a2ff3379, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:39,487 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2b1a33a6-9207-4732-bf90-24a7a2ff3379, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:39,489 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2b1a33a6-9207-4732-bf90-24a7a2ff3379, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:39,811 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:39,812 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:39,812 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d78938f5-034b-4b21-89b1-57c5bf7a2ea0, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:39,813 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d78938f5-034b-4b21-89b1-57c5bf7a2ea0, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:39,814 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d78938f5-034b-4b21-89b1-57c5bf7a2ea0, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:43,426 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:53,458 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:53,459 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 417bed8f-f52d-4d46-bbd3-8e561bc3535c, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:53,460 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 417bed8f-f52d-4d46-bbd3-8e561bc3535c, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:53,461 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 417bed8f-f52d-4d46-bbd3-8e561bc3535c, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:56,903 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:56,943 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-11-01 16:19:56,943 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:19:56,951 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 97e02117-9a92-4dc9-947a-426bc835e6fa, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:19:56,951 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 97e02117-9a92-4dc9-947a-426bc835e6fa, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:56,953 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 97e02117-9a92-4dc9-947a-426bc835e6fa, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:00,119 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:10,175 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:10,176 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 84f9544c-f9ad-4181-8615-0ace9a93ddd3, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:10,177 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 84f9544c-f9ad-4181-8615-0ace9a93ddd3, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:10,178 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 84f9544c-f9ad-4181-8615-0ace9a93ddd3, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:14,587 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:14,626 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-11-01 16:20:14,627 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:14,627 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, eb651515-63e1-468b-957e-ad8628bbd832, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:14,628 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, eb651515-63e1-468b-957e-ad8628bbd832, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:14,629 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, eb651515-63e1-468b-957e-ad8628bbd832, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:14,901 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:14,904 - INFO - ya.test - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_compression-COMPRESSION = "zstd"])
2025-11-01 16:20:14,905 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:14,906 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d67d6873-ea3c-4c7b-a533-51deb10f2c58, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:14,907 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d67d6873-ea3c-4c7b-a533-51deb10f2c58, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\")\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:14,910 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d67d6873-ea3c-4c7b-a533-51deb10f2c58, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:18,845 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:18,846 - INFO - __tests__.alter_compression - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_compression created
2025-11-01 16:20:18,846 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:18,847 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9cfe7088-20f5-43f1-a3c0-e861c351ef40, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:18,847 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9cfe7088-20f5-43f1-a3c0-e861c351ef40, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:18,849 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9cfe7088-20f5-43f1-a3c0-e861c351ef40, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:20,021 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:20,022 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:20,022 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6fa19393-f65c-457a-be1a-28c184cfbdb0, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:20,023 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6fa19393-f65c-457a-be1a-28c184cfbdb0, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:20,027 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6fa19393-f65c-457a-be1a-28c184cfbdb0, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:21,593 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:21,593 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:21,594 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2d626401-af29-4b7a-8daa-94004c0e0648, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:21,595 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2d626401-af29-4b7a-8daa-94004c0e0648, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:21,596 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2d626401-af29-4b7a-8daa-94004c0e0648, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:22,565 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:22,566 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:22,566 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9ca1e72a-9abc-4f97-b09a-cd163d63bcbc, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:22,567 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9ca1e72a-9abc-4f97-b09a-cd163d63bcbc, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" 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_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:22,569 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9ca1e72a-9abc-4f97-b09a-cd163d63bcbc, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:24,701 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:24,702 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318880, 'BlobCount': 128}}
2025-11-01 16:20:24,702 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:24,703 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1923332b-2802-4b67-9ffa-19a539ba039a, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:24,704 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1923332b-2802-4b67-9ffa-19a539ba039a, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:24,706 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1923332b-2802-4b67-9ffa-19a539ba039a, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:26,152 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:26,153 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:26,154 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, fe994640-844e-469d-85bd-2b6477d533ec, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:26,155 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, fe994640-844e-469d-85bd-2b6477d533ec, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:26,158 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, fe994640-844e-469d-85bd-2b6477d533ec, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:26,508 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:26,509 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:26,510 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 056be58d-328d-42ba-b031-4b0db6485250, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:26,511 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 056be58d-328d-42ba-b031-4b0db6485250, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" 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_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:26,513 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 056be58d-328d-42ba-b031-4b0db6485250, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:26,876 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:26,876 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 638384, 'BlobCount': 256}}
2025-11-01 16:20:26,877 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:26,878 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ff4d98b3-d708-4c95-97b4-269d85eee840, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:26,879 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ff4d98b3-d708-4c95-97b4-269d85eee840, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:26,880 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ff4d98b3-d708-4c95-97b4-269d85eee840, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:28,069 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:28,069 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:28,070 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0097dc0c-959e-4ecc-be6c-978d8b2f91c3, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:28,071 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0097dc0c-959e-4ecc-be6c-978d8b2f91c3, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:28,072 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0097dc0c-959e-4ecc-be6c-978d8b2f91c3, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:28,518 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:28,519 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:28,519 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2c997daf-2923-4e1e-a3ee-efc890c02f59, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:28,520 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2c997daf-2923-4e1e-a3ee-efc890c02f59, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" 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_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:28,521 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2c997daf-2923-4e1e-a3ee-efc890c02f59, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:28,857 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:28,858 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 957552, 'BlobCount': 384}}
2025-11-01 16:20:28,858 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:28,859 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 36e00a95-5e09-42e1-9c20-011732667fee, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:28,879 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 36e00a95-5e09-42e1-9c20-011732667fee, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:28,881 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 36e00a95-5e09-42e1-9c20-011732667fee, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:29,955 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:29,956 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:29,956 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7b279549-62a6-4e1b-bc92-8c2809e41373, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:29,957 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7b279549-62a6-4e1b-bc92-8c2809e41373, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:29,966 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7b279549-62a6-4e1b-bc92-8c2809e41373, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:30,318 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:30,319 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:30,319 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 94105b47-3bbe-4fe0-b536-a70bd318e931, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:30,320 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 94105b47-3bbe-4fe0-b536-a70bd318e931, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" 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_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:30,321 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 94105b47-3bbe-4fe0-b536-a70bd318e931, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:30,770 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:30,771 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1277056, 'BlobCount': 512}}
2025-11-01 16:20:30,771 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:30,772 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f1d5e423-602f-44e0-a226-828948890b57, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:30,772 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f1d5e423-602f-44e0-a226-828948890b57, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:30,774 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f1d5e423-602f-44e0-a226-828948890b57, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:32,106 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:32,107 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:32,107 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1fd4f8be-6751-4fd4-a0ec-f20d9216d681, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:32,108 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1fd4f8be-6751-4fd4-a0ec-f20d9216d681, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:32,109 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1fd4f8be-6751-4fd4-a0ec-f20d9216d681, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:32,469 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:32,470 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:32,470 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d596bbb2-f5a9-4d57-94c6-0f8fdba5250c, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:32,471 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d596bbb2-f5a9-4d57-94c6-0f8fdba5250c, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" 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_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:32,475 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d596bbb2-f5a9-4d57-94c6-0f8fdba5250c, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:32,919 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:32,920 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1596256, 'BlobCount': 640}}
2025-11-01 16:20:32,920 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:32,921 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 711b6149-d652-4885-8edc-c2bbecc2054d, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:32,922 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 711b6149-d652-4885-8edc-c2bbecc2054d, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:32,923 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 711b6149-d652-4885-8edc-c2bbecc2054d, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:34,144 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:34,144 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:34,145 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3b53103c-ce7d-4562-8e4a-6f196e9fd9aa, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:34,146 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3b53103c-ce7d-4562-8e4a-6f196e9fd9aa, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:34,147 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3b53103c-ce7d-4562-8e4a-6f196e9fd9aa, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:34,455 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:34,456 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:34,457 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1538df92-3791-4d83-8dd3-3a1ff980834e, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:34,458 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1538df92-3791-4d83-8dd3-3a1ff980834e, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" 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_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:34,459 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1538df92-3791-4d83-8dd3-3a1ff980834e, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:35,073 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:35,074 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1915600, 'BlobCount': 768}}
2025-11-01 16:20:35,074 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:35,075 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 526b5922-98c9-40eb-a55f-0ef6796896bd, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:35,076 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 526b5922-98c9-40eb-a55f-0ef6796896bd, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:35,077 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 526b5922-98c9-40eb-a55f-0ef6796896bd, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:36,299 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:36,300 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:36,301 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, dd6f4036-d33f-4ae7-87f2-6bdd0433706b, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:36,301 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, dd6f4036-d33f-4ae7-87f2-6bdd0433706b, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:36,303 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, dd6f4036-d33f-4ae7-87f2-6bdd0433706b, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:36,568 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:36,568 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:36,569 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 20f7fe42-c1f7-452a-9618-281399b25711, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:36,569 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 20f7fe42-c1f7-452a-9618-281399b25711, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" 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_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:36,571 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 20f7fe42-c1f7-452a-9618-281399b25711, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:37,234 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:37,235 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2234896, 'BlobCount': 896}}
2025-11-01 16:20:37,235 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:37,235 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c14526d2-ef18-4634-b5ee-1d2eec3c5c4c, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:37,236 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c14526d2-ef18-4634-b5ee-1d2eec3c5c4c, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:37,238 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c14526d2-ef18-4634-b5ee-1d2eec3c5c4c, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:38,543 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:38,543 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:38,544 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d5161982-90d6-4240-b500-b7c07eee6030, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:38,545 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d5161982-90d6-4240-b500-b7c07eee6030, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:38,546 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d5161982-90d6-4240-b500-b7c07eee6030, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:38,900 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:38,900 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:38,901 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4c9d5992-3e46-4ed1-8144-83339e06d35b, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:38,902 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4c9d5992-3e46-4ed1-8144-83339e06d35b, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" 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_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:38,903 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4c9d5992-3e46-4ed1-8144-83339e06d35b, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:39,574 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:39,574 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2554464, 'BlobCount': 1024}}
2025-11-01 16:20:39,575 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:39,575 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0f6015fa-f71c-4e1c-9471-332e36803560, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:39,576 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0f6015fa-f71c-4e1c-9471-332e36803560, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:39,578 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0f6015fa-f71c-4e1c-9471-332e36803560, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:41,025 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:41,025 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:41,026 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f61b7bba-b87c-4802-b35b-27406164b6b2, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:41,027 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f61b7bba-b87c-4802-b35b-27406164b6b2, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:41,028 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f61b7bba-b87c-4802-b35b-27406164b6b2, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:41,362 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:41,363 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:41,364 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3988d763-944f-4350-a545-b3ae355e7188, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:41,365 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3988d763-944f-4350-a545-b3ae355e7188, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" 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_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:41,366 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3988d763-944f-4350-a545-b3ae355e7188, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:42,086 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:42,086 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2873568, 'BlobCount': 1152}}
2025-11-01 16:20:42,087 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:42,087 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 84448677-d4fd-4d16-b803-27e3bf1d7dea, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:42,088 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 84448677-d4fd-4d16-b803-27e3bf1d7dea, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:42,089 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 84448677-d4fd-4d16-b803-27e3bf1d7dea, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:43,398 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:43,399 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:43,399 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 57c7ce0c-9277-49da-a60a-b11b471f46f7, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:43,400 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 57c7ce0c-9277-49da-a60a-b11b471f46f7, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:43,402 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 57c7ce0c-9277-49da-a60a-b11b471f46f7, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:43,709 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:43,710 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:43,710 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 32a16a76-36d6-4d2a-b8a6-42188f37eb30, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:43,711 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 32a16a76-36d6-4d2a-b8a6-42188f37eb30, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" 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_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:43,713 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 32a16a76-36d6-4d2a-b8a6-42188f37eb30, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:44,458 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:44,459 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3193216, 'BlobCount': 1280}}
2025-11-01 16:20:44,459 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:44,460 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c0c3db8c-35ed-49c6-891a-897a0dd30049, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:44,461 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c0c3db8c-35ed-49c6-891a-897a0dd30049, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:44,462 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c0c3db8c-35ed-49c6-891a-897a0dd30049, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:45,853 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:45,854 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:45,855 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5c76fff1-310e-4f4c-a893-1f16467ba16f, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:45,855 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5c76fff1-310e-4f4c-a893-1f16467ba16f, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:45,859 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5c76fff1-310e-4f4c-a893-1f16467ba16f, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:46,253 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:46,254 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:46,255 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a4a7a86a-5522-42eb-8da5-df741278fdf0, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:46,256 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a4a7a86a-5522-42eb-8da5-df741278fdf0, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:46,260 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a4a7a86a-5522-42eb-8da5-df741278fdf0, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:46,677 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:46,678 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:20:46,679 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0720d767-8078-4486-b2f3-01c39ff4f7fa, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:20:46,680 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0720d767-8078-4486-b2f3-01c39ff4f7fa, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:46,686 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0720d767-8078-4486-b2f3-01c39ff4f7fa, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:51,046 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:21:01,089 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:21:01,089 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2cd3744b-3059-4c4d-9341-feed5def11ee, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:21:01,090 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2cd3744b-3059-4c4d-9341-feed5def11ee, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:21:01,091 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2cd3744b-3059-4c4d-9341-feed5def11ee, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:05,409 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:21:05,448 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_compression`, volumes `value` (8000000, 1596608)
2025-11-01 16:21:05,449 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:21:05,450 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9144fd44-5971-41f1-8448-6182acb2450f, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:21:05,450 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9144fd44-5971-41f1-8448-6182acb2450f, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:21:05,452 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9144fd44-5971-41f1-8448-6182acb2450f, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:05,807 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 16:21:05,808 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 16:21:05,818 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:21:05,819 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:21:05,820 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 325a2eea-a951-49c3-ae6c-293cca230a30, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:21:05,821 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 325a2eea-a951-49c3-ae6c-293cca230a30, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:21:05,822 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 325a2eea-a951-49c3-ae6c-293cca230a30, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:05,825 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-01 16:21:05,826 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 02089667-3d81-4579-963f-929ff105e024, localhost:19493): creating call state
2025-11-01 16:21:05,826 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 02089667-3d81-4579-963f-929ff105e024, localhost:19493): request = { database: "/Root" }
2025-11-01 16:21:05,834 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 02089667-3d81-4579-963f-929ff105e024, localhost:19493): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-cjocww3of4.auto.internal" port: 19493 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-11-01 16:21:05,835 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-cjocww3of4.auto.internal:19493, location 1, ssl: False>]>
2025-11-01 16:21:05,836 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:19493
2025-11-01 16:21:08,848 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:21:18,895 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:21:18,895 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 16ae3afb-4ee6-4455-b68a-ca39251455f7, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:21:18,896 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 16ae3afb-4ee6-4455-b68a-ca39251455f7, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:21:18,898 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 16ae3afb-4ee6-4455-b68a-ca39251455f7, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:21,787 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:21:31,807 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:21:31,809 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5942f741-934a-41f3-87c4-4ba638b205cc, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:21:31,809 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5942f741-934a-41f3-87c4-4ba638b205cc, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:21:31,811 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5942f741-934a-41f3-87c4-4ba638b205cc, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:32,549 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:21:42,553 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:21:42,554 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3a22b907-0521-4d06-9b51-0b862f3535cb, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:21:42,555 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3a22b907-0521-4d06-9b51-0b862f3535cb, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:21:42,556 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3a22b907-0521-4d06-9b51-0b862f3535cb, ghrun-cjocww3of4.auto.internal:19493): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:43,371 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=
2025-11-01 16:21:43,374 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_compression`, volumes `value` (8000000, 1465272)
2025-11-01 16:21:43,375 - INFO - root - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_compression` 8092160 / 1465272: 5.522633340430992
2025-11-01 16:21:43,377 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-11-01 16:21:43,378 - DEBUG - ydb.connection - _prepare_call: RpcState(DeleteSession, 57eb0b35-9794-4cec-8daa-95db18a0dea4, ghrun-cjocww3of4.auto.internal:19493): creating call state
2025-11-01 16:21:43,379 - DEBUG - ydb.connection - _log_request: RpcState(DeleteSession, 57eb0b35-9794-4cec-8daa-95db18a0dea4, ghrun-cjocww3of4.auto.internal:19493): request = { session_id: "ydb://session/3?node_id=1&id=YTJhNWIyNGYtM2YzYWVmMjQtYmRiZGIxMTItYzFlMDFiMTU=" }
2025-11-01 16:21:43,388 - DEBUG - ydb.connection - _log_response: RpcState(DeleteSession, 57eb0b35-9794-4cec-8daa-95db18a0dea4, ghrun-cjocww3of4.auto.internal:19493): response = { status: SUCCESS }
2025-11-01 16:21:43,389 - DEBUG - ydb.query.pool - stop: All session were deleted.
2025-11-01 16:21:43,390 - DEBUG - ydb.topic - close: Close topic client
2025-11-01 16:21:43,390 - DEBUG - ydb.topic - close: Topic client was closed
2025-11-01 16:21:43,390 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:19493
2025-11-01 16:21:43,391 - DEBUG - ydb.connection - _rpc_error_handler: RpcState(AttachSession, 2d8fd972-fc68-4699-b063-6c8c8d0e962a, ghrun-cjocww3of4.auto.internal:19493): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.CANCELLED
	details = "Locally cancelled by application!"
	debug_error_string = "None"
>
2025-11-01 16:21:43,393 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-cjocww3of4.auto.internal:19493
2025-11-01 16:21:43,400 - INFO - ydb.pool.Discovery - run: Successfully terminated discovery process
2025-11-01 16:21:50,421 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:19493/1
2025-11-01 16:21:50,422 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/9473
2025-11-01 16:21:50,422 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/63286
2025-11-01 16:21:50,423 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/24309
2025-11-01 16:21:50,423 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/19493
2025-11-01 16:21:50,423 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/5019
