2025-10-31 11:32:31,046 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-31 11:32:31,047 - INFO - ya.test - pytest_runtest_setup: test_all_supported_compression[zstd_6_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 6]
2025-10-31 11:32:31,047 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-31 11:32:31,047 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-10-31 11:32:31,049 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-10-31 11:32:31,050 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-10-31 11:32:31,051 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/70wh/0019a8/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-10-31 11:32:31,057 - DEBUG - ya.test - execute: Command pid: 924235
2025-10-31 11:32:31,905 - DEBUG - ya.test - _save_outputs: Command (pid 924235) rc: 0
2025-10-31 11:32:31,906 - DEBUG - ya.test - _save_outputs: Command (pid 924235) elapsed time (sec): 0.8469433784484863
2025-10-31 11:32:31,906 - DEBUG - ya.test - _save_outputs: Command (pid 924235) idrss: 0
2025-10-31 11:32:31,907 - DEBUG - ya.test - _save_outputs: Command (pid 924235) inblock: 0
2025-10-31 11:32:31,907 - DEBUG - ya.test - _save_outputs: Command (pid 924235) isrss: 0
2025-10-31 11:32:31,907 - DEBUG - ya.test - _save_outputs: Command (pid 924235) ixrss: 0
2025-10-31 11:32:31,908 - DEBUG - ya.test - _save_outputs: Command (pid 924235) majflt: 0
2025-10-31 11:32:31,908 - DEBUG - ya.test - _save_outputs: Command (pid 924235) maxrss: 493124
2025-10-31 11:32:31,908 - DEBUG - ya.test - _save_outputs: Command (pid 924235) minflt: 45346
2025-10-31 11:32:31,908 - DEBUG - ya.test - _save_outputs: Command (pid 924235) msgrcv: 0
2025-10-31 11:32:31,909 - DEBUG - ya.test - _save_outputs: Command (pid 924235) msgsnd: 0
2025-10-31 11:32:31,909 - DEBUG - ya.test - _save_outputs: Command (pid 924235) nivcsw: 191
2025-10-31 11:32:31,909 - DEBUG - ya.test - _save_outputs: Command (pid 924235) nsignals: 0
2025-10-31 11:32:31,909 - DEBUG - ya.test - _save_outputs: Command (pid 924235) nswap: 0
2025-10-31 11:32:31,910 - DEBUG - ya.test - _save_outputs: Command (pid 924235) nvcsw: 14
2025-10-31 11:32:31,910 - DEBUG - ya.test - _save_outputs: Command (pid 924235) oublock: 8
2025-10-31 11:32:31,911 - DEBUG - ya.test - _save_outputs: Command (pid 924235) stime: 0.188164
2025-10-31 11:32:31,911 - DEBUG - ya.test - _save_outputs: Command (pid 924235) utime: 0.509718
2025-10-31 11:32:31,911 - DEBUG - ya.test - _save_outputs: Command (pid 924235) wtime: 0.854
2025-10-31 11:32:31,912 - DEBUG - ya.test - _save_outputs: Command (pid 924235) output:
Git info:
    Commit: bf6ff911495926b6bb7f5256c196b59a842137c6
    Branch: 
    Author: vporyadke <mczalyalov@gmail.com>
    Summary: Merge b9809b09cb4b5083a45f9e458df813fff23b2cde into a04e6ba412e7d697c2b9458e46daee2c991a915c

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-xve6mkyrcq
    Host information: 
        Linux ghrun-xve6mkyrcq 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-10-31 11:32:31,912 - DEBUG - ya.test - _save_outputs: Command (pid 924235) errors:

2025-10-31 11:32:31,912 - INFO - __tests__.base - _setup_ydb: Git info:
    Commit: bf6ff911495926b6bb7f5256c196b59a842137c6
    Branch: 
    Author: vporyadke <mczalyalov@gmail.com>
    Summary: Merge b9809b09cb4b5083a45f9e458df813fff23b2cde into a04e6ba412e7d697c2b9458e46daee2c991a915c

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-xve6mkyrcq
    Host information: 
        Linux ghrun-xve6mkyrcq 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-10-31 11:32:32,128 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/70wh/0019a8/ydb/apps/ydbd/ydbd
2025-10-31 11:32:32,135 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/7539
2025-10-31 11:32:32,137 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/70wh/0019a8/r3tmp/kikimr_cluster_mkkutcws
2025-10-31 11:32:32,233 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/70wh/0019a8/ydb/apps/ydbd/ydbd
2025-10-31 11:32:32,242 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/12102
2025-10-31 11:32:32,242 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/12376
2025-10-31 11:32:32,243 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/19229
2025-10-31 11:32:32,243 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/3178
2025-10-31 11:32:32,244 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/70wh/0019a8/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_6_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.6/cluster/kikimr_configs"
2025-10-31 11:32:32,249 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/70wh/0019a8/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/70wh/0019a8/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_6_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.6/cluster/node_1/logfile_wqza4q9_.log --grpc-port=12102 --mon-port=12376 --ic-port=7539
2025-10-31 11:32:32,250 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:12102/1, disk_size 68719476736
2025-10-31 11:32:32,250 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/70wh/0019a8/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_6_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.6/cluster/kikimr_configs"
2025-10-31 11:32:32,251 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/70wh/0019a8/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/70wh/0019a8/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_6_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.6/cluster/node_1/logfile_wqza4q9_.log --grpc-port=12102 --mon-port=12376 --ic-port=7539
2025-10-31 11:32:32,252 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/70wh/0019a8/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/70wh/0019a8/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_6_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.6/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/70wh/0019a8/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_6_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.6/cluster/node_1/logfile_wqza4q9_.log', '--grpc-port=12102', '--mon-port=12376', '--ic-port=7539')' in '/home/runner/.ya/build/build_root/70wh/0019a8/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_6_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.6/cluster/node_1' (no wait)
2025-10-31 11:32:32,269 - DEBUG - ya.test - execute: Command pid: 924811
2025-10-31 11:32:32,270 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:12102/1
2025-10-31 11:32:32,271 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-10-31 11:32:32,272 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-10-31 11:32:32,272 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/70wh/0019a8/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-10-31 11:32:32,274 - DEBUG - ya.test - execute: Command pid: 924814
2025-10-31 11:32:33,502 - DEBUG - ya.test - _save_outputs: Command (pid 924814) rc: 0
2025-10-31 11:32:33,502 - DEBUG - ya.test - _save_outputs: Command (pid 924814) elapsed time (sec): 1.226196527481079
2025-10-31 11:32:33,502 - DEBUG - ya.test - _save_outputs: Command (pid 924814) idrss: 0
2025-10-31 11:32:33,503 - DEBUG - ya.test - _save_outputs: Command (pid 924814) inblock: 0
2025-10-31 11:32:33,503 - DEBUG - ya.test - _save_outputs: Command (pid 924814) isrss: 0
2025-10-31 11:32:33,503 - DEBUG - ya.test - _save_outputs: Command (pid 924814) ixrss: 0
2025-10-31 11:32:33,503 - DEBUG - ya.test - _save_outputs: Command (pid 924814) majflt: 0
2025-10-31 11:32:33,504 - DEBUG - ya.test - _save_outputs: Command (pid 924814) maxrss: 496300
2025-10-31 11:32:33,504 - DEBUG - ya.test - _save_outputs: Command (pid 924814) minflt: 45336
2025-10-31 11:32:33,504 - DEBUG - ya.test - _save_outputs: Command (pid 924814) msgrcv: 0
2025-10-31 11:32:33,505 - DEBUG - ya.test - _save_outputs: Command (pid 924814) msgsnd: 0
2025-10-31 11:32:33,505 - DEBUG - ya.test - _save_outputs: Command (pid 924814) nivcsw: 193
2025-10-31 11:32:33,505 - DEBUG - ya.test - _save_outputs: Command (pid 924814) nsignals: 0
2025-10-31 11:32:33,506 - DEBUG - ya.test - _save_outputs: Command (pid 924814) nswap: 0
2025-10-31 11:32:33,506 - DEBUG - ya.test - _save_outputs: Command (pid 924814) nvcsw: 14
2025-10-31 11:32:33,506 - DEBUG - ya.test - _save_outputs: Command (pid 924814) oublock: 8
2025-10-31 11:32:33,507 - DEBUG - ya.test - _save_outputs: Command (pid 924814) stime: 0.19211899999999998
2025-10-31 11:32:33,507 - DEBUG - ya.test - _save_outputs: Command (pid 924814) utime: 0.52437
2025-10-31 11:32:33,507 - DEBUG - ya.test - _save_outputs: Command (pid 924814) wtime: 1.229
2025-10-31 11:32:33,508 - DEBUG - ya.test - _save_outputs: Command (pid 924814) output:
Git info:
    Commit: bf6ff911495926b6bb7f5256c196b59a842137c6
    Branch: 
    Author: vporyadke <mczalyalov@gmail.com>
    Summary: Merge b9809b09cb4b5083a45f9e458df813fff23b2cde into a04e6ba412e7d697c2b9458e46daee2c991a915c

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-xve6mkyrcq
    Host information: 
        Linux ghrun-xve6mkyrcq 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-10-31 11:32:33,508 - DEBUG - ya.test - _save_outputs: Command (pid 924814) errors:

2025-10-31 11:32:33,508 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: bf6ff911495926b6bb7f5256c196b59a842137c6
    Branch: 
    Author: vporyadke <mczalyalov@gmail.com>
    Summary: Merge b9809b09cb4b5083a45f9e458df813fff23b2cde into a04e6ba412e7d697c2b9458e46daee2c991a915c
2025-10-31 11:32:39,026 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/70wh/0019a8/ydb/apps/ydbd/ydbd
2025-10-31 11:32:39,027 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/70wh/0019a8/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:12102', '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: 7539\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-10-31 11:32:39,028 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-10-31 11:32:39,028 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-10-31 11:32:39,029 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/70wh/0019a8/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:12102', '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: 7539\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-10-31 11:32:39,035 - DEBUG - ya.test - execute: Command pid: 926381
2025-10-31 11:32:40,199 - DEBUG - ya.test - _save_outputs: Command (pid 926381) rc: 0
2025-10-31 11:32:40,200 - DEBUG - ya.test - _save_outputs: Command (pid 926381) elapsed time (sec): 1.163161039352417
2025-10-31 11:32:40,200 - DEBUG - ya.test - _save_outputs: Command (pid 926381) idrss: 0
2025-10-31 11:32:40,200 - DEBUG - ya.test - _save_outputs: Command (pid 926381) inblock: 0
2025-10-31 11:32:40,201 - DEBUG - ya.test - _save_outputs: Command (pid 926381) isrss: 0
2025-10-31 11:32:40,201 - DEBUG - ya.test - _save_outputs: Command (pid 926381) ixrss: 0
2025-10-31 11:32:40,201 - DEBUG - ya.test - _save_outputs: Command (pid 926381) majflt: 0
2025-10-31 11:32:40,201 - DEBUG - ya.test - _save_outputs: Command (pid 926381) maxrss: 597448
2025-10-31 11:32:40,202 - DEBUG - ya.test - _save_outputs: Command (pid 926381) minflt: 51604
2025-10-31 11:32:40,202 - DEBUG - ya.test - _save_outputs: Command (pid 926381) msgrcv: 0
2025-10-31 11:32:40,202 - DEBUG - ya.test - _save_outputs: Command (pid 926381) msgsnd: 0
2025-10-31 11:32:40,203 - DEBUG - ya.test - _save_outputs: Command (pid 926381) nivcsw: 259
2025-10-31 11:32:40,203 - DEBUG - ya.test - _save_outputs: Command (pid 926381) nsignals: 0
2025-10-31 11:32:40,203 - DEBUG - ya.test - _save_outputs: Command (pid 926381) nswap: 0
2025-10-31 11:32:40,203 - DEBUG - ya.test - _save_outputs: Command (pid 926381) nvcsw: 566
2025-10-31 11:32:40,204 - DEBUG - ya.test - _save_outputs: Command (pid 926381) oublock: 8
2025-10-31 11:32:40,204 - DEBUG - ya.test - _save_outputs: Command (pid 926381) stime: 0.256758
2025-10-31 11:32:40,204 - DEBUG - ya.test - _save_outputs: Command (pid 926381) utime: 0.57672
2025-10-31 11:32:40,205 - DEBUG - ya.test - _save_outputs: Command (pid 926381) wtime: 1.169
2025-10-31 11:32:40,216 - DEBUG - ya.test - _save_outputs: Command (pid 926381) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-10-31 11:32:40,216 - DEBUG - ya.test - _save_outputs: Command (pid 926381) errors:

2025-10-31 11:32:40,217 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/70wh/0019a8/ydb/apps/ydbd/ydbd
2025-10-31 11:32:40,218 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/70wh/0019a8/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:12102', '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-10-31 11:32:40,219 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-10-31 11:32:40,228 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-10-31 11:32:40,228 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/70wh/0019a8/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:12102', '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-10-31 11:32:40,236 - DEBUG - ya.test - execute: Command pid: 926661
2025-10-31 11:32:41,392 - DEBUG - ya.test - _save_outputs: Command (pid 926661) rc: 0
2025-10-31 11:32:41,393 - DEBUG - ya.test - _save_outputs: Command (pid 926661) elapsed time (sec): 1.155116319656372
2025-10-31 11:32:41,393 - DEBUG - ya.test - _save_outputs: Command (pid 926661) idrss: 0
2025-10-31 11:32:41,394 - DEBUG - ya.test - _save_outputs: Command (pid 926661) inblock: 0
2025-10-31 11:32:41,394 - DEBUG - ya.test - _save_outputs: Command (pid 926661) isrss: 0
2025-10-31 11:32:41,394 - DEBUG - ya.test - _save_outputs: Command (pid 926661) ixrss: 0
2025-10-31 11:32:41,394 - DEBUG - ya.test - _save_outputs: Command (pid 926661) majflt: 0
2025-10-31 11:32:41,395 - DEBUG - ya.test - _save_outputs: Command (pid 926661) maxrss: 597908
2025-10-31 11:32:41,395 - DEBUG - ya.test - _save_outputs: Command (pid 926661) minflt: 51774
2025-10-31 11:32:41,395 - DEBUG - ya.test - _save_outputs: Command (pid 926661) msgrcv: 0
2025-10-31 11:32:41,395 - DEBUG - ya.test - _save_outputs: Command (pid 926661) msgsnd: 0
2025-10-31 11:32:41,396 - DEBUG - ya.test - _save_outputs: Command (pid 926661) nivcsw: 224
2025-10-31 11:32:41,396 - DEBUG - ya.test - _save_outputs: Command (pid 926661) nsignals: 0
2025-10-31 11:32:41,396 - DEBUG - ya.test - _save_outputs: Command (pid 926661) nswap: 0
2025-10-31 11:32:41,396 - DEBUG - ya.test - _save_outputs: Command (pid 926661) nvcsw: 516
2025-10-31 11:32:41,400 - DEBUG - ya.test - _save_outputs: Command (pid 926661) oublock: 8
2025-10-31 11:32:41,400 - DEBUG - ya.test - _save_outputs: Command (pid 926661) stime: 0.260857
2025-10-31 11:32:41,400 - DEBUG - ya.test - _save_outputs: Command (pid 926661) utime: 0.547974
2025-10-31 11:32:41,401 - DEBUG - ya.test - _save_outputs: Command (pid 926661) wtime: 1.163
2025-10-31 11:32:41,401 - DEBUG - ya.test - _save_outputs: Command (pid 926661) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-10-31 11:32:41,401 - DEBUG - ya.test - _save_outputs: Command (pid 926661) errors:

2025-10-31 11:32:41,402 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-10-31 11:32:41,607 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-10-31 11:32:41,646 - 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-10-31 11:32:41,653 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 11:32:41,654 - 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-10-31 11:32:41,676 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-10-31 11:32:41,677 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, f6bca24d-ae6a-4098-9fc1-1b528b06e8bb, localhost:12102): creating call state
2025-10-31 11:32:41,678 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, f6bca24d-ae6a-4098-9fc1-1b528b06e8bb, localhost:12102): request = { database: "/Root" }
2025-10-31 11:32:41,690 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, f6bca24d-ae6a-4098-9fc1-1b528b06e8bb, localhost:12102): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-xve6mkyrcq.auto.internal" port: 12102 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-10-31 11:32:41,691 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-xve6mkyrcq.auto.internal:12102, location 1, ssl: False>]>
2025-10-31 11:32:41,692 - 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-10-31 11:32:41,708 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:12102
2025-10-31 11:32:41,713 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-10-31 11:32:41,714 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, b548331c-bb4d-427b-887d-d3524f78035c, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:32:41,715 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, b548331c-bb4d-427b-887d-d3524f78035c, ghrun-xve6mkyrcq.auto.internal:12102): request = {  }
2025-10-31 11:32:41,726 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, b548331c-bb4d-427b-887d-d3524f78035c, ghrun-xve6mkyrcq.auto.internal:12102): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" node_id: 1 }
2025-10-31 11:32:41,727 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, b1d12156-67af-4ebd-b7f3-7be9f854fa53, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:32:41,728 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, b1d12156-67af-4ebd-b7f3-7be9f854fa53, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" }
2025-10-31 11:32:41,737 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, b1d12156-67af-4ebd-b7f3-7be9f854fa53, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:32:41,755 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:32:41,756 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a05972ae-6349-44f1-807f-7d7545391a94, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:32:41,757 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a05972ae-6349-44f1-807f-7d7545391a94, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:32:41,759 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a05972ae-6349-44f1-807f-7d7545391a94, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:32:45,274 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:32:45,275 - INFO - __tests__.alter_compression - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-10-31 11:32:45,275 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:32:45,276 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 13ef3ad4-76c5-41bc-9468-13c79884a451, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:32:45,277 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 13ef3ad4-76c5-41bc-9468-13c79884a451, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:32:45,278 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 13ef3ad4-76c5-41bc-9468-13c79884a451, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:32:46,565 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:32:46,566 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:32:46,567 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b1c75225-9dbf-4ab2-b123-b577d4b89f52, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:32:46,568 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b1c75225-9dbf-4ab2-b123-b577d4b89f52, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:32:46,570 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b1c75225-9dbf-4ab2-b123-b577d4b89f52, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:32:47,922 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:32:47,923 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:32:47,924 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d0b19a52-f489-4e69-9bdd-230a54e71b43, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:32:47,925 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d0b19a52-f489-4e69-9bdd-230a54e71b43, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:32:47,926 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d0b19a52-f489-4e69-9bdd-230a54e71b43, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:32:49,132 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:32:49,135 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:32:49,135 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, cc675ce4-c368-4b7f-b931-aebe5d51d377, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:32:49,136 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, cc675ce4-c368-4b7f-b931-aebe5d51d377, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:32:49,139 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, cc675ce4-c368-4b7f-b931-aebe5d51d377, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:32:50,645 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:32:50,646 - 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-10-31 11:32:50,646 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:32:50,647 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5a3ec838-4f42-408b-9264-bc39571a91b6, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:32:50,648 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5a3ec838-4f42-408b-9264-bc39571a91b6, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:32:50,653 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5a3ec838-4f42-408b-9264-bc39571a91b6, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:32:51,902 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:32:51,903 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:32:51,903 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8da8f93a-29f1-44af-a239-9626c9864274, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:32:51,904 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8da8f93a-29f1-44af-a239-9626c9864274, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:32:51,910 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8da8f93a-29f1-44af-a239-9626c9864274, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:32:52,294 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:32:52,295 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:32:52,296 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, fa2be016-943c-4204-b31d-4580ceb57c3c, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:32:52,297 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, fa2be016-943c-4204-b31d-4580ceb57c3c, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:32:52,298 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, fa2be016-943c-4204-b31d-4580ceb57c3c, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:32:52,690 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:32:52,691 - 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-10-31 11:32:52,691 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:32:52,692 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 78b9943c-80da-439f-af3d-278413b1bda8, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:32:52,693 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 78b9943c-80da-439f-af3d-278413b1bda8, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:32:52,694 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 78b9943c-80da-439f-af3d-278413b1bda8, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:32:53,851 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:32:53,852 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:32:53,853 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 63f28636-4d55-4362-b995-9e954d7676a8, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:32:53,853 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 63f28636-4d55-4362-b995-9e954d7676a8, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:32:53,855 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 63f28636-4d55-4362-b995-9e954d7676a8, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:32:54,129 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:32:54,130 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:32:54,131 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6c32dd46-2bd3-484f-a331-6e6b53937443, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:32:54,132 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6c32dd46-2bd3-484f-a331-6e6b53937443, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:32:54,134 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6c32dd46-2bd3-484f-a331-6e6b53937443, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:32:54,519 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:32:54,519 - 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-10-31 11:32:54,520 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:32:54,520 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 41d12d94-e216-445f-adc3-732a47e8dffa, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:32:54,521 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 41d12d94-e216-445f-adc3-732a47e8dffa, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:32:54,523 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 41d12d94-e216-445f-adc3-732a47e8dffa, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:32:55,568 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:32:55,568 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:32:55,569 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 21ac2f8a-141e-4c27-bb34-bf93b128f266, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:32:55,570 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 21ac2f8a-141e-4c27-bb34-bf93b128f266, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:32:55,572 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 21ac2f8a-141e-4c27-bb34-bf93b128f266, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:32:55,809 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:32:55,810 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:32:55,811 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c7e8d502-f270-4275-8ede-5cecc220bfb9, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:32:55,811 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c7e8d502-f270-4275-8ede-5cecc220bfb9, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:32:55,814 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c7e8d502-f270-4275-8ede-5cecc220bfb9, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:32:56,506 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:32:56,506 - 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-10-31 11:32:56,507 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:32:56,508 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e58e004d-c25e-4823-802d-06f549414b30, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:32:56,508 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e58e004d-c25e-4823-802d-06f549414b30, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:32:56,512 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e58e004d-c25e-4823-802d-06f549414b30, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:32:57,712 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:32:57,713 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:32:57,713 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 931f0166-a521-4dfe-8d7e-07eae8ae978b, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:32:57,714 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 931f0166-a521-4dfe-8d7e-07eae8ae978b, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:32:57,716 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 931f0166-a521-4dfe-8d7e-07eae8ae978b, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:32:58,109 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:32:58,110 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:32:58,111 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 88dd0056-9dff-47b4-90b1-917bad6ed779, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:32:58,112 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 88dd0056-9dff-47b4-90b1-917bad6ed779, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:32:58,116 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 88dd0056-9dff-47b4-90b1-917bad6ed779, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:32:58,807 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:32:58,808 - 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-10-31 11:32:58,808 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:32:58,809 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c16a6e22-6b67-4467-a3eb-f8ea46b5c74b, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:32:58,810 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c16a6e22-6b67-4467-a3eb-f8ea46b5c74b, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:32:58,811 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c16a6e22-6b67-4467-a3eb-f8ea46b5c74b, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:32:59,942 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:32:59,943 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:32:59,943 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ca388796-b00a-453a-b890-8861f11d6630, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:32:59,944 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ca388796-b00a-453a-b890-8861f11d6630, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:32:59,946 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ca388796-b00a-453a-b890-8861f11d6630, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:33:00,326 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:00,327 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:00,328 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8b514dda-0d9f-4dc4-ac99-2a3a59f5adf7, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:33:00,328 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8b514dda-0d9f-4dc4-ac99-2a3a59f5adf7, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:33:00,330 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8b514dda-0d9f-4dc4-ac99-2a3a59f5adf7, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:33:01,255 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:01,255 - 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-10-31 11:33:01,256 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:01,257 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, cb3ad669-ae08-44d2-b970-97908d9cdeea, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:33:01,257 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, cb3ad669-ae08-44d2-b970-97908d9cdeea, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:33:01,259 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, cb3ad669-ae08-44d2-b970-97908d9cdeea, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:33:02,373 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:02,373 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:02,374 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9c61f88e-4e5c-4477-aba9-2330b2969ad1, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:33:02,375 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9c61f88e-4e5c-4477-aba9-2330b2969ad1, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:33:02,376 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9c61f88e-4e5c-4477-aba9-2330b2969ad1, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:33:02,859 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:02,859 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:02,860 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 94b3221b-bcdf-40f6-a461-4efef83d744e, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:33:02,861 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 94b3221b-bcdf-40f6-a461-4efef83d744e, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:33:02,862 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 94b3221b-bcdf-40f6-a461-4efef83d744e, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:33:03,453 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:03,454 - 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-10-31 11:33:03,454 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:03,455 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d1827429-978e-4ac3-a32d-b96bdd6ba6af, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:33:03,456 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d1827429-978e-4ac3-a32d-b96bdd6ba6af, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:33:03,457 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d1827429-978e-4ac3-a32d-b96bdd6ba6af, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:33:04,737 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:04,738 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:04,738 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, df40eb03-ea10-4b39-bd59-d2345284473a, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:33:04,739 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, df40eb03-ea10-4b39-bd59-d2345284473a, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:33:04,740 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, df40eb03-ea10-4b39-bd59-d2345284473a, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:33:04,997 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:04,998 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:04,999 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f730dcad-f4ea-4ef0-ad58-139c54fd9e40, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:33:05,000 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f730dcad-f4ea-4ef0-ad58-139c54fd9e40, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:33:05,001 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f730dcad-f4ea-4ef0-ad58-139c54fd9e40, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:33:05,701 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:05,702 - 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-10-31 11:33:05,703 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:05,703 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9f7a8f12-0606-48f7-903b-1fdef162c318, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:33:05,704 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9f7a8f12-0606-48f7-903b-1fdef162c318, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:33:05,710 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9f7a8f12-0606-48f7-903b-1fdef162c318, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:33:06,845 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:06,846 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:06,846 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2bf8ebd2-2e3f-4328-8941-d0a4db8f221b, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:33:06,847 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2bf8ebd2-2e3f-4328-8941-d0a4db8f221b, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:33:06,848 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2bf8ebd2-2e3f-4328-8941-d0a4db8f221b, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:33:07,137 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:07,137 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:07,138 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 00a96271-14e9-429e-a70c-1bf0bd0b6d4e, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:33:07,139 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 00a96271-14e9-429e-a70c-1bf0bd0b6d4e, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:33:07,141 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 00a96271-14e9-429e-a70c-1bf0bd0b6d4e, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:33:08,186 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:08,187 - 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-10-31 11:33:08,187 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:08,188 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, fa6d4134-ba48-4309-a07a-4afba39c5b77, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:33:08,189 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, fa6d4134-ba48-4309-a07a-4afba39c5b77, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:33:08,191 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, fa6d4134-ba48-4309-a07a-4afba39c5b77, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:33:09,312 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:09,312 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:09,313 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 37d86395-9637-4d53-b399-82c5fbe1c94c, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:33:09,314 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 37d86395-9637-4d53-b399-82c5fbe1c94c, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:33:09,315 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 37d86395-9637-4d53-b399-82c5fbe1c94c, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:33:09,614 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:09,615 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:09,616 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9fc8067a-1f18-4a64-a118-224859133ef6, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:33:09,617 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9fc8067a-1f18-4a64-a118-224859133ef6, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:33:09,620 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9fc8067a-1f18-4a64-a118-224859133ef6, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:33:10,428 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:10,429 - 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-10-31 11:33:10,430 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:10,431 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d72dbe3f-ee29-4bfe-b512-d59b96f183e7, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:33:10,431 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d72dbe3f-ee29-4bfe-b512-d59b96f183e7, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:33:10,437 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d72dbe3f-ee29-4bfe-b512-d59b96f183e7, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:33:11,513 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:11,514 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:11,515 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0546db78-50b5-40cd-9e4a-67a87256c7d2, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:33:11,515 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0546db78-50b5-40cd-9e4a-67a87256c7d2, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:33:11,517 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0546db78-50b5-40cd-9e4a-67a87256c7d2, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:33:11,809 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:11,810 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:11,810 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 69b604f7-2d32-472a-a58b-1591eb8874f6, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:33:11,811 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 69b604f7-2d32-472a-a58b-1591eb8874f6, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:33:11,813 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 69b604f7-2d32-472a-a58b-1591eb8874f6, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:33:12,042 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:12,043 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:12,044 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ee1fed97-05ba-47da-8e75-5166ab28643a, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:33:12,045 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ee1fed97-05ba-47da-8e75-5166ab28643a, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:33:12,046 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ee1fed97-05ba-47da-8e75-5166ab28643a, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:33:15,719 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:25,757 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:25,758 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f6c2def2-58be-4e0a-ac4c-660671e284f5, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:33:25,759 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f6c2def2-58be-4e0a-ac4c-660671e284f5, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:33:25,760 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f6c2def2-58be-4e0a-ac4c-660671e284f5, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:33:29,524 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:29,559 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-10-31 11:33:29,560 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:29,563 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 540d6502-d451-4ca4-9f42-974754c78b77, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:33:29,564 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 540d6502-d451-4ca4-9f42-974754c78b77, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:33:29,565 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 540d6502-d451-4ca4-9f42-974754c78b77, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:33:32,636 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:42,680 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:42,681 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8c81ed99-a136-49e1-88d5-aa44b1f6727b, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:33:42,682 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8c81ed99-a136-49e1-88d5-aa44b1f6727b, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:33:42,683 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8c81ed99-a136-49e1-88d5-aa44b1f6727b, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:33:47,119 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:57,157 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:33:57,158 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9f46da3d-b44b-4c22-b800-d3048acbd87a, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:33:57,159 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9f46da3d-b44b-4c22-b800-d3048acbd87a, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:33:57,162 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9f46da3d-b44b-4c22-b800-d3048acbd87a, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:33:57,775 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:07,781 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:07,782 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 44987e38-99c7-41f2-b60a-ad5e676bcaaa, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:07,783 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 44987e38-99c7-41f2-b60a-ad5e676bcaaa, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:34:07,784 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 44987e38-99c7-41f2-b60a-ad5e676bcaaa, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:08,237 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 11:34:08,238 - 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-10-31 11:34:08,269 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-10-31 11:34:08,270 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, f7fe67b6-9081-4eec-956d-4159484a8f20, localhost:12102): creating call state
2025-10-31 11:34:08,271 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, f7fe67b6-9081-4eec-956d-4159484a8f20, localhost:12102): request = { database: "/Root" }
2025-10-31 11:34:08,354 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, f7fe67b6-9081-4eec-956d-4159484a8f20, localhost:12102): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-xve6mkyrcq.auto.internal" port: 12102 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-10-31 11:34:08,355 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-xve6mkyrcq.auto.internal:12102, location 1, ssl: False>]>
2025-10-31 11:34:08,356 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:12102
2025-10-31 11:34:08,642 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:08,646 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8009216)
2025-10-31 11:34:08,647 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:08,648 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 078fdf09-58ff-4fe4-952d-ee299fbae488, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:08,648 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 078fdf09-58ff-4fe4-952d-ee299fbae488, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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-10-31 11:34:08,650 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 078fdf09-58ff-4fe4-952d-ee299fbae488, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:08,937 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:08,940 - INFO - ya.test - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_6_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 6])
2025-10-31 11:34:08,941 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:08,942 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4074bd4f-7633-492b-9b88-7d2d1511b62c, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:08,943 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4074bd4f-7633-492b-9b88-7d2d1511b62c, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_6_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 6)\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:08,944 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4074bd4f-7633-492b-9b88-7d2d1511b62c, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:11,993 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:11,994 - INFO - __tests__.alter_compression - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_6_compression created
2025-10-31 11:34:11,994 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:11,995 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 71fdc3e4-046c-46d0-a6f2-e9eae5f8db70, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:11,996 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 71fdc3e4-046c-46d0-a6f2-e9eae5f8db70, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_6_compression`" } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:11,997 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 71fdc3e4-046c-46d0-a6f2-e9eae5f8db70, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:12,785 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:12,786 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:12,786 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a1474afb-add5-445c-9748-381faa2f0e4f, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:12,787 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a1474afb-add5-445c-9748-381faa2f0e4f, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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_6_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:12,788 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a1474afb-add5-445c-9748-381faa2f0e4f, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:14,081 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:14,082 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:14,082 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e9f242b7-804c-499f-a838-4c9c0510aa5b, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:14,083 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e9f242b7-804c-499f-a838-4c9c0510aa5b, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:14,085 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e9f242b7-804c-499f-a838-4c9c0510aa5b, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:14,985 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:15,030 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:15,031 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b04aed21-36ca-4e65-91e5-59079519a775, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:15,032 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b04aed21-36ca-4e65-91e5-59079519a775, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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_6_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:15,035 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b04aed21-36ca-4e65-91e5-59079519a775, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:16,731 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:16,731 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318016, 'BlobCount': 128}}
2025-10-31 11:34:16,732 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:16,732 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 19840fd7-9375-4993-922a-32b694740f98, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:16,733 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 19840fd7-9375-4993-922a-32b694740f98, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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_6_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:16,734 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 19840fd7-9375-4993-922a-32b694740f98, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:17,868 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:17,869 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:17,870 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 27fa5533-65d4-411e-a9da-9a2c9b71df29, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:17,870 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 27fa5533-65d4-411e-a9da-9a2c9b71df29, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:17,872 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 27fa5533-65d4-411e-a9da-9a2c9b71df29, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:18,145 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:18,146 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:18,147 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 347d33eb-6af8-46d6-8044-e6bd2d955a39, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:18,147 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 347d33eb-6af8-46d6-8044-e6bd2d955a39, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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_6_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:18,148 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 347d33eb-6af8-46d6-8044-e6bd2d955a39, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:18,463 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:18,464 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 637312, 'BlobCount': 256}}
2025-10-31 11:34:18,464 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:18,465 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5d5f2221-4411-4ace-84cf-59ed0c3809da, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:18,466 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5d5f2221-4411-4ace-84cf-59ed0c3809da, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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_6_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:18,474 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5d5f2221-4411-4ace-84cf-59ed0c3809da, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:19,769 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:19,770 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:19,770 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5f3623d5-6caa-45d3-8fad-0f5649fec3ed, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:19,771 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5f3623d5-6caa-45d3-8fad-0f5649fec3ed, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:19,772 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5f3623d5-6caa-45d3-8fad-0f5649fec3ed, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:19,991 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:19,992 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:19,993 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 52fc64a8-4b01-476f-a0bd-e530d96146bf, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:19,994 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 52fc64a8-4b01-476f-a0bd-e530d96146bf, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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_6_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:19,995 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 52fc64a8-4b01-476f-a0bd-e530d96146bf, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:20,392 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:20,393 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 956352, 'BlobCount': 384}}
2025-10-31 11:34:20,394 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:20,394 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 309583c0-aee3-4fa8-bed6-5abccdc637aa, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:20,395 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 309583c0-aee3-4fa8-bed6-5abccdc637aa, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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_6_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:20,397 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 309583c0-aee3-4fa8-bed6-5abccdc637aa, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:21,438 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:21,439 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:21,440 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 925bd5a1-d21e-4eec-b590-e4312140f23f, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:21,441 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 925bd5a1-d21e-4eec-b590-e4312140f23f, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:21,442 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 925bd5a1-d21e-4eec-b590-e4312140f23f, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:21,669 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:21,670 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:21,671 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 83ae3b64-b045-4d88-892d-3a5c2e5f4d85, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:21,672 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 83ae3b64-b045-4d88-892d-3a5c2e5f4d85, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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_6_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:21,674 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 83ae3b64-b045-4d88-892d-3a5c2e5f4d85, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:22,069 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:22,070 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1275712, 'BlobCount': 512}}
2025-10-31 11:34:22,071 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:22,071 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c5a12fe3-b1da-4ba2-ae4c-2e7a25c8dcd5, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:22,072 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c5a12fe3-b1da-4ba2-ae4c-2e7a25c8dcd5, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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_6_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:22,073 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c5a12fe3-b1da-4ba2-ae4c-2e7a25c8dcd5, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:23,305 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:23,306 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:23,307 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1c00781b-9a90-4d21-ad99-5c6cdffb1dcd, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:23,307 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1c00781b-9a90-4d21-ad99-5c6cdffb1dcd, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:23,313 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1c00781b-9a90-4d21-ad99-5c6cdffb1dcd, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:23,543 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:23,544 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:23,544 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5a6f1b69-7753-43fc-8572-5b79689f2cd7, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:23,545 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5a6f1b69-7753-43fc-8572-5b79689f2cd7, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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_6_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:23,546 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5a6f1b69-7753-43fc-8572-5b79689f2cd7, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:23,921 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:23,922 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1594672, 'BlobCount': 640}}
2025-10-31 11:34:23,922 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:23,923 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 461aea35-80ea-47d8-a38e-5adbaff1a1ec, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:23,924 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 461aea35-80ea-47d8-a38e-5adbaff1a1ec, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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_6_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:23,925 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 461aea35-80ea-47d8-a38e-5adbaff1a1ec, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:25,138 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:25,139 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:25,139 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 15f55660-ffba-4b4f-adac-1f9706e14fee, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:25,140 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 15f55660-ffba-4b4f-adac-1f9706e14fee, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:25,142 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 15f55660-ffba-4b4f-adac-1f9706e14fee, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:25,487 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:25,488 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:25,489 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 732381e1-95b9-4a13-af3a-f1808b85f084, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:25,490 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 732381e1-95b9-4a13-af3a-f1808b85f084, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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_6_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:25,492 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 732381e1-95b9-4a13-af3a-f1808b85f084, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:26,011 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:26,012 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1913856, 'BlobCount': 768}}
2025-10-31 11:34:26,012 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:26,013 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b5131880-8075-4096-a280-1e206c6aa546, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:26,014 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b5131880-8075-4096-a280-1e206c6aa546, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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_6_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:26,015 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b5131880-8075-4096-a280-1e206c6aa546, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:27,145 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:27,146 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:27,147 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 685a8bd6-2635-4055-bd7c-1478e68ae67a, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:27,147 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 685a8bd6-2635-4055-bd7c-1478e68ae67a, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:27,148 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 685a8bd6-2635-4055-bd7c-1478e68ae67a, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:27,401 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:27,402 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:27,402 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, dbc57207-57b9-44d9-956f-3bb5ac1db4f9, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:27,403 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, dbc57207-57b9-44d9-956f-3bb5ac1db4f9, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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_6_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:27,405 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, dbc57207-57b9-44d9-956f-3bb5ac1db4f9, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:27,967 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:27,968 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2232992, 'BlobCount': 896}}
2025-10-31 11:34:27,969 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:27,969 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d5487731-c618-47b1-9082-9f36ec484721, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:27,970 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d5487731-c618-47b1-9082-9f36ec484721, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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_6_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:27,972 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d5487731-c618-47b1-9082-9f36ec484721, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:29,157 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:29,157 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:29,158 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4b3ada42-0cf5-425a-812b-73bed52dd919, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:29,159 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4b3ada42-0cf5-425a-812b-73bed52dd919, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:29,160 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4b3ada42-0cf5-425a-812b-73bed52dd919, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:29,410 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:29,411 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:29,412 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 46770993-ba5d-43df-9d6c-eb849916ed2b, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:29,412 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 46770993-ba5d-43df-9d6c-eb849916ed2b, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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_6_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:29,413 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 46770993-ba5d-43df-9d6c-eb849916ed2b, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:29,953 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:29,954 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2552480, 'BlobCount': 1024}}
2025-10-31 11:34:29,955 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:29,955 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9406edeb-3533-447b-baf8-c068657053d6, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:29,956 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9406edeb-3533-447b-baf8-c068657053d6, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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_6_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:29,958 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9406edeb-3533-447b-baf8-c068657053d6, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:31,123 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:31,124 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:31,124 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e3fa50ff-104f-459f-b61c-ff4c2b27ffa7, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:31,125 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e3fa50ff-104f-459f-b61c-ff4c2b27ffa7, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:31,126 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e3fa50ff-104f-459f-b61c-ff4c2b27ffa7, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:31,344 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:31,345 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:31,346 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 19a5d331-2943-4e07-b6af-75208ec700a7, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:31,346 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 19a5d331-2943-4e07-b6af-75208ec700a7, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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_6_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:31,348 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 19a5d331-2943-4e07-b6af-75208ec700a7, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:31,993 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:31,994 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2871488, 'BlobCount': 1152}}
2025-10-31 11:34:31,994 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:31,995 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d2299603-45b2-4c79-b084-b2fa8580c18a, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:31,995 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d2299603-45b2-4c79-b084-b2fa8580c18a, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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_6_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:31,996 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d2299603-45b2-4c79-b084-b2fa8580c18a, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:33,325 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:33,326 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:33,327 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 29d833e3-7334-4764-a482-57f9e3fd7f49, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:33,327 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 29d833e3-7334-4764-a482-57f9e3fd7f49, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:33,330 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 29d833e3-7334-4764-a482-57f9e3fd7f49, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:33,586 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:33,587 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:33,587 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b01f4add-6e8a-4db3-b81a-1e0c9ef53cc8, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:33,588 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b01f4add-6e8a-4db3-b81a-1e0c9ef53cc8, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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_6_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:33,589 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b01f4add-6e8a-4db3-b81a-1e0c9ef53cc8, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:34,224 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:34,225 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3190992, 'BlobCount': 1280}}
2025-10-31 11:34:34,225 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:34,226 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7d957787-a8bc-44fe-af98-f5822ea038cc, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:34,226 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7d957787-a8bc-44fe-af98-f5822ea038cc, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_6_compression`" } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:34,227 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7d957787-a8bc-44fe-af98-f5822ea038cc, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:35,174 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:35,175 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:35,176 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 737f55a4-6f9e-4f8d-8888-3f222581bd11, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:35,176 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 737f55a4-6f9e-4f8d-8888-3f222581bd11, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:35,178 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 737f55a4-6f9e-4f8d-8888-3f222581bd11, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:35,485 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:35,486 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:35,486 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8eff2dfb-5a15-4ef1-8259-f8e7e602aa82, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:35,487 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8eff2dfb-5a15-4ef1-8259-f8e7e602aa82, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:35,489 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8eff2dfb-5a15-4ef1-8259-f8e7e602aa82, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:35,743 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:35,743 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:35,744 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a285c47c-079c-46e6-9de5-b28a8ea683df, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:35,745 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a285c47c-079c-46e6-9de5-b28a8ea683df, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_6_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:35,750 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a285c47c-079c-46e6-9de5-b28a8ea683df, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:39,323 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:49,384 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:49,385 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 99104aa8-5dee-4c3b-b759-a76e8364499d, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:49,386 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 99104aa8-5dee-4c3b-b759-a76e8364499d, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_6_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:49,387 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 99104aa8-5dee-4c3b-b759-a76e8364499d, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:52,441 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:52,484 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_6_compression`, volumes `value` (8000000, 1595496)
2025-10-31 11:34:52,484 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:52,485 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b1d8b347-83cc-4e46-9b72-fbda3ef5d2ce, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:52,486 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b1d8b347-83cc-4e46-9b72-fbda3ef5d2ce, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:52,487 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b1d8b347-83cc-4e46-9b72-fbda3ef5d2ce, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:52,775 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:52,776 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:34:52,776 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d95c4f20-ec7f-493c-b03c-a10e44753c8b, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:34:52,777 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d95c4f20-ec7f-493c-b03c-a10e44753c8b, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_6_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-10-31 11:34:52,778 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d95c4f20-ec7f-493c-b03c-a10e44753c8b, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:34:56,475 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:35:06,510 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:35:06,511 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 87851d0f-9264-4d1e-8fb7-44f1f006a093, ghrun-xve6mkyrcq.auto.internal:12102): creating call state
2025-10-31 11:35:06,512 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 87851d0f-9264-4d1e-8fb7-44f1f006a093, ghrun-xve6mkyrcq.auto.internal:12102): request = { session_id: "ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_6_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-10-31 11:35:06,514 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 87851d0f-9264-4d1e-8fb7-44f1f006a093, ghrun-xve6mkyrcq.auto.internal:12102): response = { <_MultiThreadedRendezvous object> }
2025-10-31 11:35:10,734 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NjQ5NmE2MmQtZDE0YzE0ZjEtY2M5YjIwMzQtMTcxOTM1OTU=
2025-10-31 11:35:10,797 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_6_compression`, volumes `value` (8000000, 1595496)
2025-10-31 11:35:10,797 - INFO - root - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_6_compression` 8092160 / 1595496: 5.071877334697173
2025-10-31 11:35:10,800 - INFO - ya.test - pytest_runtest_teardown: Test teardown
