2025-12-23 17:49:26,338 - INFO - ya.test.2335926  - pytest_runtest_setup: ####################################################################################################
2025-12-23 17:49:26,338 - INFO - ya.test.2335926  - pytest_runtest_setup: test_all_supported_compression[zstd_18_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 18]
2025-12-23 17:49:26,339 - INFO - ya.test.2335926  - pytest_runtest_setup: ####################################################################################################
2025-12-23 17:49:26,339 - INFO - ya.test.2335926  - pytest_runtest_setup: Test setup
2025-12-23 17:49:26,341 - DEBUG - ya.test.2335926  - _get_command_output_file: Command out will be placed to ydbd.out
2025-12-23 17:49:26,342 - DEBUG - ya.test.2335926  - _get_command_output_file: Command err will be placed to ydbd.err
2025-12-23 17:49:26,343 - DEBUG - ya.test.2335926  - execute: Executing '['/home/runner/.ya/build/build_root/w2fb/001d8c/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-12-23 17:49:26,344 - DEBUG - ya.test.2335926  - execute: Command pid: 2336886
2025-12-23 17:49:27,073 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336886) rc: 0
2025-12-23 17:49:27,074 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336886) elapsed time (sec): 0.7274031639099121
2025-12-23 17:49:27,074 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336886) idrss: 0
2025-12-23 17:49:27,074 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336886) inblock: 0
2025-12-23 17:49:27,075 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336886) isrss: 0
2025-12-23 17:49:27,075 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336886) ixrss: 0
2025-12-23 17:49:27,075 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336886) majflt: 0
2025-12-23 17:49:27,076 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336886) maxrss: 502880
2025-12-23 17:49:27,077 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336886) minflt: 45863
2025-12-23 17:49:27,078 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336886) msgrcv: 0
2025-12-23 17:49:27,078 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336886) msgsnd: 0
2025-12-23 17:49:27,078 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336886) nivcsw: 80
2025-12-23 17:49:27,079 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336886) nsignals: 0
2025-12-23 17:49:27,079 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336886) nswap: 0
2025-12-23 17:49:27,079 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336886) nvcsw: 14
2025-12-23 17:49:27,079 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336886) oublock: 8
2025-12-23 17:49:27,080 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336886) stime: 0.189364
2025-12-23 17:49:27,080 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336886) utime: 0.47481199999999996
2025-12-23 17:49:27,080 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336886) wtime: 0.729
2025-12-23 17:49:27,081 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336886) output:
Git info:
    Commit: 36060cc90e9313d79d78f7e01e8251dfc0b9a307
    Branch: 
    Author: Pavel Velikhov <pavel.velikhov@gmail.com>
    Summary: Merge 11f4dd79bc2e09e94b7f6457af93c1ee041776e2 into 7a46c6293674d1de550a9922546b7e0022176cfa
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-yh5r7pxf7y    Host information: 
        Linux ghrun-yh5r7pxf7y 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/10492077879/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/10492077879/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-12-23 17:49:27,081 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336886) errors:

2025-12-23 17:49:27,082 - INFO - __tests__.base.2335926  - _setup_ydb: Git info:
    Commit: 36060cc90e9313d79d78f7e01e8251dfc0b9a307
    Branch: 
    Author: Pavel Velikhov <pavel.velikhov@gmail.com>
    Summary: Merge 11f4dd79bc2e09e94b7f6457af93c1ee041776e2 into 7a46c6293674d1de550a9922546b7e0022176cfa
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-yh5r7pxf7y    Host information: 
        Linux ghrun-yh5r7pxf7y 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/10492077879/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/10492077879/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-12-23 17:49:27,187 - DEBUG - ya.test.2335926  - get_binary: Binary was found by /home/runner/.ya/build/build_root/w2fb/001d8c/ydb/apps/ydbd/ydbd
2025-12-23 17:49:27,188 - DEBUG - library.python.filelock.2335926  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/20492
2025-12-23 17:49:27,190 - DEBUG - ydb.tests.library.harness.kikimr_runner.2335926  - start: Working directory: /home/runner/.ya/build/build_root/w2fb/001d8c/r3tmp/kikimr_cluster_r9y_z7sm
2025-12-23 17:49:27,226 - DEBUG - ya.test.2335926  - get_binary: Binary was found by /home/runner/.ya/build/build_root/w2fb/001d8c/ydb/apps/ydbd/ydbd
2025-12-23 17:49:27,227 - DEBUG - library.python.filelock.2335926  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/6953
2025-12-23 17:49:27,228 - DEBUG - library.python.filelock.2335926  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/30309
2025-12-23 17:49:27,228 - DEBUG - library.python.filelock.2335926  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/28202
2025-12-23 17:49:27,229 - DEBUG - library.python.filelock.2335926  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/9757
2025-12-23 17:49:27,230 - INFO - ydb.tests.library.harness.kikimr_runner.2335926  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/w2fb/001d8c/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk3/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_18_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.18/cluster/kikimr_configs"
2025-12-23 17:49:27,230 - INFO - ydb.tests.library.harness.kikimr_runner.2335926  - __make_run_command: Final command: /home/runner/.ya/build/build_root/w2fb/001d8c/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/w2fb/001d8c/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk3/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_18_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.18/cluster/node_1/logfile_vsg034um.log --grpc-port=6953 --mon-port=30309 --ic-port=20492
2025-12-23 17:49:27,231 - DEBUG - ydb.tests.library.harness.kikimr_runner.2335926  - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:6953/1, disk_size 68719476736
2025-12-23 17:49:27,231 - INFO - ydb.tests.library.harness.kikimr_runner.2335926  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/w2fb/001d8c/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk3/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_18_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.18/cluster/kikimr_configs"
2025-12-23 17:49:27,231 - INFO - ydb.tests.library.harness.kikimr_runner.2335926  - __make_run_command: Final command: /home/runner/.ya/build/build_root/w2fb/001d8c/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/w2fb/001d8c/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk3/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_18_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.18/cluster/node_1/logfile_vsg034um.log --grpc-port=6953 --mon-port=30309 --ic-port=20492
2025-12-23 17:49:27,232 - DEBUG - ya.test.2335926  - execute: Executing '('/home/runner/.ya/build/build_root/w2fb/001d8c/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/w2fb/001d8c/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk3/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_18_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.18/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/w2fb/001d8c/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk3/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_18_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.18/cluster/node_1/logfile_vsg034um.log', '--grpc-port=6953', '--mon-port=30309', '--ic-port=20492')' in '/home/runner/.ya/build/build_root/w2fb/001d8c/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk3/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_18_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.18/cluster/node_1' (no wait)
2025-12-23 17:49:27,247 - DEBUG - ya.test.2335926  - execute: Command pid: 2336970
2025-12-23 17:49:27,248 - INFO - ydb.tests.library.harness.kikimr_runner.2335926  - start: Started node localhost:6953/1
2025-12-23 17:49:27,250 - DEBUG - ya.test.2335926  - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-12-23 17:49:27,251 - DEBUG - ya.test.2335926  - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-12-23 17:49:27,251 - DEBUG - ya.test.2335926  - execute: Executing '['/home/runner/.ya/build/build_root/w2fb/001d8c/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-12-23 17:49:27,253 - DEBUG - ya.test.2335926  - execute: Command pid: 2336971
2025-12-23 17:49:28,048 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336971) rc: 0
2025-12-23 17:49:28,049 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336971) elapsed time (sec): 0.7938528060913086
2025-12-23 17:49:28,049 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336971) idrss: 0
2025-12-23 17:49:28,049 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336971) inblock: 0
2025-12-23 17:49:28,049 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336971) isrss: 0
2025-12-23 17:49:28,050 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336971) ixrss: 0
2025-12-23 17:49:28,050 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336971) majflt: 0
2025-12-23 17:49:28,050 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336971) maxrss: 513332
2025-12-23 17:49:28,051 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336971) minflt: 45873
2025-12-23 17:49:28,051 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336971) msgrcv: 0
2025-12-23 17:49:28,051 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336971) msgsnd: 0
2025-12-23 17:49:28,052 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336971) nivcsw: 128
2025-12-23 17:49:28,052 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336971) nsignals: 0
2025-12-23 17:49:28,052 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336971) nswap: 0
2025-12-23 17:49:28,052 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336971) nvcsw: 13
2025-12-23 17:49:28,053 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336971) oublock: 8
2025-12-23 17:49:28,053 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336971) stime: 0.18628899999999998
2025-12-23 17:49:28,053 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336971) utime: 0.5118659999999999
2025-12-23 17:49:28,053 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336971) wtime: 0.796
2025-12-23 17:49:28,054 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336971) output:
Git info:
    Commit: 36060cc90e9313d79d78f7e01e8251dfc0b9a307
    Branch: 
    Author: Pavel Velikhov <pavel.velikhov@gmail.com>
    Summary: Merge 11f4dd79bc2e09e94b7f6457af93c1ee041776e2 into 7a46c6293674d1de550a9922546b7e0022176cfa
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-yh5r7pxf7y    Host information: 
        Linux ghrun-yh5r7pxf7y 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/10492077879/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/10492077879/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-12-23 17:49:28,054 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2336971) errors:

2025-12-23 17:49:28,055 - INFO - ydb.tests.library.harness.kikimr_runner.2335926  - start: Node 1 version:
Git info:
    Commit: 36060cc90e9313d79d78f7e01e8251dfc0b9a307
    Branch: 
    Author: Pavel Velikhov <pavel.velikhov@gmail.com>
    Summary: Merge 11f4dd79bc2e09e94b7f6457af93c1ee041776e2 into 7a46c6293674d1de550a9922546b7e0022176cfa
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-yh5r7pxf7y    Host information: 
        Linux ghrun-yh5r7pxf7y 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64
2025-12-23 17:49:33,469 - DEBUG - ya.test.2335926  - get_binary: Binary was found by /home/runner/.ya/build/build_root/w2fb/001d8c/ydb/apps/ydbd/ydbd
2025-12-23 17:49:33,470 - DEBUG - ydb.tests.library.harness.kikimr_runner.2335926  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/w2fb/001d8c/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:6953', '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: 20492\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-12-23 17:49:33,471 - DEBUG - ya.test.2335926  - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-12-23 17:49:33,472 - DEBUG - ya.test.2335926  - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-12-23 17:49:33,508 - DEBUG - ya.test.2335926  - execute: Executing '['/home/runner/.ya/build/build_root/w2fb/001d8c/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:6953', '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: 20492\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-12-23 17:49:33,524 - DEBUG - ya.test.2335926  - execute: Command pid: 2339379
2025-12-23 17:49:34,981 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2339379) rc: 0
2025-12-23 17:49:34,982 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2339379) elapsed time (sec): 1.455150842666626
2025-12-23 17:49:34,982 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2339379) idrss: 0
2025-12-23 17:49:34,982 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2339379) inblock: 0
2025-12-23 17:49:34,983 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2339379) isrss: 0
2025-12-23 17:49:34,983 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2339379) ixrss: 0
2025-12-23 17:49:34,983 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2339379) majflt: 0
2025-12-23 17:49:34,984 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2339379) maxrss: 596564
2025-12-23 17:49:34,984 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2339379) minflt: 52447
2025-12-23 17:49:34,984 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2339379) msgrcv: 0
2025-12-23 17:49:34,985 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2339379) msgsnd: 0
2025-12-23 17:49:34,985 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2339379) nivcsw: 219
2025-12-23 17:49:34,985 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2339379) nsignals: 0
2025-12-23 17:49:34,986 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2339379) nswap: 0
2025-12-23 17:49:34,986 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2339379) nvcsw: 419
2025-12-23 17:49:34,986 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2339379) oublock: 8
2025-12-23 17:49:34,987 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2339379) stime: 0.303979
2025-12-23 17:49:34,987 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2339379) utime: 0.612429
2025-12-23 17:49:34,987 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2339379) wtime: 1.466
2025-12-23 17:49:34,988 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2339379) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-12-23 17:49:34,988 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2339379) errors:

2025-12-23 17:49:34,994 - DEBUG - ya.test.2335926  - get_binary: Binary was found by /home/runner/.ya/build/build_root/w2fb/001d8c/ydb/apps/ydbd/ydbd
2025-12-23 17:49:34,994 - DEBUG - ydb.tests.library.harness.kikimr_runner.2335926  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/w2fb/001d8c/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:6953', '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-12-23 17:49:34,996 - DEBUG - ya.test.2335926  - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-12-23 17:49:34,997 - DEBUG - ya.test.2335926  - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-12-23 17:49:34,997 - DEBUG - ya.test.2335926  - execute: Executing '['/home/runner/.ya/build/build_root/w2fb/001d8c/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:6953', '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-12-23 17:49:35,004 - DEBUG - ya.test.2335926  - execute: Command pid: 2340072
2025-12-23 17:49:36,368 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2340072) rc: 0
2025-12-23 17:49:36,369 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2340072) elapsed time (sec): 1.3549885749816895
2025-12-23 17:49:36,369 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2340072) idrss: 0
2025-12-23 17:49:36,370 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2340072) inblock: 0
2025-12-23 17:49:36,370 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2340072) isrss: 0
2025-12-23 17:49:36,370 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2340072) ixrss: 0
2025-12-23 17:49:36,370 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2340072) majflt: 0
2025-12-23 17:49:36,371 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2340072) maxrss: 596564
2025-12-23 17:49:36,371 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2340072) minflt: 52293
2025-12-23 17:49:36,371 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2340072) msgrcv: 0
2025-12-23 17:49:36,372 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2340072) msgsnd: 0
2025-12-23 17:49:36,372 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2340072) nivcsw: 224
2025-12-23 17:49:36,377 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2340072) nsignals: 0
2025-12-23 17:49:36,377 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2340072) nswap: 0
2025-12-23 17:49:36,377 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2340072) nvcsw: 661
2025-12-23 17:49:36,378 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2340072) oublock: 8
2025-12-23 17:49:36,378 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2340072) stime: 0.323851
2025-12-23 17:49:36,378 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2340072) utime: 0.592486
2025-12-23 17:49:36,379 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2340072) wtime: 1.362
2025-12-23 17:49:36,379 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2340072) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-12-23 17:49:36,379 - DEBUG - ya.test.2335926  - _save_outputs: Command (pid 2340072) errors:

2025-12-23 17:49:36,380 - INFO - ydb.tests.library.harness.kikimr_runner.2335926  - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-12-23 17:49:36,613 - INFO - ydb.tests.library.harness.kikimr_runner.2335926  - __run: Cluster started and initialized
2025-12-23 17:49:36,652 - DEBUG - ydb.connection.2335926  - 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', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-23 17:49:36,677 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2335926  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-23 17:49:36,678 - DEBUG - ydb.connection.2335926  - 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', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-23 17:49:36,732 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2335926  - context_resolve: Resolving endpoints for database /Root
2025-12-23 17:49:36,733 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ListEndpoints, 704be324-83a5-456c-89b8-d00a5b9e24e6, localhost:6953): creating call state
2025-12-23 17:49:36,735 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ListEndpoints, 704be324-83a5-456c-89b8-d00a5b9e24e6, localhost:6953): request = { database: "/Root" }
2025-12-23 17:49:36,745 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ListEndpoints, 704be324-83a5-456c-89b8-d00a5b9e24e6, localhost:6953): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-yh5r7pxf7y.auto.internal" port: 6953 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-12-23 17:49:36,746 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2335926  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-yh5r7pxf7y.auto.internal:6953, location 1, ssl: False>]>
2025-12-23 17:49:36,747 - DEBUG - ydb.connection.2335926  - 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', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-23 17:49:36,792 - DEBUG - ydb.connection.2335926  - close: Closing channel for endpoint localhost:6953
2025-12-23 17:49:36,796 - DEBUG - ydb.query.pool.2335926  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-23 17:49:36,798 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(CreateSession, f216bb49-28b7-4cda-8b53-47c15d2cafcf, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:49:36,798 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(CreateSession, f216bb49-28b7-4cda-8b53-47c15d2cafcf, ghrun-yh5r7pxf7y.auto.internal:6953): request = {  }
2025-12-23 17:49:36,810 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(CreateSession, f216bb49-28b7-4cda-8b53-47c15d2cafcf, ghrun-yh5r7pxf7y.auto.internal:6953): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" node_id: 1 }
2025-12-23 17:49:36,811 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(AttachSession, 4b34263c-a9aa-49f2-882d-e41eb5b53d4b, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:49:36,812 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(AttachSession, 4b34263c-a9aa-49f2-882d-e41eb5b53d4b, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" }
2025-12-23 17:49:36,821 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(AttachSession, 4b34263c-a9aa-49f2-882d-e41eb5b53d4b, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:36,844 - DEBUG - ydb.query.pool.2335926  - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:36,845 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, bb501f2c-8746-4930-93c6-c833dd67cebd, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:49:36,847 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, bb501f2c-8746-4930-93c6-c833dd67cebd, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:36,850 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, bb501f2c-8746-4930-93c6-c833dd67cebd, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:39,899 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:39,899 - INFO - __tests__.alter_compression.2335926  - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-12-23 17:49:39,900 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:39,900 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 8e21ed25-0d8a-4703-8b13-e30a64cfe805, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:49:39,901 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 8e21ed25-0d8a-4703-8b13-e30a64cfe805, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:39,904 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 8e21ed25-0d8a-4703-8b13-e30a64cfe805, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:41,046 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:41,047 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:41,048 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 9e7ba1ca-c5a6-429a-b5c1-4cca2f4f358f, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:49:41,049 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 9e7ba1ca-c5a6-429a-b5c1-4cca2f4f358f, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:41,051 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 9e7ba1ca-c5a6-429a-b5c1-4cca2f4f358f, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:42,264 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:42,265 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:42,266 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 6d15a110-d849-4b3e-95cb-e16d26309399, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:49:42,267 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 6d15a110-d849-4b3e-95cb-e16d26309399, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:42,269 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 6d15a110-d849-4b3e-95cb-e16d26309399, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:43,092 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:43,093 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:43,094 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, cb9724f6-754c-4e7f-9ad0-3021c3aad1b0, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:49:43,095 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, cb9724f6-754c-4e7f-9ad0-3021c3aad1b0, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:43,119 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, cb9724f6-754c-4e7f-9ad0-3021c3aad1b0, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:44,809 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:44,809 - INFO - __tests__.alter_compression.2335926  - 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-12-23 17:49:44,810 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:44,811 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, eb72128f-ee38-4d57-b263-dc61152a7ddb, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:49:44,812 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, eb72128f-ee38-4d57-b263-dc61152a7ddb, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:44,814 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, eb72128f-ee38-4d57-b263-dc61152a7ddb, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:46,278 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:46,279 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:46,280 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 60ae135a-1e06-4fe0-9d39-e1e19548eb81, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:49:46,281 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 60ae135a-1e06-4fe0-9d39-e1e19548eb81, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:46,285 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 60ae135a-1e06-4fe0-9d39-e1e19548eb81, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:46,674 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:46,675 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:46,675 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 94781e65-daed-485a-bccb-1cdf57d73cc1, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:49:46,679 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 94781e65-daed-485a-bccb-1cdf57d73cc1, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:46,680 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 94781e65-daed-485a-bccb-1cdf57d73cc1, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:47,037 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:47,038 - INFO - __tests__.alter_compression.2335926  - 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-12-23 17:49:47,039 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:47,040 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 83e4ab2c-ac1f-41f9-828e-e7b92f27f3ff, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:49:47,041 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 83e4ab2c-ac1f-41f9-828e-e7b92f27f3ff, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:47,042 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 83e4ab2c-ac1f-41f9-828e-e7b92f27f3ff, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:48,223 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:48,224 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:48,224 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, b9fab817-61da-47db-875a-b9d7093f6a53, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:49:48,225 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, b9fab817-61da-47db-875a-b9d7093f6a53, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:48,227 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, b9fab817-61da-47db-875a-b9d7093f6a53, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:48,472 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:48,473 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:48,474 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, d64c6664-24f9-47b3-afb4-44f8b65d07a5, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:49:48,475 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, d64c6664-24f9-47b3-afb4-44f8b65d07a5, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:48,477 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, d64c6664-24f9-47b3-afb4-44f8b65d07a5, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:48,868 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:48,869 - INFO - __tests__.alter_compression.2335926  - 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-12-23 17:49:48,870 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:48,871 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 59ee946b-4c4d-4db3-a3f7-a7307164d030, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:49:48,872 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 59ee946b-4c4d-4db3-a3f7-a7307164d030, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:48,880 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 59ee946b-4c4d-4db3-a3f7-a7307164d030, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:50,390 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:50,391 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:50,392 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, e14c8f6b-42c8-48cc-90fb-17021030ad11, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:49:50,393 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, e14c8f6b-42c8-48cc-90fb-17021030ad11, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:50,395 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, e14c8f6b-42c8-48cc-90fb-17021030ad11, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:50,682 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:50,684 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:50,684 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 3887ee87-0a56-4ede-ac4b-5ebd7523e830, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:49:50,686 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 3887ee87-0a56-4ede-ac4b-5ebd7523e830, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:50,688 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 3887ee87-0a56-4ede-ac4b-5ebd7523e830, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:51,757 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:51,758 - INFO - __tests__.alter_compression.2335926  - 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-12-23 17:49:51,758 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:51,759 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, df220c05-579e-445e-8163-a2b72cb07413, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:49:51,764 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, df220c05-579e-445e-8163-a2b72cb07413, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:51,770 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, df220c05-579e-445e-8163-a2b72cb07413, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:53,414 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:53,415 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:53,415 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, a22cace3-7759-4b6b-80e5-0415d9806452, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:49:53,416 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, a22cace3-7759-4b6b-80e5-0415d9806452, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:53,425 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, a22cace3-7759-4b6b-80e5-0415d9806452, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:53,930 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:53,931 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:53,931 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 831bc257-3960-4fac-8827-ed39e05d33f0, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:49:53,932 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 831bc257-3960-4fac-8827-ed39e05d33f0, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:53,934 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 831bc257-3960-4fac-8827-ed39e05d33f0, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:54,699 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:54,700 - INFO - __tests__.alter_compression.2335926  - 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-12-23 17:49:54,701 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:54,702 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 978c83c9-b01f-4d5c-9ebe-591d401c44bc, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:49:54,703 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 978c83c9-b01f-4d5c-9ebe-591d401c44bc, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:54,705 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 978c83c9-b01f-4d5c-9ebe-591d401c44bc, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:56,194 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:56,195 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:56,196 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, dfca3991-f1c8-446f-a3b1-114cbd558040, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:49:56,197 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, dfca3991-f1c8-446f-a3b1-114cbd558040, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:56,205 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, dfca3991-f1c8-446f-a3b1-114cbd558040, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:56,657 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:56,658 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:56,659 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 20e92a3f-87eb-4f84-b1b0-699b27dc299d, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:49:56,659 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 20e92a3f-87eb-4f84-b1b0-699b27dc299d, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:56,662 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 20e92a3f-87eb-4f84-b1b0-699b27dc299d, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:57,714 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:57,715 - INFO - __tests__.alter_compression.2335926  - 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-12-23 17:49:57,715 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:57,716 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 7c65a2a7-cfd8-40a8-bafc-cb11b4948d81, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:49:57,717 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 7c65a2a7-cfd8-40a8-bafc-cb11b4948d81, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:57,719 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 7c65a2a7-cfd8-40a8-bafc-cb11b4948d81, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:59,402 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:59,404 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:59,405 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, cc872474-dfea-4a54-847f-8db0a7f4ac3f, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:49:59,406 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, cc872474-dfea-4a54-847f-8db0a7f4ac3f, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:59,434 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, cc872474-dfea-4a54-847f-8db0a7f4ac3f, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:59,745 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:59,746 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:49:59,746 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 4be66481-4181-4955-89ce-22e217eed919, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:49:59,747 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 4be66481-4181-4955-89ce-22e217eed919, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:59,753 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 4be66481-4181-4955-89ce-22e217eed919, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:50:00,397 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:50:00,398 - INFO - __tests__.alter_compression.2335926  - 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-12-23 17:50:00,398 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:50:00,399 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 5bd5ca6a-7964-4eb3-a347-2e731877a51e, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:50:00,401 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 5bd5ca6a-7964-4eb3-a347-2e731877a51e, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:50:00,402 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 5bd5ca6a-7964-4eb3-a347-2e731877a51e, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:50:01,750 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:50:01,751 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:50:01,754 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 88ed59c4-7530-4ab3-aea0-95ca07f98308, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:50:01,755 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 88ed59c4-7530-4ab3-aea0-95ca07f98308, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:50:01,757 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 88ed59c4-7530-4ab3-aea0-95ca07f98308, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:50:02,073 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:50:02,074 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:50:02,075 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, b04b6666-2be0-42f4-8a86-3e7cd39c0ceb, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:50:02,076 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, b04b6666-2be0-42f4-8a86-3e7cd39c0ceb, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:50:02,077 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, b04b6666-2be0-42f4-8a86-3e7cd39c0ceb, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:50:02,742 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:50:02,743 - INFO - __tests__.alter_compression.2335926  - 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-12-23 17:50:02,743 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:50:02,746 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, ecb0e0c4-bad8-4af6-bfc9-143b4ce9bc52, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:50:02,748 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, ecb0e0c4-bad8-4af6-bfc9-143b4ce9bc52, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:50:02,749 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, ecb0e0c4-bad8-4af6-bfc9-143b4ce9bc52, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:50:04,169 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:50:04,170 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:50:04,170 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 4ebf47cf-cfcd-4de2-9415-32c6e4737761, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:50:04,171 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 4ebf47cf-cfcd-4de2-9415-32c6e4737761, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:50:04,173 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 4ebf47cf-cfcd-4de2-9415-32c6e4737761, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:50:04,661 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:50:04,662 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:50:04,663 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, e051cccf-38dd-4f40-8765-048bf3e3c542, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:50:04,670 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, e051cccf-38dd-4f40-8765-048bf3e3c542, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:50:04,672 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, e051cccf-38dd-4f40-8765-048bf3e3c542, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:50:05,823 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:50:05,824 - INFO - __tests__.alter_compression.2335926  - 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-12-23 17:50:05,825 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:50:05,826 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, b40ae109-5004-41b5-ba50-4804fc48a108, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:50:05,827 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, b40ae109-5004-41b5-ba50-4804fc48a108, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:50:05,829 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, b40ae109-5004-41b5-ba50-4804fc48a108, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:50:07,041 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:50:07,041 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:50:07,042 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, e5a4a2a8-99bf-45f1-8ba8-95f7da71773c, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:50:07,043 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, e5a4a2a8-99bf-45f1-8ba8-95f7da71773c, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:50:07,046 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, e5a4a2a8-99bf-45f1-8ba8-95f7da71773c, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:50:07,596 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:50:07,597 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:50:07,598 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 63458c69-d8ef-4d82-8c1c-e19a0ac7d3a4, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:50:07,599 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 63458c69-d8ef-4d82-8c1c-e19a0ac7d3a4, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:50:07,603 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 63458c69-d8ef-4d82-8c1c-e19a0ac7d3a4, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:50:09,647 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:50:09,648 - INFO - __tests__.alter_compression.2335926  - 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-12-23 17:50:09,648 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:50:09,649 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, a815e192-b4d9-482e-bde2-601e98772a5a, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:50:09,650 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, a815e192-b4d9-482e-bde2-601e98772a5a, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:50:09,654 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, a815e192-b4d9-482e-bde2-601e98772a5a, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:50:11,714 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:50:11,715 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:50:11,716 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 03a45d02-bfe5-4629-806f-02cd10d5853b, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:50:11,717 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 03a45d02-bfe5-4629-806f-02cd10d5853b, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:50:11,718 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 03a45d02-bfe5-4629-806f-02cd10d5853b, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:50:12,077 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:50:12,078 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:50:12,079 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 45c103ab-7f9d-4886-96e1-5b3e5e9362d3, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:50:12,079 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 45c103ab-7f9d-4886-96e1-5b3e5e9362d3, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:50:12,085 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 45c103ab-7f9d-4886-96e1-5b3e5e9362d3, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:50:12,583 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:50:12,584 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:50:12,585 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 8644f58c-47cc-4b10-9e92-13f247aa0b3b, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:50:12,586 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 8644f58c-47cc-4b10-9e92-13f247aa0b3b, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:50:12,597 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 8644f58c-47cc-4b10-9e92-13f247aa0b3b, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:50:16,928 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:50:27,021 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:50:27,022 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 1dedd66d-56aa-4188-b08f-6a5285ec9b43, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:50:27,023 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 1dedd66d-56aa-4188-b08f-6a5285ec9b43, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:50:27,025 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 1dedd66d-56aa-4188-b08f-6a5285ec9b43, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:50:30,839 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:50:30,880 - INFO - root.2335926  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-12-23 17:50:30,881 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:50:30,881 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 132bc3b5-e04c-4529-8bc5-771906bdd600, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:50:30,882 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 132bc3b5-e04c-4529-8bc5-771906bdd600, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:50:30,884 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 132bc3b5-e04c-4529-8bc5-771906bdd600, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:50:35,833 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:50:45,873 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:50:45,874 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 1cd96876-822c-4cbc-b2fb-87c813889e67, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:50:45,875 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 1cd96876-822c-4cbc-b2fb-87c813889e67, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:50:45,878 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 1cd96876-822c-4cbc-b2fb-87c813889e67, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:50:47,819 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:50:49,139 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2335926  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-23 17:50:49,140 - DEBUG - ydb.connection.2335926  - 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', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-23 17:50:49,162 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2335926  - context_resolve: Resolving endpoints for database /Root
2025-12-23 17:50:49,163 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ListEndpoints, 268ee620-9799-4da6-895e-412dea09e9fa, localhost:6953): creating call state
2025-12-23 17:50:49,163 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ListEndpoints, 268ee620-9799-4da6-895e-412dea09e9fa, localhost:6953): request = { database: "/Root" }
2025-12-23 17:50:49,172 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ListEndpoints, 268ee620-9799-4da6-895e-412dea09e9fa, localhost:6953): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-yh5r7pxf7y.auto.internal" port: 6953 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-12-23 17:50:49,174 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2335926  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-yh5r7pxf7y.auto.internal:6953, location 1, ssl: False>]>
2025-12-23 17:50:49,174 - DEBUG - ydb.connection.2335926  - close: Closing channel for endpoint localhost:6953
2025-12-23 17:50:57,832 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:50:57,833 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 1f7de584-5d49-4ef9-9228-dcad0c55436b, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:50:57,833 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 1f7de584-5d49-4ef9-9228-dcad0c55436b, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:50:57,835 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 1f7de584-5d49-4ef9-9228-dcad0c55436b, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:50:58,475 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:08,480 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:08,481 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 74ca37f5-fdca-42fe-a9ba-0f46399fca6b, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:51:08,486 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 74ca37f5-fdca-42fe-a9ba-0f46399fca6b, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:08,488 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 74ca37f5-fdca-42fe-a9ba-0f46399fca6b, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:09,241 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:09,246 - INFO - root.2335926  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8009216)
2025-12-23 17:51:09,246 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:09,247 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, f7e455b3-98e3-4f19-9eaf-eef6cb6d1f76, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:51:09,248 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, f7e455b3-98e3-4f19-9eaf-eef6cb6d1f76, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:09,250 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, f7e455b3-98e3-4f19-9eaf-eef6cb6d1f76, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:09,562 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:09,565 - INFO - ya.test.2335926  - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_18_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 18])
2025-12-23 17:51:09,566 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:09,567 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, ed8135fa-7c07-480f-86de-35f813b0a1eb, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:51:09,568 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, ed8135fa-7c07-480f-86de-35f813b0a1eb, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_18_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 18)\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:09,569 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, ed8135fa-7c07-480f-86de-35f813b0a1eb, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:13,224 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:13,225 - INFO - __tests__.alter_compression.2335926  - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_18_compression created
2025-12-23 17:51:13,226 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:13,227 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 22da9ad1-7f10-458d-996f-5431af0b5c61, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:51:13,228 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 22da9ad1-7f10-458d-996f-5431af0b5c61, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_18_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:13,233 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 22da9ad1-7f10-458d-996f-5431af0b5c61, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:14,178 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:14,179 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:14,180 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 04b04b6c-7080-4185-b15d-71a019391534, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:51:14,181 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 04b04b6c-7080-4185-b15d-71a019391534, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_18_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:14,184 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 04b04b6c-7080-4185-b15d-71a019391534, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:19,249 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:19,250 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:19,251 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 13c4bc95-4451-4594-8630-6e0367503ec6, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:51:19,252 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 13c4bc95-4451-4594-8630-6e0367503ec6, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:19,254 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 13c4bc95-4451-4594-8630-6e0367503ec6, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:20,267 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:20,268 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:20,269 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 15932ccb-d8a3-4532-bc4d-4cfb94cf8ec6, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:51:20,270 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 15932ccb-d8a3-4532-bc4d-4cfb94cf8ec6, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_18_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:20,271 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 15932ccb-d8a3-4532-bc4d-4cfb94cf8ec6, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:22,028 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:22,029 - INFO - __tests__.alter_compression.2335926  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_18_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318528, 'BlobCount': 128}}
2025-12-23 17:51:22,029 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:22,030 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 34e34a6a-4394-4fdc-91c7-47e189782433, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:51:22,031 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 34e34a6a-4394-4fdc-91c7-47e189782433, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_18_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:22,032 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 34e34a6a-4394-4fdc-91c7-47e189782433, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:27,853 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:27,854 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:27,855 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 452c6baa-c6d4-4adf-bc00-a6d300bfd562, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:51:27,856 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 452c6baa-c6d4-4adf-bc00-a6d300bfd562, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:27,857 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 452c6baa-c6d4-4adf-bc00-a6d300bfd562, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:28,303 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:28,303 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:28,304 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, cfef0a4f-2097-4daa-b00b-7bf0107467d8, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:51:28,305 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, cfef0a4f-2097-4daa-b00b-7bf0107467d8, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_18_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:28,309 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, cfef0a4f-2097-4daa-b00b-7bf0107467d8, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:28,680 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:28,681 - INFO - __tests__.alter_compression.2335926  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_18_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 637920, 'BlobCount': 256}}
2025-12-23 17:51:28,682 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:28,683 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 7cc276b8-c284-419a-be50-c624ae7282d2, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:51:28,684 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 7cc276b8-c284-419a-be50-c624ae7282d2, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_18_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:28,687 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 7cc276b8-c284-419a-be50-c624ae7282d2, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:34,361 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:34,361 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:34,362 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, b1221906-3cd4-4385-bc5a-c7b69f25ec5f, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:51:34,363 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, b1221906-3cd4-4385-bc5a-c7b69f25ec5f, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:34,367 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, b1221906-3cd4-4385-bc5a-c7b69f25ec5f, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:34,784 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:34,785 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:34,786 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 76e1575d-bc8a-4052-a840-c780512100db, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:51:34,787 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 76e1575d-bc8a-4052-a840-c780512100db, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_18_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:34,798 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 76e1575d-bc8a-4052-a840-c780512100db, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:35,582 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:35,583 - INFO - __tests__.alter_compression.2335926  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_18_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 956816, 'BlobCount': 384}}
2025-12-23 17:51:35,584 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:35,584 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 704a4650-63fe-498b-a99f-fa69092c0e64, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:51:35,585 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 704a4650-63fe-498b-a99f-fa69092c0e64, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_18_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:35,594 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 704a4650-63fe-498b-a99f-fa69092c0e64, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:41,605 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:41,606 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:41,607 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 041d98a3-28c5-4430-be1c-a3552da25f37, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:51:41,608 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 041d98a3-28c5-4430-be1c-a3552da25f37, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:41,609 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 041d98a3-28c5-4430-be1c-a3552da25f37, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:41,918 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:41,919 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:41,919 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, c02a3dd6-7c2b-42c2-9af7-6821d64e9a3a, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:51:41,920 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, c02a3dd6-7c2b-42c2-9af7-6821d64e9a3a, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_18_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:41,922 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, c02a3dd6-7c2b-42c2-9af7-6821d64e9a3a, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:42,375 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:42,376 - INFO - __tests__.alter_compression.2335926  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_18_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1276240, 'BlobCount': 512}}
2025-12-23 17:51:42,376 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:42,377 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 0eabf6d7-de87-4e55-aca9-63ebc4f299e2, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:51:42,378 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 0eabf6d7-de87-4e55-aca9-63ebc4f299e2, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_18_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:42,380 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 0eabf6d7-de87-4e55-aca9-63ebc4f299e2, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:47,165 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:47,166 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:47,167 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, f4a119a2-282e-4a2f-9a09-3af704b3b19d, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:51:47,168 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, f4a119a2-282e-4a2f-9a09-3af704b3b19d, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:47,170 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, f4a119a2-282e-4a2f-9a09-3af704b3b19d, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:47,436 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:47,437 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:47,438 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, d452bc17-b26d-45c4-9c8e-fdea3afe9f41, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:51:47,439 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, d452bc17-b26d-45c4-9c8e-fdea3afe9f41, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_18_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:47,440 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, d452bc17-b26d-45c4-9c8e-fdea3afe9f41, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:47,905 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:47,906 - INFO - __tests__.alter_compression.2335926  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_18_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1595136, 'BlobCount': 640}}
2025-12-23 17:51:47,906 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:47,907 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 413e9480-0c44-4d78-81f4-4a2ec43ed437, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:51:47,910 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 413e9480-0c44-4d78-81f4-4a2ec43ed437, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_18_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:47,912 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 413e9480-0c44-4d78-81f4-4a2ec43ed437, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:53,138 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:53,138 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:53,139 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 1de9e495-02be-40eb-af76-fa0e6aa13ea7, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:51:53,140 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 1de9e495-02be-40eb-af76-fa0e6aa13ea7, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:53,142 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 1de9e495-02be-40eb-af76-fa0e6aa13ea7, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:53,560 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:53,561 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:53,561 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, d058eedb-d4c8-42ff-b3d0-b6397543e071, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:51:53,562 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, d058eedb-d4c8-42ff-b3d0-b6397543e071, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_18_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:53,563 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, d058eedb-d4c8-42ff-b3d0-b6397543e071, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:54,295 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:54,309 - INFO - __tests__.alter_compression.2335926  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_18_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1914416, 'BlobCount': 768}}
2025-12-23 17:51:54,310 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:54,311 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 9cb063fb-859d-49a6-a674-6c9c7e8a5c12, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:51:54,312 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 9cb063fb-859d-49a6-a674-6c9c7e8a5c12, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_18_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:54,313 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 9cb063fb-859d-49a6-a674-6c9c7e8a5c12, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:59,517 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:59,519 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:59,519 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, b7a75191-a304-44ca-8ff7-409df3949527, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:51:59,520 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, b7a75191-a304-44ca-8ff7-409df3949527, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:59,527 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, b7a75191-a304-44ca-8ff7-409df3949527, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:59,865 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:59,866 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:51:59,866 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 21ddb441-7a73-446b-be08-6f7c3e58b08e, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:51:59,867 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 21ddb441-7a73-446b-be08-6f7c3e58b08e, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_18_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:59,869 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 21ddb441-7a73-446b-be08-6f7c3e58b08e, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:52:00,577 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:52:00,578 - INFO - __tests__.alter_compression.2335926  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_18_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2233456, 'BlobCount': 896}}
2025-12-23 17:52:00,578 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:52:00,579 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, df23b7d6-1e48-4ab0-b9d7-6a1c9296bab3, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:52:00,580 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, df23b7d6-1e48-4ab0-b9d7-6a1c9296bab3, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_18_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:52:00,582 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, df23b7d6-1e48-4ab0-b9d7-6a1c9296bab3, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:52:05,012 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:52:05,013 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:52:05,014 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 6b6a3104-8c40-4fe1-aaeb-1b85d5318c66, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:52:05,015 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 6b6a3104-8c40-4fe1-aaeb-1b85d5318c66, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:52:05,017 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 6b6a3104-8c40-4fe1-aaeb-1b85d5318c66, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:52:05,327 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:52:05,328 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:52:05,329 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, dc133ba3-7bc7-410e-b78f-c61bf7c50355, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:52:05,330 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, dc133ba3-7bc7-410e-b78f-c61bf7c50355, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_18_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:52:05,331 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, dc133ba3-7bc7-410e-b78f-c61bf7c50355, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:52:06,020 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:52:06,021 - INFO - __tests__.alter_compression.2335926  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_18_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2552960, 'BlobCount': 1024}}
2025-12-23 17:52:06,022 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:52:06,023 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 4cd1d7bd-8cca-4c5a-bf2b-eafcdb99c72a, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:52:06,024 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 4cd1d7bd-8cca-4c5a-bf2b-eafcdb99c72a, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_18_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:52:06,026 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 4cd1d7bd-8cca-4c5a-bf2b-eafcdb99c72a, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:52:10,192 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:52:10,193 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:52:10,194 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, dc05f1f1-f31a-4ecf-b8e2-f2b3b5e36a36, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:52:10,195 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, dc05f1f1-f31a-4ecf-b8e2-f2b3b5e36a36, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:52:10,197 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, dc05f1f1-f31a-4ecf-b8e2-f2b3b5e36a36, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:52:10,553 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:52:10,554 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:52:10,555 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 8f20f401-5143-4a88-9fbe-7c31560004b5, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:52:10,556 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 8f20f401-5143-4a88-9fbe-7c31560004b5, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_18_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:52:10,557 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 8f20f401-5143-4a88-9fbe-7c31560004b5, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:52:11,310 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:52:11,311 - INFO - __tests__.alter_compression.2335926  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_18_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2871840, 'BlobCount': 1152}}
2025-12-23 17:52:11,311 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:52:11,312 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, cda409ff-1efb-4a03-a0fd-2d78ae8cfc1d, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:52:11,313 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, cda409ff-1efb-4a03-a0fd-2d78ae8cfc1d, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_18_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:52:11,325 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, cda409ff-1efb-4a03-a0fd-2d78ae8cfc1d, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:52:11,966 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2335926  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-23 17:52:11,967 - DEBUG - ydb.connection.2335926  - 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', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-23 17:52:11,997 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2335926  - context_resolve: Resolving endpoints for database /Root
2025-12-23 17:52:11,998 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ListEndpoints, 1be964cd-556f-4203-9619-7b4fd849c1b2, localhost:6953): creating call state
2025-12-23 17:52:11,998 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ListEndpoints, 1be964cd-556f-4203-9619-7b4fd849c1b2, localhost:6953): request = { database: "/Root" }
2025-12-23 17:52:12,010 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ListEndpoints, 1be964cd-556f-4203-9619-7b4fd849c1b2, localhost:6953): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-yh5r7pxf7y.auto.internal" port: 6953 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-12-23 17:52:12,011 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2335926  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-yh5r7pxf7y.auto.internal:6953, location 1, ssl: False>]>
2025-12-23 17:52:12,012 - DEBUG - ydb.connection.2335926  - close: Closing channel for endpoint localhost:6953
2025-12-23 17:52:17,230 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:52:17,231 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:52:17,231 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 0cb189dc-6de2-4226-8b43-5f83ee83c9d1, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:52:17,232 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 0cb189dc-6de2-4226-8b43-5f83ee83c9d1, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:52:17,234 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 0cb189dc-6de2-4226-8b43-5f83ee83c9d1, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:52:17,634 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:52:17,635 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:52:17,636 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 38e8b06e-14ac-447a-ae01-2eeff6a29ad1, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:52:17,637 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 38e8b06e-14ac-447a-ae01-2eeff6a29ad1, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_18_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:52:17,638 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 38e8b06e-14ac-447a-ae01-2eeff6a29ad1, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:52:18,521 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:52:18,522 - INFO - __tests__.alter_compression.2335926  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_18_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3191408, 'BlobCount': 1280}}
2025-12-23 17:52:18,523 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:52:18,524 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 8d68f1a2-f90c-4363-94d8-8a4a92d723ac, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:52:18,525 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 8d68f1a2-f90c-4363-94d8-8a4a92d723ac, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_18_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:52:18,528 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 8d68f1a2-f90c-4363-94d8-8a4a92d723ac, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:52:20,242 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:52:20,243 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:52:20,244 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 124173a8-90b8-47ec-8ba3-1cba89a7aa8e, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:52:20,245 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 124173a8-90b8-47ec-8ba3-1cba89a7aa8e, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:52:20,246 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 124173a8-90b8-47ec-8ba3-1cba89a7aa8e, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:52:20,671 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:52:20,672 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:52:20,673 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 207faaf8-7990-4e18-94a3-2c807d853dad, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:52:20,674 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 207faaf8-7990-4e18-94a3-2c807d853dad, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:52:20,676 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 207faaf8-7990-4e18-94a3-2c807d853dad, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:52:21,099 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:52:21,100 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:52:21,101 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 9d78458b-f090-405c-885f-c959a2a85890, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:52:21,102 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 9d78458b-f090-405c-885f-c959a2a85890, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_18_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:52:21,104 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 9d78458b-f090-405c-885f-c959a2a85890, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:52:25,559 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:52:35,604 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:52:35,605 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 6822a289-7974-41dd-bc9a-dbc262d1bac8, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:52:35,606 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 6822a289-7974-41dd-bc9a-dbc262d1bac8, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_18_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:52:35,608 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 6822a289-7974-41dd-bc9a-dbc262d1bac8, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:52:39,241 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:52:39,310 - INFO - root.2335926  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_18_compression`, volumes `value` (8000000, 1595704)
2025-12-23 17:52:39,311 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:52:39,311 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 036be097-288b-4167-87e9-8f7e0d74ba76, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:52:39,312 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 036be097-288b-4167-87e9-8f7e0d74ba76, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:52:39,314 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 036be097-288b-4167-87e9-8f7e0d74ba76, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:52:39,702 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:52:39,703 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:52:39,704 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 74d6c38d-aaf5-472f-b6e9-8dab56a89cee, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:52:39,705 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 74d6c38d-aaf5-472f-b6e9-8dab56a89cee, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_18_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:52:39,706 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 74d6c38d-aaf5-472f-b6e9-8dab56a89cee, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:52:44,201 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:52:54,244 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:52:54,245 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, ad30c899-b56f-4515-9823-3bae3260dced, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:52:54,246 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, ad30c899-b56f-4515-9823-3bae3260dced, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_18_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:52:54,248 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, ad30c899-b56f-4515-9823-3bae3260dced, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:52:59,008 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:52:59,051 - INFO - root.2335926  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_18_compression`, volumes `value` (8000000, 1595704)
2025-12-23 17:52:59,051 - INFO - root.2335926  - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_18_compression` 8092160 / 1595704: 5.071216215538722
2025-12-23 17:52:59,063 - INFO - ya.test.2335926  - pytest_runtest_teardown: Test teardown
