2025-11-01 16:19:05,121 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 16:19:05,121 - INFO - ya.test - pytest_runtest_setup: test_all_supported_compression[zstd_4_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 4]
2025-11-01 16:19:05,122 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 16:19:05,122 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-01 16:19:05,124 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-11-01 16:19:05,125 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-11-01 16:19:05,125 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/y72z/00250a/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 16:19:05,127 - DEBUG - ya.test - execute: Command pid: 516417
2025-11-01 16:19:05,832 - DEBUG - ya.test - _save_outputs: Command (pid 516417) rc: 0
2025-11-01 16:19:05,833 - DEBUG - ya.test - _save_outputs: Command (pid 516417) elapsed time (sec): 0.7041208744049072
2025-11-01 16:19:05,833 - DEBUG - ya.test - _save_outputs: Command (pid 516417) idrss: 0
2025-11-01 16:19:05,833 - DEBUG - ya.test - _save_outputs: Command (pid 516417) inblock: 0
2025-11-01 16:19:05,839 - DEBUG - ya.test - _save_outputs: Command (pid 516417) isrss: 0
2025-11-01 16:19:05,839 - DEBUG - ya.test - _save_outputs: Command (pid 516417) ixrss: 0
2025-11-01 16:19:05,839 - DEBUG - ya.test - _save_outputs: Command (pid 516417) majflt: 0
2025-11-01 16:19:05,839 - DEBUG - ya.test - _save_outputs: Command (pid 516417) maxrss: 494820
2025-11-01 16:19:05,839 - DEBUG - ya.test - _save_outputs: Command (pid 516417) minflt: 45394
2025-11-01 16:19:05,840 - DEBUG - ya.test - _save_outputs: Command (pid 516417) msgrcv: 0
2025-11-01 16:19:05,840 - DEBUG - ya.test - _save_outputs: Command (pid 516417) msgsnd: 0
2025-11-01 16:19:05,840 - DEBUG - ya.test - _save_outputs: Command (pid 516417) nivcsw: 75
2025-11-01 16:19:05,840 - DEBUG - ya.test - _save_outputs: Command (pid 516417) nsignals: 0
2025-11-01 16:19:05,841 - DEBUG - ya.test - _save_outputs: Command (pid 516417) nswap: 0
2025-11-01 16:19:05,841 - DEBUG - ya.test - _save_outputs: Command (pid 516417) nvcsw: 13
2025-11-01 16:19:05,841 - DEBUG - ya.test - _save_outputs: Command (pid 516417) oublock: 8
2025-11-01 16:19:05,841 - DEBUG - ya.test - _save_outputs: Command (pid 516417) stime: 0.195548
2025-11-01 16:19:05,842 - DEBUG - ya.test - _save_outputs: Command (pid 516417) utime: 0.44877599999999995
2025-11-01 16:19:05,842 - DEBUG - ya.test - _save_outputs: Command (pid 516417) wtime: 0.706
2025-11-01 16:19:05,842 - DEBUG - ya.test - _save_outputs: Command (pid 516417) 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:05,842 - DEBUG - ya.test - _save_outputs: Command (pid 516417) errors:

2025-11-01 16:19:05,843 - 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:05,950 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/y72z/00250a/ydb/apps/ydbd/ydbd
2025-11-01 16:19:05,952 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/29574
2025-11-01 16:19:05,955 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/y72z/00250a/r3tmp/kikimr_cluster_k2rdcyaw
2025-11-01 16:19:05,987 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/y72z/00250a/ydb/apps/ydbd/ydbd
2025-11-01 16:19:05,988 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/11574
2025-11-01 16:19:05,989 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/21207
2025-11-01 16:19:05,989 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/30287
2025-11-01 16:19:05,990 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/9396
2025-11-01 16:19:05,990 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/y72z/00250a/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/kikimr_configs"
2025-11-01 16:19:05,991 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/y72z/00250a/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/00250a/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/node_1/logfile_729r_3kt.log --grpc-port=11574 --mon-port=21207 --ic-port=29574
2025-11-01 16:19:05,991 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:11574/1, disk_size 68719476736
2025-11-01 16:19:05,992 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/y72z/00250a/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/kikimr_configs"
2025-11-01 16:19:05,992 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/y72z/00250a/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/00250a/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/node_1/logfile_729r_3kt.log --grpc-port=11574 --mon-port=21207 --ic-port=29574
2025-11-01 16:19:05,993 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/y72z/00250a/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/y72z/00250a/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/y72z/00250a/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/node_1/logfile_729r_3kt.log', '--grpc-port=11574', '--mon-port=21207', '--ic-port=29574')' in '/home/runner/.ya/build/build_root/y72z/00250a/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/node_1' (no wait)
2025-11-01 16:19:05,996 - DEBUG - ya.test - execute: Command pid: 516617
2025-11-01 16:19:05,996 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:11574/1
2025-11-01 16:19:05,998 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-11-01 16:19:05,998 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-11-01 16:19:05,999 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/y72z/00250a/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 16:19:06,000 - DEBUG - ya.test - execute: Command pid: 516618
2025-11-01 16:19:06,697 - DEBUG - ya.test - _save_outputs: Command (pid 516618) rc: 0
2025-11-01 16:19:06,697 - DEBUG - ya.test - _save_outputs: Command (pid 516618) elapsed time (sec): 0.6960318088531494
2025-11-01 16:19:06,698 - DEBUG - ya.test - _save_outputs: Command (pid 516618) idrss: 0
2025-11-01 16:19:06,698 - DEBUG - ya.test - _save_outputs: Command (pid 516618) inblock: 0
2025-11-01 16:19:06,698 - DEBUG - ya.test - _save_outputs: Command (pid 516618) isrss: 0
2025-11-01 16:19:06,698 - DEBUG - ya.test - _save_outputs: Command (pid 516618) ixrss: 0
2025-11-01 16:19:06,699 - DEBUG - ya.test - _save_outputs: Command (pid 516618) majflt: 0
2025-11-01 16:19:06,699 - DEBUG - ya.test - _save_outputs: Command (pid 516618) maxrss: 503472
2025-11-01 16:19:06,699 - DEBUG - ya.test - _save_outputs: Command (pid 516618) minflt: 45282
2025-11-01 16:19:06,700 - DEBUG - ya.test - _save_outputs: Command (pid 516618) msgrcv: 0
2025-11-01 16:19:06,700 - DEBUG - ya.test - _save_outputs: Command (pid 516618) msgsnd: 0
2025-11-01 16:19:06,700 - DEBUG - ya.test - _save_outputs: Command (pid 516618) nivcsw: 133
2025-11-01 16:19:06,701 - DEBUG - ya.test - _save_outputs: Command (pid 516618) nsignals: 0
2025-11-01 16:19:06,701 - DEBUG - ya.test - _save_outputs: Command (pid 516618) nswap: 0
2025-11-01 16:19:06,701 - DEBUG - ya.test - _save_outputs: Command (pid 516618) nvcsw: 14
2025-11-01 16:19:06,701 - DEBUG - ya.test - _save_outputs: Command (pid 516618) oublock: 8
2025-11-01 16:19:06,702 - DEBUG - ya.test - _save_outputs: Command (pid 516618) stime: 0.186579
2025-11-01 16:19:06,702 - DEBUG - ya.test - _save_outputs: Command (pid 516618) utime: 0.436869
2025-11-01 16:19:06,702 - DEBUG - ya.test - _save_outputs: Command (pid 516618) wtime: 0.698
2025-11-01 16:19:06,702 - DEBUG - ya.test - _save_outputs: Command (pid 516618) output:
Git info:
    Commit: b759454d1e40b275ba8b2f5964202fc9f08a1c3c
    Branch: 
    Author: Denis Khalikov <dennis.khalikov@gmail.com>
    Summary: Merge b3001557f326a9ac3df9852d3eea5c83a6651a93 into 88f362bbf1115d2653ecf70400035099c5165741

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

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

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

2025-11-01 16:19:06,703 - 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:11,656 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/y72z/00250a/ydb/apps/ydbd/ydbd
2025-11-01 16:19:11,656 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/y72z/00250a/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:11574', '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: 29574\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-01 16:19:11,657 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-11-01 16:19:11,658 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-11-01 16:19:11,658 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/y72z/00250a/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:11574', '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: 29574\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-01 16:19:11,681 - DEBUG - ya.test - execute: Command pid: 519622
2025-11-01 16:19:12,825 - DEBUG - ya.test - _save_outputs: Command (pid 519622) rc: 0
2025-11-01 16:19:12,825 - DEBUG - ya.test - _save_outputs: Command (pid 519622) elapsed time (sec): 1.1433079242706299
2025-11-01 16:19:12,826 - DEBUG - ya.test - _save_outputs: Command (pid 519622) idrss: 0
2025-11-01 16:19:12,826 - DEBUG - ya.test - _save_outputs: Command (pid 519622) inblock: 0
2025-11-01 16:19:12,826 - DEBUG - ya.test - _save_outputs: Command (pid 519622) isrss: 0
2025-11-01 16:19:12,827 - DEBUG - ya.test - _save_outputs: Command (pid 519622) ixrss: 0
2025-11-01 16:19:12,827 - DEBUG - ya.test - _save_outputs: Command (pid 519622) majflt: 0
2025-11-01 16:19:12,827 - DEBUG - ya.test - _save_outputs: Command (pid 519622) maxrss: 600020
2025-11-01 16:19:12,827 - DEBUG - ya.test - _save_outputs: Command (pid 519622) minflt: 51719
2025-11-01 16:19:12,828 - DEBUG - ya.test - _save_outputs: Command (pid 519622) msgrcv: 0
2025-11-01 16:19:12,828 - DEBUG - ya.test - _save_outputs: Command (pid 519622) msgsnd: 0
2025-11-01 16:19:12,828 - DEBUG - ya.test - _save_outputs: Command (pid 519622) nivcsw: 202
2025-11-01 16:19:12,828 - DEBUG - ya.test - _save_outputs: Command (pid 519622) nsignals: 0
2025-11-01 16:19:12,829 - DEBUG - ya.test - _save_outputs: Command (pid 519622) nswap: 0
2025-11-01 16:19:12,829 - DEBUG - ya.test - _save_outputs: Command (pid 519622) nvcsw: 548
2025-11-01 16:19:12,829 - DEBUG - ya.test - _save_outputs: Command (pid 519622) oublock: 8
2025-11-01 16:19:12,829 - DEBUG - ya.test - _save_outputs: Command (pid 519622) stime: 0.251422
2025-11-01 16:19:12,830 - DEBUG - ya.test - _save_outputs: Command (pid 519622) utime: 0.5568609999999999
2025-11-01 16:19:12,830 - DEBUG - ya.test - _save_outputs: Command (pid 519622) wtime: 1.166
2025-11-01 16:19:12,830 - DEBUG - ya.test - _save_outputs: Command (pid 519622) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-01 16:19:12,830 - DEBUG - ya.test - _save_outputs: Command (pid 519622) errors:

2025-11-01 16:19:12,832 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/y72z/00250a/ydb/apps/ydbd/ydbd
2025-11-01 16:19:12,832 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/y72z/00250a/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:11574', '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:12,834 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-11-01 16:19:12,834 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-11-01 16:19:12,835 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/y72z/00250a/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:11574', '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:12,841 - DEBUG - ya.test - execute: Command pid: 520119
2025-11-01 16:19:13,768 - DEBUG - ya.test - _save_outputs: Command (pid 520119) rc: 0
2025-11-01 16:19:13,768 - DEBUG - ya.test - _save_outputs: Command (pid 520119) elapsed time (sec): 0.9255609512329102
2025-11-01 16:19:13,769 - DEBUG - ya.test - _save_outputs: Command (pid 520119) idrss: 0
2025-11-01 16:19:13,769 - DEBUG - ya.test - _save_outputs: Command (pid 520119) inblock: 0
2025-11-01 16:19:13,769 - DEBUG - ya.test - _save_outputs: Command (pid 520119) isrss: 0
2025-11-01 16:19:13,769 - DEBUG - ya.test - _save_outputs: Command (pid 520119) ixrss: 0
2025-11-01 16:19:13,770 - DEBUG - ya.test - _save_outputs: Command (pid 520119) majflt: 0
2025-11-01 16:19:13,770 - DEBUG - ya.test - _save_outputs: Command (pid 520119) maxrss: 600480
2025-11-01 16:19:13,770 - DEBUG - ya.test - _save_outputs: Command (pid 520119) minflt: 51567
2025-11-01 16:19:13,770 - DEBUG - ya.test - _save_outputs: Command (pid 520119) msgrcv: 0
2025-11-01 16:19:13,771 - DEBUG - ya.test - _save_outputs: Command (pid 520119) msgsnd: 0
2025-11-01 16:19:13,771 - DEBUG - ya.test - _save_outputs: Command (pid 520119) nivcsw: 191
2025-11-01 16:19:13,771 - DEBUG - ya.test - _save_outputs: Command (pid 520119) nsignals: 0
2025-11-01 16:19:13,771 - DEBUG - ya.test - _save_outputs: Command (pid 520119) nswap: 0
2025-11-01 16:19:13,772 - DEBUG - ya.test - _save_outputs: Command (pid 520119) nvcsw: 474
2025-11-01 16:19:13,772 - DEBUG - ya.test - _save_outputs: Command (pid 520119) oublock: 8
2025-11-01 16:19:13,772 - DEBUG - ya.test - _save_outputs: Command (pid 520119) stime: 0.23589
2025-11-01 16:19:13,772 - DEBUG - ya.test - _save_outputs: Command (pid 520119) utime: 0.51711
2025-11-01 16:19:13,773 - DEBUG - ya.test - _save_outputs: Command (pid 520119) wtime: 0.932
2025-11-01 16:19:13,773 - DEBUG - ya.test - _save_outputs: Command (pid 520119) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

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

2025-11-01 16:19:13,774 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-01 16:19:13,832 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-11-01 16:19:13,872 - 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:13,875 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 16:19:13,875 - 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:13,921 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-01 16:19:13,922 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, d7ad5cc3-8bf5-4f8a-a8ce-a3ea2cf20eb6, localhost:11574): creating call state
2025-11-01 16:19:13,923 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, d7ad5cc3-8bf5-4f8a-a8ce-a3ea2cf20eb6, localhost:11574): request = { database: "/Root" }
2025-11-01 16:19:13,939 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, d7ad5cc3-8bf5-4f8a-a8ce-a3ea2cf20eb6, localhost:11574): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-cjocww3of4.auto.internal" port: 11574 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:13,940 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-cjocww3of4.auto.internal:11574, location 1, ssl: False>]>
2025-11-01 16:19:13,940 - 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:13,992 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:11574
2025-11-01 16:19:13,993 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 16:19:13,994 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 43c8077a-41fd-4517-97a3-c0ad6771577e, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:13,994 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 43c8077a-41fd-4517-97a3-c0ad6771577e, ghrun-cjocww3of4.auto.internal:11574): request = {  }
2025-11-01 16:19:14,005 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 43c8077a-41fd-4517-97a3-c0ad6771577e, ghrun-cjocww3of4.auto.internal:11574): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" node_id: 1 }
2025-11-01 16:19:14,006 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, c22f590c-ce77-4eb2-a6b7-88139835958b, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:14,007 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, c22f590c-ce77-4eb2-a6b7-88139835958b, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" }
2025-11-01 16:19:14,013 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, c22f590c-ce77-4eb2-a6b7-88139835958b, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:14,029 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:14,030 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 802bd89d-3fb9-4819-982b-e5501498d7cb, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:14,031 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 802bd89d-3fb9-4819-982b-e5501498d7cb, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/off_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"off\")\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:14,037 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 802bd89d-3fb9-4819-982b-e5501498d7cb, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:16,847 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:16,848 - INFO - __tests__.alter_compression - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-11-01 16:19:16,849 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:16,850 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6e87798a-444e-409e-959e-717abd5805f8, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:16,851 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6e87798a-444e-409e-959e-717abd5805f8, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" 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:16,852 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6e87798a-444e-409e-959e-717abd5805f8, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:17,749 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:17,750 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:17,751 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, df354bf8-9072-4a08-a447-d9c64f0595a8, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:17,752 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, df354bf8-9072-4a08-a447-d9c64f0595a8, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" 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:17,753 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, df354bf8-9072-4a08-a447-d9c64f0595a8, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:18,735 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:18,736 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:18,736 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 252007a6-a3a2-4ffd-b81f-2a989c5bff2a, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:18,737 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 252007a6-a3a2-4ffd-b81f-2a989c5bff2a, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" 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:18,738 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 252007a6-a3a2-4ffd-b81f-2a989c5bff2a, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:19,546 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:19,547 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:19,548 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c82e71d4-f051-4839-8d1c-b93965338a3e, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:19,548 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c82e71d4-f051-4839-8d1c-b93965338a3e, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" 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:19,550 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c82e71d4-f051-4839-8d1c-b93965338a3e, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:20,802 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:20,802 - 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:20,803 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:20,803 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 355717ea-018c-4c13-9070-c08ba7359782, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:20,805 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 355717ea-018c-4c13-9070-c08ba7359782, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" 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:20,807 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 355717ea-018c-4c13-9070-c08ba7359782, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:21,624 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:21,624 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:21,625 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b49aa987-5027-499f-8775-30d22f6ef7cf, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:21,626 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b49aa987-5027-499f-8775-30d22f6ef7cf, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" 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,627 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b49aa987-5027-499f-8775-30d22f6ef7cf, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:21,833 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:21,833 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:21,834 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3edef97f-fc90-49b5-b20b-f341ae5f9dd3, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:21,835 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3edef97f-fc90-49b5-b20b-f341ae5f9dd3, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" 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:21,836 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3edef97f-fc90-49b5-b20b-f341ae5f9dd3, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:22,216 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:22,217 - 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:22,218 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:22,218 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ee96f5f9-a9b5-47da-ab73-ba34f9f38d37, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:22,219 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ee96f5f9-a9b5-47da-ab73-ba34f9f38d37, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" 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:22,221 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ee96f5f9-a9b5-47da-ab73-ba34f9f38d37, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:23,001 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:23,001 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:23,002 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 16ccd8db-5faa-47bd-950b-c366648656d4, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:23,003 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 16ccd8db-5faa-47bd-950b-c366648656d4, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" 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:23,004 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 16ccd8db-5faa-47bd-950b-c366648656d4, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:23,265 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:23,265 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:23,266 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, fd84d3d2-0cb6-47f5-8a39-17eea2d0f5ac, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:23,267 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, fd84d3d2-0cb6-47f5-8a39-17eea2d0f5ac, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" 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:23,268 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, fd84d3d2-0cb6-47f5-8a39-17eea2d0f5ac, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:23,654 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:23,655 - 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:23,655 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:23,656 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ff8aed96-a6ae-4b0d-a0fb-ea63cbabf67e, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:23,657 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ff8aed96-a6ae-4b0d-a0fb-ea63cbabf67e, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" 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:23,659 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ff8aed96-a6ae-4b0d-a0fb-ea63cbabf67e, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:24,737 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:24,738 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:24,739 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 82be8da2-ba10-44c4-b687-da865e4d320f, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:24,740 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 82be8da2-ba10-44c4-b687-da865e4d320f, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" 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,744 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 82be8da2-ba10-44c4-b687-da865e4d320f, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:25,009 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:25,010 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:25,011 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7c274412-ce43-472b-8990-53fdbfda1068, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:25,012 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7c274412-ce43-472b-8990-53fdbfda1068, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:25,013 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7c274412-ce43-472b-8990-53fdbfda1068, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:25,442 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:25,443 - 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:25,444 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:25,444 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9fa386c8-9453-4429-8c42-96e518eb394f, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:25,447 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9fa386c8-9453-4429-8c42-96e518eb394f, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" 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:25,449 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9fa386c8-9453-4429-8c42-96e518eb394f, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:26,289 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:26,289 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:26,290 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 85d0be3e-a5dd-4b05-bdd9-2986e51a9378, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:26,291 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 85d0be3e-a5dd-4b05-bdd9-2986e51a9378, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" 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,301 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 85d0be3e-a5dd-4b05-bdd9-2986e51a9378, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:26,627 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:26,628 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:26,629 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 17df779f-4106-4d41-a57b-cbb21b35d18f, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:26,630 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 17df779f-4106-4d41-a57b-cbb21b35d18f, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" 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,631 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 17df779f-4106-4d41-a57b-cbb21b35d18f, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:27,090 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:27,091 - 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:27,092 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:27,092 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7e437214-7259-4ddf-b02c-f6f7c0a805f8, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:27,094 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7e437214-7259-4ddf-b02c-f6f7c0a805f8, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" 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:27,096 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7e437214-7259-4ddf-b02c-f6f7c0a805f8, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:28,018 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:28,018 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:28,019 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 87ab7c04-9e20-4f52-9ebc-c2af00652638, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:28,020 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 87ab7c04-9e20-4f52-9ebc-c2af00652638, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" 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:28,022 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 87ab7c04-9e20-4f52-9ebc-c2af00652638, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:28,273 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:28,274 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:28,275 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 72265bc9-e032-48f1-a79e-328fc473b85d, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:28,276 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 72265bc9-e032-48f1-a79e-328fc473b85d, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" 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,282 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 72265bc9-e032-48f1-a79e-328fc473b85d, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:28,773 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:28,774 - 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:28,775 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:28,775 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 35786774-b9ac-4ae3-85a0-ff2efdf40fc4, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:28,776 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 35786774-b9ac-4ae3-85a0-ff2efdf40fc4, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" 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:28,782 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 35786774-b9ac-4ae3-85a0-ff2efdf40fc4, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:29,666 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:29,667 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:29,667 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a14bdeea-e508-4f8f-984a-63c0ad3fbcd5, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:29,668 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a14bdeea-e508-4f8f-984a-63c0ad3fbcd5, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" 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,669 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a14bdeea-e508-4f8f-984a-63c0ad3fbcd5, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:29,966 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:29,967 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:29,967 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 17592d4e-ed6e-42e5-86b6-8f6d85b12830, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:29,968 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 17592d4e-ed6e-42e5-86b6-8f6d85b12830, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" 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,969 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 17592d4e-ed6e-42e5-86b6-8f6d85b12830, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:30,570 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:30,570 - 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:30,570 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:30,571 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9578362a-27f6-4f82-ae8b-b01553b1fda6, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:30,571 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9578362a-27f6-4f82-ae8b-b01553b1fda6, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" 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:30,573 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9578362a-27f6-4f82-ae8b-b01553b1fda6, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:31,589 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:31,590 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:31,590 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f59c5c26-67aa-49ad-9860-e3feaa51037a, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:31,591 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f59c5c26-67aa-49ad-9860-e3feaa51037a, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" 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,593 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f59c5c26-67aa-49ad-9860-e3feaa51037a, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:31,861 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:31,862 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:31,862 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e3e624a5-7581-42ae-b659-11e1b92fd048, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:31,863 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e3e624a5-7581-42ae-b659-11e1b92fd048, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" 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,865 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e3e624a5-7581-42ae-b659-11e1b92fd048, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:32,433 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:32,434 - 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:32,434 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:32,435 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b42c89d3-9485-4251-9eea-ba61372c8e2c, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:32,436 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b42c89d3-9485-4251-9eea-ba61372c8e2c, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" 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:32,437 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b42c89d3-9485-4251-9eea-ba61372c8e2c, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:33,453 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:33,453 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:33,454 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 19f7a2da-d1ed-49ab-9f84-49638cc3e967, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:33,455 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 19f7a2da-d1ed-49ab-9f84-49638cc3e967, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:33,456 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 19f7a2da-d1ed-49ab-9f84-49638cc3e967, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:33,825 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:33,826 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:33,826 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 26be1d81-39a5-4d66-bace-78c05d13b61c, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:33,827 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 26be1d81-39a5-4d66-bace-78c05d13b61c, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" 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,829 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 26be1d81-39a5-4d66-bace-78c05d13b61c, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:34,450 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:34,451 - 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:34,451 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:34,452 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a7f153c9-8ef7-4031-98d0-15b959a09656, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:34,453 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a7f153c9-8ef7-4031-98d0-15b959a09656, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" 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:34,454 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a7f153c9-8ef7-4031-98d0-15b959a09656, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:35,537 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:35,538 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:35,538 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 48fb3dd7-966f-429c-bd1d-40a15cf727ac, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:35,539 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 48fb3dd7-966f-429c-bd1d-40a15cf727ac, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" 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:35,541 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 48fb3dd7-966f-429c-bd1d-40a15cf727ac, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:35,798 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:35,799 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:35,800 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1249a3ff-3b4d-492f-9a3a-36d5c06b1565, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:35,801 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1249a3ff-3b4d-492f-9a3a-36d5c06b1565, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:35,802 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1249a3ff-3b4d-492f-9a3a-36d5c06b1565, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:36,382 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:36,382 - 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:36,383 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:36,384 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 151bdeab-d026-414f-8664-2c6a9a1a3bd0, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:36,384 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 151bdeab-d026-414f-8664-2c6a9a1a3bd0, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" 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:36,385 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 151bdeab-d026-414f-8664-2c6a9a1a3bd0, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:37,493 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:37,494 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:37,494 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 68e7ab30-3dab-499c-b85d-97d5f85db6a4, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:37,495 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 68e7ab30-3dab-499c-b85d-97d5f85db6a4, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:37,497 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 68e7ab30-3dab-499c-b85d-97d5f85db6a4, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:37,693 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:37,694 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:37,694 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c868c430-cb79-4ee6-b488-f872ec9a053d, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:37,695 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c868c430-cb79-4ee6-b488-f872ec9a053d, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:37,698 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c868c430-cb79-4ee6-b488-f872ec9a053d, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:37,955 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:37,956 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:37,956 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 94df5baf-49b2-42c7-8d35-6363e0268e5b, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:37,957 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 94df5baf-49b2-42c7-8d35-6363e0268e5b, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" 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:37,958 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 94df5baf-49b2-42c7-8d35-6363e0268e5b, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:41,884 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:51,925 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:51,925 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a6b08308-1bca-4e58-b55d-c463134a3dc5, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:51,926 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a6b08308-1bca-4e58-b55d-c463134a3dc5, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" 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:51,927 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a6b08308-1bca-4e58-b55d-c463134a3dc5, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:55,002 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:55,063 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-11-01 16:19:55,064 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:19:55,065 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 48fcc313-7da4-496b-85e3-f6d0ef86ca3d, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:19:55,066 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 48fcc313-7da4-496b-85e3-f6d0ef86ca3d, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" 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:55,067 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 48fcc313-7da4-496b-85e3-f6d0ef86ca3d, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:58,374 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:08,413 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:08,414 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, df0de85f-a3b6-4820-85b5-af9caf6c33c9, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:08,415 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, df0de85f-a3b6-4820-85b5-af9caf6c33c9, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" 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:08,416 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, df0de85f-a3b6-4820-85b5-af9caf6c33c9, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:11,742 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:11,780 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-11-01 16:20:11,781 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:11,782 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 16b5d604-a2c3-4921-99b1-67f68121538c, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:11,783 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 16b5d604-a2c3-4921-99b1-67f68121538c, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" 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:11,785 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 16b5d604-a2c3-4921-99b1-67f68121538c, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:12,110 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:12,113 - INFO - ya.test - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_4_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 4])
2025-11-01 16:20:12,113 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:12,114 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0776ba36-b7dd-4ca0-9b48-6d0da6ddab8d, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:12,115 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0776ba36-b7dd-4ca0-9b48-6d0da6ddab8d, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_4_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 4)\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:12,116 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0776ba36-b7dd-4ca0-9b48-6d0da6ddab8d, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:15,507 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:15,508 - INFO - __tests__.alter_compression - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_4_compression created
2025-11-01 16:20:15,508 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:15,509 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 16b74bcd-114e-45d7-9014-19dbe5d1b644, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:15,510 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 16b74bcd-114e-45d7-9014-19dbe5d1b644, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_4_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:15,512 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 16b74bcd-114e-45d7-9014-19dbe5d1b644, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:16,728 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:16,729 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:16,730 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d4057ead-48e0-41ca-b15c-e1b77863682c, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:16,731 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d4057ead-48e0-41ca-b15c-e1b77863682c, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 0;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:16,732 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d4057ead-48e0-41ca-b15c-e1b77863682c, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:18,846 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:18,847 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:18,848 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0fa19523-1e11-4818-a7b7-15178c9b8967, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:18,849 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0fa19523-1e11-4818-a7b7-15178c9b8967, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:18,852 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0fa19523-1e11-4818-a7b7-15178c9b8967, ghrun-cjocww3of4.auto.internal:11574): 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=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:20,018 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:20,019 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0ef2d56b-44b3-401e-8612-59b093a54579, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:20,020 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0ef2d56b-44b3-401e-8612-59b093a54579, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:20,030 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0ef2d56b-44b3-401e-8612-59b093a54579, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:22,066 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:22,067 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318960, 'BlobCount': 128}}
2025-11-01 16:20:22,068 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:22,069 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ffaaab36-0f17-46fc-b0bf-ad753a0ee69a, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:22,070 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ffaaab36-0f17-46fc-b0bf-ad753a0ee69a, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 100000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:22,072 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ffaaab36-0f17-46fc-b0bf-ad753a0ee69a, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:23,597 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:23,598 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:23,599 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7c14d98a-4694-4973-883e-abf94fc2e24f, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:23,600 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7c14d98a-4694-4973-883e-abf94fc2e24f, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:23,601 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7c14d98a-4694-4973-883e-abf94fc2e24f, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:24,056 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:24,056 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:24,057 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, bb598040-d5ac-4fd8-8a9b-73adbefe230c, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:24,058 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, bb598040-d5ac-4fd8-8a9b-73adbefe230c, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:24,059 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, bb598040-d5ac-4fd8-8a9b-73adbefe230c, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:24,652 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:24,653 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 638256, 'BlobCount': 256}}
2025-11-01 16:20:24,653 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:24,654 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f2473e40-2a64-4622-ba91-8fbc89cc3bac, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:24,655 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f2473e40-2a64-4622-ba91-8fbc89cc3bac, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 200000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:24,662 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f2473e40-2a64-4622-ba91-8fbc89cc3bac, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:25,982 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:25,983 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:25,984 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0a2462ab-5ac6-4db5-a37c-6b861b2926f0, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:25,984 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0a2462ab-5ac6-4db5-a37c-6b861b2926f0, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:25,986 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0a2462ab-5ac6-4db5-a37c-6b861b2926f0, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:26,289 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:26,290 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:26,291 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, cdddd400-b246-4b7b-a737-e83bb9303f87, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:26,292 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, cdddd400-b246-4b7b-a737-e83bb9303f87, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:26,294 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, cdddd400-b246-4b7b-a737-e83bb9303f87, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:26,685 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:26,686 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 957296, 'BlobCount': 384}}
2025-11-01 16:20:26,687 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:26,687 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d622d790-dfd0-43e4-bd22-055accf180a8, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:26,688 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d622d790-dfd0-43e4-bd22-055accf180a8, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 300000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:26,690 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d622d790-dfd0-43e4-bd22-055accf180a8, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:27,811 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:27,811 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:27,812 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0c9231fa-fdae-45bb-948d-e675cc34016f, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:27,813 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0c9231fa-fdae-45bb-948d-e675cc34016f, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:27,814 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0c9231fa-fdae-45bb-948d-e675cc34016f, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:28,113 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:28,114 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:28,114 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3f9d6c67-cccb-446d-a7be-0317eda522ac, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:28,115 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3f9d6c67-cccb-446d-a7be-0317eda522ac, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:28,123 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3f9d6c67-cccb-446d-a7be-0317eda522ac, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:28,525 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:28,526 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1276656, 'BlobCount': 512}}
2025-11-01 16:20:28,526 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:28,527 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b2807a0f-8e18-4f69-8732-7d3ed304cde2, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:28,528 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b2807a0f-8e18-4f69-8732-7d3ed304cde2, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 400000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:28,531 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b2807a0f-8e18-4f69-8732-7d3ed304cde2, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:29,849 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:29,850 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:29,851 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9708d8e2-cc51-4925-92fe-46dfd45b113e, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:29,852 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9708d8e2-cc51-4925-92fe-46dfd45b113e, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:29,853 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9708d8e2-cc51-4925-92fe-46dfd45b113e, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:30,117 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:30,118 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:30,118 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8c52140c-d823-4307-bcb5-75588c1e9cef, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:30,119 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8c52140c-d823-4307-bcb5-75588c1e9cef, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:30,122 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8c52140c-d823-4307-bcb5-75588c1e9cef, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:30,514 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:30,514 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1595616, 'BlobCount': 640}}
2025-11-01 16:20:30,515 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:30,515 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 25a9dd6a-bf15-4417-9bc9-101be00948f1, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:30,516 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 25a9dd6a-bf15-4417-9bc9-101be00948f1, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 500000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:30,518 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 25a9dd6a-bf15-4417-9bc9-101be00948f1, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:31,625 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:31,625 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:31,626 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4eb0186b-2943-4d80-81c5-2cb51b247bd8, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:31,627 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4eb0186b-2943-4d80-81c5-2cb51b247bd8, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:31,628 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4eb0186b-2943-4d80-81c5-2cb51b247bd8, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:31,861 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:31,862 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:31,862 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 99d95993-3919-4427-8e85-1d9ac8cb01b2, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:31,863 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 99d95993-3919-4427-8e85-1d9ac8cb01b2, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:31,865 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 99d95993-3919-4427-8e85-1d9ac8cb01b2, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:32,349 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:32,350 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1914800, 'BlobCount': 768}}
2025-11-01 16:20:32,350 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:32,351 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3eb76dd1-ec15-4336-bdd2-bffa68c96441, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:32,351 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3eb76dd1-ec15-4336-bdd2-bffa68c96441, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 600000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:32,353 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3eb76dd1-ec15-4336-bdd2-bffa68c96441, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:33,717 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:33,717 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:33,718 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7cb7e251-0d8c-42f7-a8e2-046595825ea5, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:33,719 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7cb7e251-0d8c-42f7-a8e2-046595825ea5, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:33,720 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7cb7e251-0d8c-42f7-a8e2-046595825ea5, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:34,028 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:34,029 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:34,030 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f32d4d73-f735-43b0-8f7b-8c28a958ef66, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:34,030 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f32d4d73-f735-43b0-8f7b-8c28a958ef66, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:34,032 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f32d4d73-f735-43b0-8f7b-8c28a958ef66, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:34,562 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:34,563 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2233936, 'BlobCount': 896}}
2025-11-01 16:20:34,564 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:34,564 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d63acaef-6585-4efd-8c8a-b81ce71ff447, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:34,565 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d63acaef-6585-4efd-8c8a-b81ce71ff447, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 700000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:34,567 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d63acaef-6585-4efd-8c8a-b81ce71ff447, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:35,785 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:35,786 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:35,786 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a2b6cbbc-e606-458c-9580-3828072f32cd, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:35,787 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a2b6cbbc-e606-458c-9580-3828072f32cd, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:35,788 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a2b6cbbc-e606-458c-9580-3828072f32cd, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:36,065 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:36,066 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:36,066 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5778ee42-86e2-4e25-8139-2a9d1a501b29, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:36,067 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5778ee42-86e2-4e25-8139-2a9d1a501b29, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:36,069 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5778ee42-86e2-4e25-8139-2a9d1a501b29, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:36,741 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:36,742 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2553424, 'BlobCount': 1024}}
2025-11-01 16:20:36,743 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:36,743 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 49d7c206-a99e-498e-98c4-8621c4ca3290, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:36,746 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 49d7c206-a99e-498e-98c4-8621c4ca3290, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 800000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:36,747 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 49d7c206-a99e-498e-98c4-8621c4ca3290, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:38,122 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:38,122 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:38,123 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 80dd285b-c35c-4783-952f-fd1429676c54, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:38,124 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 80dd285b-c35c-4783-952f-fd1429676c54, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:38,130 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 80dd285b-c35c-4783-952f-fd1429676c54, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:38,517 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:38,518 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:38,519 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5ef63ed1-6899-4715-b813-7ac5ff98aab8, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:38,520 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5ef63ed1-6899-4715-b813-7ac5ff98aab8, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:38,523 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5ef63ed1-6899-4715-b813-7ac5ff98aab8, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:39,464 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:39,464 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2872432, 'BlobCount': 1152}}
2025-11-01 16:20:39,465 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:39,465 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a1097740-da08-4fd5-ae0e-e0d0c7e867be, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:39,466 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a1097740-da08-4fd5-ae0e-e0d0c7e867be, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 900000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:39,468 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a1097740-da08-4fd5-ae0e-e0d0c7e867be, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:40,754 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:40,755 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:40,755 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8b320366-0d83-4889-a3c1-dcb1a7950e3e, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:40,756 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8b320366-0d83-4889-a3c1-dcb1a7950e3e, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:40,757 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8b320366-0d83-4889-a3c1-dcb1a7950e3e, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:41,226 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:41,227 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:41,228 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 13ff62f9-8c53-4a98-9564-e2778a2b6d19, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:41,229 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 13ff62f9-8c53-4a98-9564-e2778a2b6d19, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:41,230 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 13ff62f9-8c53-4a98-9564-e2778a2b6d19, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:42,245 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:42,246 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3191936, 'BlobCount': 1280}}
2025-11-01 16:20:42,246 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:42,247 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4335e7dd-2dbf-4a2b-b32c-b68b57a07e5c, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:42,247 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4335e7dd-2dbf-4a2b-b32c-b68b57a07e5c, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_4_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:42,250 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4335e7dd-2dbf-4a2b-b32c-b68b57a07e5c, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:43,589 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:43,590 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:43,590 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1a571718-b569-43fe-9a79-57557e5a1f2b, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:43,591 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1a571718-b569-43fe-9a79-57557e5a1f2b, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:43,593 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1a571718-b569-43fe-9a79-57557e5a1f2b, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:43,993 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:43,994 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:43,995 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 669046f5-7065-4be7-8e66-45ea6265f47d, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:43,995 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 669046f5-7065-4be7-8e66-45ea6265f47d, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:43,997 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 669046f5-7065-4be7-8e66-45ea6265f47d, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:44,316 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:44,317 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:44,318 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8b2e95b8-6c82-4d33-8d21-52894073311b, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:44,318 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8b2e95b8-6c82-4d33-8d21-52894073311b, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:44,320 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8b2e95b8-6c82-4d33-8d21-52894073311b, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:20:48,641 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:58,683 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:20:58,684 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6ec447d9-42b6-41d3-b0e2-f7d188218e3e, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:20:58,685 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6ec447d9-42b6-41d3-b0e2-f7d188218e3e, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:20:58,687 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6ec447d9-42b6-41d3-b0e2-f7d188218e3e, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:01,661 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 16:21:01,661 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 16:21:01,697 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-01 16:21:01,697 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, e16fe74c-b13a-4e6f-ac85-dd8bcb28bfd4, localhost:11574): creating call state
2025-11-01 16:21:01,698 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, e16fe74c-b13a-4e6f-ac85-dd8bcb28bfd4, localhost:11574): request = { database: "/Root" }
2025-11-01 16:21:01,709 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, e16fe74c-b13a-4e6f-ac85-dd8bcb28bfd4, localhost:11574): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-cjocww3of4.auto.internal" port: 11574 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-11-01 16:21:01,710 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-cjocww3of4.auto.internal:11574, location 1, ssl: False>]>
2025-11-01 16:21:01,710 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:11574
2025-11-01 16:21:02,322 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:21:02,364 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_4_compression`, volumes `value` (8000000, 1595968)
2025-11-01 16:21:02,364 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:21:02,365 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 80e69a48-9e0b-4c69-a006-1f13a0686af0, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:21:02,366 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 80e69a48-9e0b-4c69-a006-1f13a0686af0, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:21:02,369 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 80e69a48-9e0b-4c69-a006-1f13a0686af0, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:02,795 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:21:02,795 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:21:02,796 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6f2def85-ceef-4cfa-8b28-72ae952f5884, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:21:02,796 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6f2def85-ceef-4cfa-8b28-72ae952f5884, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:21:02,798 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6f2def85-ceef-4cfa-8b28-72ae952f5884, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:06,438 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:21:16,472 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:21:16,472 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6904d694-315e-44b3-b52c-2b2ddbadf404, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:21:16,473 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6904d694-315e-44b3-b52c-2b2ddbadf404, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:21:16,474 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6904d694-315e-44b3-b52c-2b2ddbadf404, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:20,049 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:21:30,075 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:21:30,076 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c2888f92-128d-47d4-aced-e90dfe2c9c9f, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:21:30,077 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c2888f92-128d-47d4-aced-e90dfe2c9c9f, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:21:30,078 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c2888f92-128d-47d4-aced-e90dfe2c9c9f, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:30,783 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:21:40,789 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:21:40,789 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, acb24e93-e3b4-472e-bb1c-fc6388968afb, ghrun-cjocww3of4.auto.internal:11574): creating call state
2025-11-01 16:21:40,790 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, acb24e93-e3b4-472e-bb1c-fc6388968afb, ghrun-cjocww3of4.auto.internal:11574): request = { session_id: "ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:21:40,792 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, acb24e93-e3b4-472e-bb1c-fc6388968afb, ghrun-cjocww3of4.auto.internal:11574): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:41,504 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgyMTU3NDgtZmJiMDI3MS1lYzU0ZjkzMi1lMTZiOWNmNg==
2025-11-01 16:21:41,508 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_4_compression`, volumes `value` (8000000, 1466456)
2025-11-01 16:21:41,540 - INFO - root - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_4_compression` 8092160 / 1466456: 5.518174428690666
2025-11-01 16:21:41,542 - INFO - ya.test - pytest_runtest_teardown: Test teardown
