2025-11-01 16:19:07,900 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 16:19:07,901 - INFO - ya.test - pytest_runtest_setup: test_all_supported_compression[zstd_8_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 8]
2025-11-01 16:19:07,901 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 16:19:07,901 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-01 16:19:07,910 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-11-01 16:19:07,911 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-11-01 16:19:07,911 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/y72z/0024e7/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 16:19:07,917 - DEBUG - ya.test - execute: Command pid: 517649
2025-11-01 16:19:08,595 - DEBUG - ya.test - _save_outputs: Command (pid 517649) rc: 0
2025-11-01 16:19:08,596 - DEBUG - ya.test - _save_outputs: Command (pid 517649) elapsed time (sec): 0.6772503852844238
2025-11-01 16:19:08,596 - DEBUG - ya.test - _save_outputs: Command (pid 517649) idrss: 0
2025-11-01 16:19:08,597 - DEBUG - ya.test - _save_outputs: Command (pid 517649) inblock: 0
2025-11-01 16:19:08,597 - DEBUG - ya.test - _save_outputs: Command (pid 517649) isrss: 0
2025-11-01 16:19:08,597 - DEBUG - ya.test - _save_outputs: Command (pid 517649) ixrss: 0
2025-11-01 16:19:08,597 - DEBUG - ya.test - _save_outputs: Command (pid 517649) majflt: 0
2025-11-01 16:19:08,598 - DEBUG - ya.test - _save_outputs: Command (pid 517649) maxrss: 492940
2025-11-01 16:19:08,598 - DEBUG - ya.test - _save_outputs: Command (pid 517649) minflt: 45399
2025-11-01 16:19:08,598 - DEBUG - ya.test - _save_outputs: Command (pid 517649) msgrcv: 0
2025-11-01 16:19:08,598 - DEBUG - ya.test - _save_outputs: Command (pid 517649) msgsnd: 0
2025-11-01 16:19:08,599 - DEBUG - ya.test - _save_outputs: Command (pid 517649) nivcsw: 113
2025-11-01 16:19:08,599 - DEBUG - ya.test - _save_outputs: Command (pid 517649) nsignals: 0
2025-11-01 16:19:08,599 - DEBUG - ya.test - _save_outputs: Command (pid 517649) nswap: 0
2025-11-01 16:19:08,600 - DEBUG - ya.test - _save_outputs: Command (pid 517649) nvcsw: 14
2025-11-01 16:19:08,600 - DEBUG - ya.test - _save_outputs: Command (pid 517649) oublock: 8
2025-11-01 16:19:08,600 - DEBUG - ya.test - _save_outputs: Command (pid 517649) stime: 0.183629
2025-11-01 16:19:08,601 - DEBUG - ya.test - _save_outputs: Command (pid 517649) utime: 0.43437499999999996
2025-11-01 16:19:08,601 - DEBUG - ya.test - _save_outputs: Command (pid 517649) wtime: 0.683
2025-11-01 16:19:08,601 - DEBUG - ya.test - _save_outputs: Command (pid 517649) 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:08,602 - DEBUG - ya.test - _save_outputs: Command (pid 517649) errors:

2025-11-01 16:19:08,602 - 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:08,699 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/y72z/0024e7/ydb/apps/ydbd/ydbd
2025-11-01 16:19:08,700 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/61055
2025-11-01 16:19:08,702 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/y72z/0024e7/r3tmp/kikimr_cluster_67s7_w9j
2025-11-01 16:19:08,738 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/y72z/0024e7/ydb/apps/ydbd/ydbd
2025-11-01 16:19:08,738 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/1995
2025-11-01 16:19:08,739 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/18549
2025-11-01 16:19:08,739 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/25596
2025-11-01 16:19:08,740 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/26048
2025-11-01 16:19:08,741 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/y72z/0024e7/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/kikimr_configs"
2025-11-01 16:19:08,742 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/y72z/0024e7/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/0024e7/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/node_1/logfile_hdtzudzd.log --grpc-port=1995 --mon-port=18549 --ic-port=61055
2025-11-01 16:19:08,742 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:1995/1, disk_size 68719476736
2025-11-01 16:19:08,743 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/y72z/0024e7/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/kikimr_configs"
2025-11-01 16:19:08,743 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/y72z/0024e7/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/0024e7/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/node_1/logfile_hdtzudzd.log --grpc-port=1995 --mon-port=18549 --ic-port=61055
2025-11-01 16:19:08,744 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/y72z/0024e7/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/y72z/0024e7/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/y72z/0024e7/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/node_1/logfile_hdtzudzd.log', '--grpc-port=1995', '--mon-port=18549', '--ic-port=61055')' in '/home/runner/.ya/build/build_root/y72z/0024e7/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/node_1' (no wait)
2025-11-01 16:19:08,749 - DEBUG - ya.test - execute: Command pid: 518217
2025-11-01 16:19:08,749 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:1995/1
2025-11-01 16:19:08,751 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-11-01 16:19:08,752 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-11-01 16:19:08,752 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/y72z/0024e7/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 16:19:08,754 - DEBUG - ya.test - execute: Command pid: 518220
2025-11-01 16:19:09,513 - DEBUG - ya.test - _save_outputs: Command (pid 518220) rc: 0
2025-11-01 16:19:09,513 - DEBUG - ya.test - _save_outputs: Command (pid 518220) elapsed time (sec): 0.758455753326416
2025-11-01 16:19:09,514 - DEBUG - ya.test - _save_outputs: Command (pid 518220) idrss: 0
2025-11-01 16:19:09,514 - DEBUG - ya.test - _save_outputs: Command (pid 518220) inblock: 0
2025-11-01 16:19:09,514 - DEBUG - ya.test - _save_outputs: Command (pid 518220) isrss: 0
2025-11-01 16:19:09,514 - DEBUG - ya.test - _save_outputs: Command (pid 518220) ixrss: 0
2025-11-01 16:19:09,515 - DEBUG - ya.test - _save_outputs: Command (pid 518220) majflt: 0
2025-11-01 16:19:09,515 - DEBUG - ya.test - _save_outputs: Command (pid 518220) maxrss: 501800
2025-11-01 16:19:09,515 - DEBUG - ya.test - _save_outputs: Command (pid 518220) minflt: 45398
2025-11-01 16:19:09,515 - DEBUG - ya.test - _save_outputs: Command (pid 518220) msgrcv: 0
2025-11-01 16:19:09,516 - DEBUG - ya.test - _save_outputs: Command (pid 518220) msgsnd: 0
2025-11-01 16:19:09,516 - DEBUG - ya.test - _save_outputs: Command (pid 518220) nivcsw: 119
2025-11-01 16:19:09,516 - DEBUG - ya.test - _save_outputs: Command (pid 518220) nsignals: 0
2025-11-01 16:19:09,516 - DEBUG - ya.test - _save_outputs: Command (pid 518220) nswap: 0
2025-11-01 16:19:09,517 - DEBUG - ya.test - _save_outputs: Command (pid 518220) nvcsw: 14
2025-11-01 16:19:09,517 - DEBUG - ya.test - _save_outputs: Command (pid 518220) oublock: 8
2025-11-01 16:19:09,517 - DEBUG - ya.test - _save_outputs: Command (pid 518220) stime: 0.19714099999999998
2025-11-01 16:19:09,517 - DEBUG - ya.test - _save_outputs: Command (pid 518220) utime: 0.48236199999999996
2025-11-01 16:19:09,518 - DEBUG - ya.test - _save_outputs: Command (pid 518220) wtime: 0.76
2025-11-01 16:19:09,518 - DEBUG - ya.test - _save_outputs: Command (pid 518220) 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:09,518 - DEBUG - ya.test - _save_outputs: Command (pid 518220) errors:

2025-11-01 16:19:09,519 - 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:14,365 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/y72z/0024e7/ydb/apps/ydbd/ydbd
2025-11-01 16:19:14,365 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/y72z/0024e7/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:1995', '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: 61055\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-01 16:19:14,367 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-11-01 16:19:14,367 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-11-01 16:19:14,368 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/y72z/0024e7/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:1995', '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: 61055\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-01 16:19:14,370 - DEBUG - ya.test - execute: Command pid: 521013
2025-11-01 16:19:15,584 - DEBUG - ya.test - _save_outputs: Command (pid 521013) rc: 0
2025-11-01 16:19:15,585 - DEBUG - ya.test - _save_outputs: Command (pid 521013) elapsed time (sec): 1.2137556076049805
2025-11-01 16:19:15,585 - DEBUG - ya.test - _save_outputs: Command (pid 521013) idrss: 0
2025-11-01 16:19:15,585 - DEBUG - ya.test - _save_outputs: Command (pid 521013) inblock: 0
2025-11-01 16:19:15,586 - DEBUG - ya.test - _save_outputs: Command (pid 521013) isrss: 0
2025-11-01 16:19:15,586 - DEBUG - ya.test - _save_outputs: Command (pid 521013) ixrss: 0
2025-11-01 16:19:15,586 - DEBUG - ya.test - _save_outputs: Command (pid 521013) majflt: 0
2025-11-01 16:19:15,586 - DEBUG - ya.test - _save_outputs: Command (pid 521013) maxrss: 589796
2025-11-01 16:19:15,586 - DEBUG - ya.test - _save_outputs: Command (pid 521013) minflt: 51503
2025-11-01 16:19:15,587 - DEBUG - ya.test - _save_outputs: Command (pid 521013) msgrcv: 0
2025-11-01 16:19:15,587 - DEBUG - ya.test - _save_outputs: Command (pid 521013) msgsnd: 0
2025-11-01 16:19:15,587 - DEBUG - ya.test - _save_outputs: Command (pid 521013) nivcsw: 195
2025-11-01 16:19:15,587 - DEBUG - ya.test - _save_outputs: Command (pid 521013) nsignals: 0
2025-11-01 16:19:15,588 - DEBUG - ya.test - _save_outputs: Command (pid 521013) nswap: 0
2025-11-01 16:19:15,588 - DEBUG - ya.test - _save_outputs: Command (pid 521013) nvcsw: 347
2025-11-01 16:19:15,588 - DEBUG - ya.test - _save_outputs: Command (pid 521013) oublock: 8
2025-11-01 16:19:15,589 - DEBUG - ya.test - _save_outputs: Command (pid 521013) stime: 0.332817
2025-11-01 16:19:15,589 - DEBUG - ya.test - _save_outputs: Command (pid 521013) utime: 0.564322
2025-11-01 16:19:15,589 - DEBUG - ya.test - _save_outputs: Command (pid 521013) wtime: 1.216
2025-11-01 16:19:15,590 - DEBUG - ya.test - _save_outputs: Command (pid 521013) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-01 16:19:15,590 - DEBUG - ya.test - _save_outputs: Command (pid 521013) errors:

2025-11-01 16:19:15,591 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/y72z/0024e7/ydb/apps/ydbd/ydbd
2025-11-01 16:19:15,592 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/y72z/0024e7/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:1995', '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:15,593 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-11-01 16:19:15,594 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-11-01 16:19:15,594 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/y72z/0024e7/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:1995', '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:15,596 - DEBUG - ya.test - execute: Command pid: 521590
2025-11-01 16:19:16,699 - DEBUG - ya.test - _save_outputs: Command (pid 521590) rc: 0
2025-11-01 16:19:16,700 - DEBUG - ya.test - _save_outputs: Command (pid 521590) elapsed time (sec): 1.1021811962127686
2025-11-01 16:19:16,700 - DEBUG - ya.test - _save_outputs: Command (pid 521590) idrss: 0
2025-11-01 16:19:16,700 - DEBUG - ya.test - _save_outputs: Command (pid 521590) inblock: 0
2025-11-01 16:19:16,701 - DEBUG - ya.test - _save_outputs: Command (pid 521590) isrss: 0
2025-11-01 16:19:16,701 - DEBUG - ya.test - _save_outputs: Command (pid 521590) ixrss: 0
2025-11-01 16:19:16,701 - DEBUG - ya.test - _save_outputs: Command (pid 521590) majflt: 0
2025-11-01 16:19:16,701 - DEBUG - ya.test - _save_outputs: Command (pid 521590) maxrss: 589796
2025-11-01 16:19:16,702 - DEBUG - ya.test - _save_outputs: Command (pid 521590) minflt: 51665
2025-11-01 16:19:16,702 - DEBUG - ya.test - _save_outputs: Command (pid 521590) msgrcv: 0
2025-11-01 16:19:16,702 - DEBUG - ya.test - _save_outputs: Command (pid 521590) msgsnd: 0
2025-11-01 16:19:16,702 - DEBUG - ya.test - _save_outputs: Command (pid 521590) nivcsw: 148
2025-11-01 16:19:16,702 - DEBUG - ya.test - _save_outputs: Command (pid 521590) nsignals: 0
2025-11-01 16:19:16,703 - DEBUG - ya.test - _save_outputs: Command (pid 521590) nswap: 0
2025-11-01 16:19:16,703 - DEBUG - ya.test - _save_outputs: Command (pid 521590) nvcsw: 677
2025-11-01 16:19:16,703 - DEBUG - ya.test - _save_outputs: Command (pid 521590) oublock: 8
2025-11-01 16:19:16,703 - DEBUG - ya.test - _save_outputs: Command (pid 521590) stime: 0.2042
2025-11-01 16:19:16,704 - DEBUG - ya.test - _save_outputs: Command (pid 521590) utime: 0.499716
2025-11-01 16:19:16,704 - DEBUG - ya.test - _save_outputs: Command (pid 521590) wtime: 1.104
2025-11-01 16:19:16,704 - DEBUG - ya.test - _save_outputs: Command (pid 521590) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-11-01 16:19:16,705 - DEBUG - ya.test - _save_outputs: Command (pid 521590) errors:

2025-11-01 16:19:16,705 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-01 16:19:16,936 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-11-01 16:19:16,975 - 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:16,978 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 16:19:16,979 - 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:17,011 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-01 16:19:17,012 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 4496eda9-d709-40f3-b78e-2b8863173458, localhost:1995): creating call state
2025-11-01 16:19:17,013 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 4496eda9-d709-40f3-b78e-2b8863173458, localhost:1995): request = { database: "/Root" }
2025-11-01 16:19:17,056 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 4496eda9-d709-40f3-b78e-2b8863173458, localhost:1995): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-cjocww3of4.auto.internal" port: 1995 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:17,058 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-cjocww3of4.auto.internal:1995, location 1, ssl: False>]>
2025-11-01 16:19:17,058 - 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:17,077 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:1995
2025-11-01 16:19:17,081 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 16:19:17,082 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, a8e93074-a055-4471-8403-b7868b3d2aa3, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:17,083 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, a8e93074-a055-4471-8403-b7868b3d2aa3, ghrun-cjocww3of4.auto.internal:1995): request = {  }
2025-11-01 16:19:17,093 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, a8e93074-a055-4471-8403-b7868b3d2aa3, ghrun-cjocww3of4.auto.internal:1995): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" node_id: 1 }
2025-11-01 16:19:17,094 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, 1209728d-53da-497d-b0db-297236b4e0b9, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:17,094 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, 1209728d-53da-497d-b0db-297236b4e0b9, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" }
2025-11-01 16:19:17,101 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, 1209728d-53da-497d-b0db-297236b4e0b9, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:17,111 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:17,112 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f5991e3d-b999-4611-bb0f-2015c7300cfc, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:17,113 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f5991e3d-b999-4611-bb0f-2015c7300cfc, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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:17,114 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f5991e3d-b999-4611-bb0f-2015c7300cfc, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:19,576 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:19,577 - INFO - __tests__.alter_compression - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-11-01 16:19:19,578 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:19,579 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3a8aaeb4-1b84-4f0a-b902-087db3038ca3, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:19,580 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3a8aaeb4-1b84-4f0a-b902-087db3038ca3, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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:19,581 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3a8aaeb4-1b84-4f0a-b902-087db3038ca3, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:20,402 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:20,403 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:20,404 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7823c042-b92c-4f7c-a357-b90fdced3927, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:20,405 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7823c042-b92c-4f7c-a357-b90fdced3927, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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:20,406 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7823c042-b92c-4f7c-a357-b90fdced3927, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:21,429 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:21,430 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:21,430 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b2225e55-0a95-4787-b41d-85482ed1f237, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:21,431 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b2225e55-0a95-4787-b41d-85482ed1f237, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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:21,432 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b2225e55-0a95-4787-b41d-85482ed1f237, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:22,165 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:22,166 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:22,167 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, eb33e7e8-80a5-42e9-9e8e-ed1dfa7e7941, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:22,168 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, eb33e7e8-80a5-42e9-9e8e-ed1dfa7e7941, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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,169 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, eb33e7e8-80a5-42e9-9e8e-ed1dfa7e7941, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:23,729 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:23,730 - 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:23,730 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:23,731 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 73afd036-8d68-416c-a9ef-04e22a3285c2, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:23,732 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 73afd036-8d68-416c-a9ef-04e22a3285c2, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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:23,734 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 73afd036-8d68-416c-a9ef-04e22a3285c2, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:24,713 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:24,714 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:24,715 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, cc973378-1bf7-4825-9cea-288cb1a47397, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:24,716 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, cc973378-1bf7-4825-9cea-288cb1a47397, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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,719 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, cc973378-1bf7-4825-9cea-288cb1a47397, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:24,923 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:24,924 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:24,925 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 542945f9-aeac-4753-bfcd-bfd00d1609c8, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:24,926 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 542945f9-aeac-4753-bfcd-bfd00d1609c8, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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,927 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 542945f9-aeac-4753-bfcd-bfd00d1609c8, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:25,265 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:25,266 - 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:25,266 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:25,267 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e0cbd951-421b-444a-9018-0925280ea4d7, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:25,268 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e0cbd951-421b-444a-9018-0925280ea4d7, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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:25,270 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e0cbd951-421b-444a-9018-0925280ea4d7, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:26,276 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:26,277 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:26,277 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ae001ba4-d9a8-4630-95eb-e020ab698f05, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:26,278 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ae001ba4-d9a8-4630-95eb-e020ab698f05, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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:26,279 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ae001ba4-d9a8-4630-95eb-e020ab698f05, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:26,509 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:26,510 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:26,510 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, abc30fff-8502-44fb-b372-2cc3f1d1b5c1, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:26,511 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, abc30fff-8502-44fb-b372-2cc3f1d1b5c1, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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:26,512 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, abc30fff-8502-44fb-b372-2cc3f1d1b5c1, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:26,847 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:26,848 - 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:26,849 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:26,849 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 285cc280-a459-47cc-b0b6-83b02c03d58e, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:26,850 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 285cc280-a459-47cc-b0b6-83b02c03d58e, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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:26,853 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 285cc280-a459-47cc-b0b6-83b02c03d58e, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:27,830 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:27,831 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:27,837 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6cdadc77-126c-462d-a1a5-493a3b3f9d48, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:27,838 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6cdadc77-126c-462d-a1a5-493a3b3f9d48, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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,839 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6cdadc77-126c-462d-a1a5-493a3b3f9d48, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:28,076 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:28,077 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:28,077 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 29354196-3385-4c9c-8474-35917afd643d, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:28,078 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 29354196-3385-4c9c-8474-35917afd643d, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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:28,079 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 29354196-3385-4c9c-8474-35917afd643d, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:28,468 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:28,468 - 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:28,469 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:28,470 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 510a657c-8107-4c07-80bb-14dd958e1f49, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:28,471 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 510a657c-8107-4c07-80bb-14dd958e1f49, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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:28,479 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 510a657c-8107-4c07-80bb-14dd958e1f49, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:29,369 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:29,370 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:29,370 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b6359f30-e85b-480f-bdc6-87f866fc9feb, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:29,371 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b6359f30-e85b-480f-bdc6-87f866fc9feb, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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,377 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b6359f30-e85b-480f-bdc6-87f866fc9feb, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:29,648 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:29,649 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:29,649 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f3dded3f-c858-4792-85bf-fae3560e2349, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:29,650 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f3dded3f-c858-4792-85bf-fae3560e2349, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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,651 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f3dded3f-c858-4792-85bf-fae3560e2349, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:30,146 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:30,147 - 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:30,148 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:30,148 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 31fcba4d-4e4f-449f-b170-810108028f21, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:30,156 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 31fcba4d-4e4f-449f-b170-810108028f21, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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:30,157 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 31fcba4d-4e4f-449f-b170-810108028f21, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:31,197 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:31,197 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:31,198 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 068216c4-d1fe-42c1-b8ca-7fea74cb50f5, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:31,199 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 068216c4-d1fe-42c1-b8ca-7fea74cb50f5, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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,200 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 068216c4-d1fe-42c1-b8ca-7fea74cb50f5, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:31,521 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:31,522 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:31,522 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4e9f33a4-0193-4e70-876b-ae9b2ddf83f1, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:31,523 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4e9f33a4-0193-4e70-876b-ae9b2ddf83f1, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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,526 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4e9f33a4-0193-4e70-876b-ae9b2ddf83f1, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:31,988 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:31,989 - 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:31,989 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:31,990 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a0091f52-d78d-410c-903d-e17e7e0e28bd, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:31,990 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a0091f52-d78d-410c-903d-e17e7e0e28bd, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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:31,993 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a0091f52-d78d-410c-903d-e17e7e0e28bd, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:32,903 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:32,903 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:32,904 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 434bcf64-34c2-4d30-b633-e4acdefc5fdd, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:32,905 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 434bcf64-34c2-4d30-b633-e4acdefc5fdd, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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:32,906 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 434bcf64-34c2-4d30-b633-e4acdefc5fdd, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:33,157 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:33,158 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:33,158 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8bae4b50-a041-42f3-aa0d-aec582f0b749, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:33,159 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8bae4b50-a041-42f3-aa0d-aec582f0b749, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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,161 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8bae4b50-a041-42f3-aa0d-aec582f0b749, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:33,582 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:33,583 - 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:33,583 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:33,584 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e9de9878-2c91-45da-b5da-6c3343c8069d, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:33,584 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e9de9878-2c91-45da-b5da-6c3343c8069d, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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:33,586 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e9de9878-2c91-45da-b5da-6c3343c8069d, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:34,515 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:34,516 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:34,516 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5f5cc9c5-8032-4f95-bcbb-71071186822f, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:34,517 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5f5cc9c5-8032-4f95-bcbb-71071186822f, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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,518 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5f5cc9c5-8032-4f95-bcbb-71071186822f, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:34,770 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:34,771 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:34,771 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2a4f3c38-c169-4438-b4cf-eec2681f1df5, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:34,772 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2a4f3c38-c169-4438-b4cf-eec2681f1df5, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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:34,773 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2a4f3c38-c169-4438-b4cf-eec2681f1df5, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:35,393 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:35,394 - 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:35,394 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:35,395 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 11e387d3-1cbf-4d6c-b683-fe8b2303a417, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:35,395 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 11e387d3-1cbf-4d6c-b683-fe8b2303a417, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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:35,397 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 11e387d3-1cbf-4d6c-b683-fe8b2303a417, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:36,572 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:36,572 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:36,573 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 120009ed-81e8-446b-b938-57216d172c6a, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:36,574 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 120009ed-81e8-446b-b938-57216d172c6a, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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:36,575 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 120009ed-81e8-446b-b938-57216d172c6a, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:36,902 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:36,902 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:36,903 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 77952f2b-a851-4616-99cc-f085c68df22f, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:36,904 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 77952f2b-a851-4616-99cc-f085c68df22f, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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:36,905 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 77952f2b-a851-4616-99cc-f085c68df22f, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:37,518 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:37,518 - 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:37,518 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:37,519 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, bdaf5bed-52fe-4cc3-8fe4-193053e249c8, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:37,519 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, bdaf5bed-52fe-4cc3-8fe4-193053e249c8, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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:37,521 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, bdaf5bed-52fe-4cc3-8fe4-193053e249c8, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:38,533 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:38,534 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:38,534 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8d5e5adc-e68e-4b39-91d2-e4d186b3e486, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:38,535 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8d5e5adc-e68e-4b39-91d2-e4d186b3e486, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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:38,538 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8d5e5adc-e68e-4b39-91d2-e4d186b3e486, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:38,770 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:38,770 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:38,771 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 18b95ae0-c07a-491b-9788-24c28deeb2ad, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:38,772 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 18b95ae0-c07a-491b-9788-24c28deeb2ad, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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:38,773 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 18b95ae0-c07a-491b-9788-24c28deeb2ad, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:39,380 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:39,381 - 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:39,381 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:39,382 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 52e1d83e-ffe8-4364-a8a4-4c9ab00d8c67, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:39,383 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 52e1d83e-ffe8-4364-a8a4-4c9ab00d8c67, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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:39,384 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 52e1d83e-ffe8-4364-a8a4-4c9ab00d8c67, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:40,401 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:40,402 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:40,402 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 12fcf484-9d90-4113-aa71-3637d3ece295, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:40,403 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 12fcf484-9d90-4113-aa71-3637d3ece295, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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:40,404 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 12fcf484-9d90-4113-aa71-3637d3ece295, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:40,657 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:40,658 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:40,659 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e613658d-d9cb-4af7-9f4c-9c34ce478dc8, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:40,660 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e613658d-d9cb-4af7-9f4c-9c34ce478dc8, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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:40,662 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e613658d-d9cb-4af7-9f4c-9c34ce478dc8, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:40,891 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:40,892 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:40,893 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 290f4870-233f-416f-9037-ad6d3e81c74d, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:40,894 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 290f4870-233f-416f-9037-ad6d3e81c74d, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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:40,895 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 290f4870-233f-416f-9037-ad6d3e81c74d, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:44,321 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:54,361 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:54,362 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 31f907c2-c909-4a49-9eeb-e363512809ad, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:54,363 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 31f907c2-c909-4a49-9eeb-e363512809ad, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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:54,364 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 31f907c2-c909-4a49-9eeb-e363512809ad, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:57,819 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:57,858 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-11-01 16:19:57,859 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:19:57,859 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f71466a9-5a27-4664-9285-740f2072b295, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:19:57,860 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f71466a9-5a27-4664-9285-740f2072b295, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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:57,862 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f71466a9-5a27-4664-9285-740f2072b295, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:01,226 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:11,281 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:11,282 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9e2d9077-9106-4488-80f6-7d6cb41b3d7c, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:11,282 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9e2d9077-9106-4488-80f6-7d6cb41b3d7c, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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:11,284 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9e2d9077-9106-4488-80f6-7d6cb41b3d7c, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:14,678 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:14,713 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-11-01 16:20:14,714 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:14,714 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 29632e3c-b2ee-4921-9527-d1e4d300b48f, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:14,715 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 29632e3c-b2ee-4921-9527-d1e4d300b48f, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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,717 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 29632e3c-b2ee-4921-9527-d1e4d300b48f, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:15,110 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:15,113 - INFO - ya.test - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_8_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 8])
2025-11-01 16:20:15,113 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:15,114 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2f2f5428-0141-4a27-88fd-99f39918f9fc, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:15,116 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2f2f5428-0141-4a27-88fd-99f39918f9fc, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_8_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 8)\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:15,118 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2f2f5428-0141-4a27-88fd-99f39918f9fc, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:18,532 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:18,532 - INFO - __tests__.alter_compression - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_8_compression created
2025-11-01 16:20:18,533 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:18,533 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7e48b814-b8da-4c8e-aa2f-c4fd7ddd76a2, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:18,534 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7e48b814-b8da-4c8e-aa2f-c4fd7ddd76a2, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_8_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:18,535 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7e48b814-b8da-4c8e-aa2f-c4fd7ddd76a2, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:20,017 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:20,018 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:20,019 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6eb061dd-32f3-4b72-ac05-22c719be76f2, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:20,020 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6eb061dd-32f3-4b72-ac05-22c719be76f2, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:20,021 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6eb061dd-32f3-4b72-ac05-22c719be76f2, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:22,178 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:22,179 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:22,180 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f583c05d-4e33-4755-a8c2-89d19d3bb254, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:22,181 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f583c05d-4e33-4755-a8c2-89d19d3bb254, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:22,182 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f583c05d-4e33-4755-a8c2-89d19d3bb254, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:23,181 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:23,182 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:23,183 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 99d41ea0-4b16-4652-a340-beaa8b5bbf24, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:23,183 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 99d41ea0-4b16-4652-a340-beaa8b5bbf24, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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_8_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:23,187 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 99d41ea0-4b16-4652-a340-beaa8b5bbf24, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:25,161 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:25,161 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318016, 'BlobCount': 128}}
2025-11-01 16:20:25,162 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:25,163 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d11dbb54-523e-49e7-8573-2f8ccbada11f, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:25,163 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d11dbb54-523e-49e7-8573-2f8ccbada11f, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:25,165 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d11dbb54-523e-49e7-8573-2f8ccbada11f, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:26,911 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:26,912 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:26,912 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, cdf4cf74-3b5d-460f-a3a1-7ca5978bf067, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:26,913 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, cdf4cf74-3b5d-460f-a3a1-7ca5978bf067, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:26,914 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, cdf4cf74-3b5d-460f-a3a1-7ca5978bf067, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:27,204 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:27,205 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:27,205 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, fef7c29f-0833-42e8-8583-e1caa8800fa2, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:27,206 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, fef7c29f-0833-42e8-8583-e1caa8800fa2, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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_8_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:27,208 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, fef7c29f-0833-42e8-8583-e1caa8800fa2, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:27,638 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:27,639 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 637312, 'BlobCount': 256}}
2025-11-01 16:20:27,639 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:27,640 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9e3adfc6-5166-4269-b261-c794d2b45357, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:27,640 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9e3adfc6-5166-4269-b261-c794d2b45357, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:27,641 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9e3adfc6-5166-4269-b261-c794d2b45357, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:29,393 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:29,393 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:29,394 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9bba4e7c-5278-4991-9ab0-bcac33fd7572, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:29,395 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9bba4e7c-5278-4991-9ab0-bcac33fd7572, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:29,396 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9bba4e7c-5278-4991-9ab0-bcac33fd7572, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:29,674 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:29,675 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:29,676 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, db72424c-4377-4f20-8dcf-e1916b27329f, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:29,677 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, db72424c-4377-4f20-8dcf-e1916b27329f, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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_8_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:29,678 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, db72424c-4377-4f20-8dcf-e1916b27329f, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:30,089 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:30,090 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 956352, 'BlobCount': 384}}
2025-11-01 16:20:30,090 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:30,091 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b04ad996-47b4-451a-bc74-57f3a997f1f2, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:30,092 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b04ad996-47b4-451a-bc74-57f3a997f1f2, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:30,093 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b04ad996-47b4-451a-bc74-57f3a997f1f2, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:31,874 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:31,875 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:31,876 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 63ae6059-6aae-453c-a468-dc587bbcfe26, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:31,876 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 63ae6059-6aae-453c-a468-dc587bbcfe26, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:31,882 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 63ae6059-6aae-453c-a468-dc587bbcfe26, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:32,208 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:32,209 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:32,209 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6ee2666a-4f55-46ca-a195-f4858329e042, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:32,210 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6ee2666a-4f55-46ca-a195-f4858329e042, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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_8_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,211 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6ee2666a-4f55-46ca-a195-f4858329e042, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:32,710 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:32,711 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1275712, 'BlobCount': 512}}
2025-11-01 16:20:32,711 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:32,712 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c3b039b5-b1c6-4895-ad26-784cf7982b49, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:32,713 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c3b039b5-b1c6-4895-ad26-784cf7982b49, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:32,714 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c3b039b5-b1c6-4895-ad26-784cf7982b49, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:34,552 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:34,552 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:34,553 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0b18bb8a-8690-4458-a5ca-3aebe7ed10ad, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:34,554 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0b18bb8a-8690-4458-a5ca-3aebe7ed10ad, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:34,555 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0b18bb8a-8690-4458-a5ca-3aebe7ed10ad, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:34,850 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:34,851 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:34,851 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1ae2c3d8-6606-4684-b5ab-a07885210b94, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:34,852 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1ae2c3d8-6606-4684-b5ab-a07885210b94, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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_8_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,853 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1ae2c3d8-6606-4684-b5ab-a07885210b94, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:35,295 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:35,296 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1594672, 'BlobCount': 640}}
2025-11-01 16:20:35,296 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:35,297 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c65e14c9-aeda-4271-9bcc-98efca68cd49, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:35,298 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c65e14c9-aeda-4271-9bcc-98efca68cd49, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:35,299 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c65e14c9-aeda-4271-9bcc-98efca68cd49, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:37,237 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:37,238 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:37,238 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5326737f-b0df-4b52-8cdb-4ca78713adb5, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:37,239 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5326737f-b0df-4b52-8cdb-4ca78713adb5, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:37,240 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5326737f-b0df-4b52-8cdb-4ca78713adb5, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:37,522 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:37,523 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:37,523 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 36e16bed-b971-4fec-afde-aff9c6de4f36, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:37,524 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 36e16bed-b971-4fec-afde-aff9c6de4f36, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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_8_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:37,525 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 36e16bed-b971-4fec-afde-aff9c6de4f36, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:38,121 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:38,122 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1913856, 'BlobCount': 768}}
2025-11-01 16:20:38,122 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:38,123 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 98dd7df8-9d03-43b6-bb15-9490cebd5f76, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:38,123 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 98dd7df8-9d03-43b6-bb15-9490cebd5f76, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:38,125 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 98dd7df8-9d03-43b6-bb15-9490cebd5f76, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:40,071 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:40,071 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:40,072 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 230c4b36-a080-4b22-9201-e4bf94ae640f, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:40,073 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 230c4b36-a080-4b22-9201-e4bf94ae640f, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:40,074 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 230c4b36-a080-4b22-9201-e4bf94ae640f, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:40,508 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:40,509 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:40,509 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b644b464-830b-4b43-a444-17621594535b, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:40,510 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b644b464-830b-4b43-a444-17621594535b, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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_8_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:40,511 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b644b464-830b-4b43-a444-17621594535b, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:41,234 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:41,235 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2232992, 'BlobCount': 896}}
2025-11-01 16:20:41,235 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:41,236 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ea94455a-5ef4-428d-a4b5-42b424d06ab5, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:41,237 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ea94455a-5ef4-428d-a4b5-42b424d06ab5, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:41,238 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ea94455a-5ef4-428d-a4b5-42b424d06ab5, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:43,226 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:43,227 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:43,228 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 36cc0711-f757-4202-9d09-689d696b7bfd, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:43,229 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 36cc0711-f757-4202-9d09-689d696b7bfd, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:43,230 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 36cc0711-f757-4202-9d09-689d696b7bfd, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:43,601 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:43,602 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:43,603 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a919d548-f765-4f9c-8c9b-a68f6a94aa69, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:43,604 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a919d548-f765-4f9c-8c9b-a68f6a94aa69, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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_8_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,609 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a919d548-f765-4f9c-8c9b-a68f6a94aa69, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:44,705 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:44,758 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2552480, 'BlobCount': 1024}}
2025-11-01 16:20:44,758 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:44,759 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a1b38cf2-017b-40bf-bb99-54e99bac833f, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:44,760 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a1b38cf2-017b-40bf-bb99-54e99bac833f, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:44,761 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a1b38cf2-017b-40bf-bb99-54e99bac833f, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:46,881 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:46,881 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:46,882 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1e43e965-ae7a-4929-a6a5-454abc341c75, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:46,883 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1e43e965-ae7a-4929-a6a5-454abc341c75, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:46,885 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1e43e965-ae7a-4929-a6a5-454abc341c75, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:47,198 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:47,199 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:47,200 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5d177b65-e5c5-4447-966e-b07767a06938, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:47,201 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5d177b65-e5c5-4447-966e-b07767a06938, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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_8_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:47,202 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5d177b65-e5c5-4447-966e-b07767a06938, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:47,850 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:47,851 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2871488, 'BlobCount': 1152}}
2025-11-01 16:20:47,851 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:47,852 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ec7ba783-dd20-44dc-8644-5b3bdb73169d, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:47,853 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ec7ba783-dd20-44dc-8644-5b3bdb73169d, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:47,862 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ec7ba783-dd20-44dc-8644-5b3bdb73169d, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:49,695 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:49,696 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:49,696 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8ade3c14-4ad3-46c1-88fc-9b1857b90070, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:49,697 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8ade3c14-4ad3-46c1-88fc-9b1857b90070, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:49,698 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8ade3c14-4ad3-46c1-88fc-9b1857b90070, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:50,077 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:50,078 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:50,079 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ccf3f157-1a0c-498f-be54-5c07a334f992, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:50,080 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ccf3f157-1a0c-498f-be54-5c07a334f992, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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_8_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:50,081 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ccf3f157-1a0c-498f-be54-5c07a334f992, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:50,946 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:50,947 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3190992, 'BlobCount': 1280}}
2025-11-01 16:20:50,947 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:50,948 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6fc1e7c8-29da-46c4-b5d5-3dc6063cb315, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:50,949 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6fc1e7c8-29da-46c4-b5d5-3dc6063cb315, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_8_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:50,950 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6fc1e7c8-29da-46c4-b5d5-3dc6063cb315, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:52,039 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:52,040 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:52,041 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4a822f24-71f8-4f02-93c7-cbc8e153b162, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:52,042 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4a822f24-71f8-4f02-93c7-cbc8e153b162, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:52,047 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4a822f24-71f8-4f02-93c7-cbc8e153b162, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:52,445 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:52,446 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:52,446 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6a9f1c93-831f-472a-9d4c-bcfd4c926d11, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:52,447 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6a9f1c93-831f-472a-9d4c-bcfd4c926d11, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:52,465 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6a9f1c93-831f-472a-9d4c-bcfd4c926d11, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:52,743 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:52,744 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:20:52,744 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6cc8175c-1fcd-42df-a8b9-378b3ef5b35a, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:20:52,745 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6cc8175c-1fcd-42df-a8b9-378b3ef5b35a, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:52,747 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6cc8175c-1fcd-42df-a8b9-378b3ef5b35a, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:53,894 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 16:20:53,895 - 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:20:53,908 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-01 16:20:53,909 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, ef5b40a0-6748-4e4b-8df8-46624983785e, localhost:1995): creating call state
2025-11-01 16:20:53,910 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, ef5b40a0-6748-4e4b-8df8-46624983785e, localhost:1995): request = { database: "/Root" }
2025-11-01 16:20:53,934 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, ef5b40a0-6748-4e4b-8df8-46624983785e, localhost:1995): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-cjocww3of4.auto.internal" port: 1995 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:20:53,935 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-cjocww3of4.auto.internal:1995, location 1, ssl: False>]>
2025-11-01 16:20:53,936 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:1995
2025-11-01 16:20:56,778 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:21:06,816 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:21:06,817 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c6865533-d0ff-4980-a4bc-ccbb42778a9a, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:21:06,818 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c6865533-d0ff-4980-a4bc-ccbb42778a9a, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:21:06,820 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c6865533-d0ff-4980-a4bc-ccbb42778a9a, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:10,160 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:21:10,196 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_8_compression`, volumes `value` (8000000, 1595496)
2025-11-01 16:21:10,197 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:21:10,197 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6a715bb8-1b0c-4122-89f4-54c4dcd2c514, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:21:10,198 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6a715bb8-1b0c-4122-89f4-54c4dcd2c514, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" 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_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:21:10,199 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6a715bb8-1b0c-4122-89f4-54c4dcd2c514, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:10,453 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:21:10,454 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:21:10,454 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 23cae970-a599-4ba2-bcc5-a7b1d2a9b9ad, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:21:10,455 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 23cae970-a599-4ba2-bcc5-a7b1d2a9b9ad, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:21:10,456 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 23cae970-a599-4ba2-bcc5-a7b1d2a9b9ad, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:13,507 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:21:23,546 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:21:23,548 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ddfe420e-81ad-4de9-9a53-f45d2511e919, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:21:23,549 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ddfe420e-81ad-4de9-9a53-f45d2511e919, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:21:23,550 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ddfe420e-81ad-4de9-9a53-f45d2511e919, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:25,823 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:21:35,849 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:21:35,851 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, db86085e-ace3-4650-9c95-ac061132e3ca, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:21:35,852 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, db86085e-ace3-4650-9c95-ac061132e3ca, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:21:35,853 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, db86085e-ace3-4650-9c95-ac061132e3ca, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:36,770 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:21:46,777 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:21:46,778 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0e118633-221e-4f3a-9705-41c26cc8d102, ghrun-cjocww3of4.auto.internal:1995): creating call state
2025-11-01 16:21:46,779 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0e118633-221e-4f3a-9705-41c26cc8d102, ghrun-cjocww3of4.auto.internal:1995): request = { session_id: "ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:21:46,780 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0e118633-221e-4f3a-9705-41c26cc8d102, ghrun-cjocww3of4.auto.internal:1995): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:47,461 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2M1N2ExODEtODE3MDA5MjktZThjNDhjNzYtYWYxZGViZmQ=
2025-11-01 16:21:47,465 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_8_compression`, volumes `value` (8000000, 1465240)
2025-11-01 16:21:47,466 - INFO - root - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_8_compression` 8092160 / 1465240: 5.522753951571073
2025-11-01 16:21:47,468 - INFO - ya.test - pytest_runtest_teardown: Test teardown
