2025-11-21 14:05:59,540 - INFO - ya.test.1143719  - pytest_runtest_setup: ####################################################################################################
2025-11-21 14:05:59,541 - INFO - ya.test.1143719  - pytest_runtest_setup: test_all_supported_compression[zstd_8_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 8]
2025-11-21 14:05:59,541 - INFO - ya.test.1143719  - pytest_runtest_setup: ####################################################################################################
2025-11-21 14:05:59,542 - INFO - ya.test.1143719  - pytest_runtest_setup: Test setup
2025-11-21 14:05:59,549 - DEBUG - ya.test.1143719  - _get_command_output_file: Command out will be placed to ydbd.out
2025-11-21 14:05:59,550 - DEBUG - ya.test.1143719  - _get_command_output_file: Command err will be placed to ydbd.err
2025-11-21 14:05:59,550 - DEBUG - ya.test.1143719  - execute: Executing '['/home/runner/.ya/build/build_root/evw0/005d8e/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-21 14:05:59,561 - DEBUG - ya.test.1143719  - execute: Command pid: 1146001
2025-11-21 14:06:00,839 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146001) rc: 0
2025-11-21 14:06:00,840 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146001) elapsed time (sec): 1.2721900939941406
2025-11-21 14:06:00,841 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146001) idrss: 0
2025-11-21 14:06:00,841 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146001) inblock: 0
2025-11-21 14:06:00,841 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146001) isrss: 0
2025-11-21 14:06:00,842 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146001) ixrss: 0
2025-11-21 14:06:00,842 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146001) majflt: 0
2025-11-21 14:06:00,842 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146001) maxrss: 485668
2025-11-21 14:06:00,844 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146001) minflt: 45652
2025-11-21 14:06:00,844 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146001) msgrcv: 0
2025-11-21 14:06:00,844 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146001) msgsnd: 0
2025-11-21 14:06:00,845 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146001) nivcsw: 174
2025-11-21 14:06:00,845 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146001) nsignals: 0
2025-11-21 14:06:00,845 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146001) nswap: 0
2025-11-21 14:06:00,846 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146001) nvcsw: 14
2025-11-21 14:06:00,846 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146001) oublock: 8
2025-11-21 14:06:00,846 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146001) stime: 0.26029199999999997
2025-11-21 14:06:00,851 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146001) utime: 0.550701
2025-11-21 14:06:00,852 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146001) wtime: 1.284
2025-11-21 14:06:00,852 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146001) output:
Arc info:
    Branch: unknown-vcs-branch
    Commit: THIS_REVISION_IS_A_DUMMY
    Author: ordinal
    Summary: No VCS
    Last Changed Rev: -1
    Last Changed Date: 2015-03-14T06:05:35.000000Z
Other info:
    Build by: runner
    Top src dir: 
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-acwccf6kvy    Host information: 
        Linux ghrun-acwccf6kvy 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/10302026024/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/10302026024/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -DCATBOOST_OPENSOURCE=yes -fsanitize=address -Daddress_sanitizer_enabled -fno-omit-frame-pointer -fsanitize-blacklist=/home/runner/actions_runner/_work/ydb/ydb/build/sanitize-blacklist.txt -fno-sanitize-link-runtime -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -std=c++20 -Wimport-preprocessor-directive-pedantic -Woverloaded-virtual -Wno-ambiguous-reversed-operator -Wno-defaulted-function-deleted -Wno-deprecated-anon-enum-enum-conversion -Wno-deprecated-enum-enum-conversion -Wno-deprecated-enum-float-conversion -Wno-deprecated-volatile -Wno-pessimizing-move -Wno-undefined-var-template -nostdinc++ -DCATBOOST_OPENSOURCE=yes -nostdinc++

2025-11-21 14:06:00,853 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146001) errors:

2025-11-21 14:06:00,853 - INFO - __tests__.base.1143719  - _setup_ydb: Arc info:
    Branch: unknown-vcs-branch
    Commit: THIS_REVISION_IS_A_DUMMY
    Author: ordinal
    Summary: No VCS
    Last Changed Rev: -1
    Last Changed Date: 2015-03-14T06:05:35.000000Z
Other info:
    Build by: runner
    Top src dir: 
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-acwccf6kvy    Host information: 
        Linux ghrun-acwccf6kvy 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/10302026024/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/10302026024/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -DCATBOOST_OPENSOURCE=yes -fsanitize=address -Daddress_sanitizer_enabled -fno-omit-frame-pointer -fsanitize-blacklist=/home/runner/actions_runner/_work/ydb/ydb/build/sanitize-blacklist.txt -fno-sanitize-link-runtime -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -std=c++20 -Wimport-preprocessor-directive-pedantic -Woverloaded-virtual -Wno-ambiguous-reversed-operator -Wno-defaulted-function-deleted -Wno-deprecated-anon-enum-enum-conversion -Wno-deprecated-enum-enum-conversion -Wno-deprecated-enum-float-conversion -Wno-deprecated-volatile -Wno-pessimizing-move -Wno-undefined-var-template -nostdinc++ -DCATBOOST_OPENSOURCE=yes -nostdinc++

2025-11-21 14:06:01,266 - DEBUG - ya.test.1143719  - get_binary: Binary was found by /home/runner/.ya/build/build_root/evw0/005d8e/ydb/apps/ydbd/ydbd
2025-11-21 14:06:01,276 - DEBUG - library.python.filelock.1143719  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/8060
2025-11-21 14:06:01,278 - DEBUG - ydb.tests.library.harness.kikimr_runner.1143719  - start: Working directory: /home/runner/.ya/build/build_root/evw0/005d8e/r3tmp/kikimr_cluster_hs4z7yxn
2025-11-21 14:06:01,423 - DEBUG - ya.test.1143719  - get_binary: Binary was found by /home/runner/.ya/build/build_root/evw0/005d8e/ydb/apps/ydbd/ydbd
2025-11-21 14:06:01,424 - DEBUG - library.python.filelock.1143719  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/15242
2025-11-21 14:06:01,425 - DEBUG - library.python.filelock.1143719  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/28183
2025-11-21 14:06:01,425 - DEBUG - library.python.filelock.1143719  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/22734
2025-11-21 14:06:01,426 - DEBUG - library.python.filelock.1143719  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/63620
2025-11-21 14:06:01,432 - INFO - ydb.tests.library.harness.kikimr_runner.1143719  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/evw0/005d8e/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/kikimr_configs"
2025-11-21 14:06:01,432 - INFO - ydb.tests.library.harness.kikimr_runner.1143719  - __make_run_command: Final command: /home/runner/.ya/build/build_root/evw0/005d8e/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/evw0/005d8e/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/node_1/logfile_yolnc1dd.log --grpc-port=15242 --mon-port=28183 --ic-port=8060
2025-11-21 14:06:01,433 - DEBUG - ydb.tests.library.harness.kikimr_runner.1143719  - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:15242/1, disk_size 68719476736
2025-11-21 14:06:01,433 - INFO - ydb.tests.library.harness.kikimr_runner.1143719  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/evw0/005d8e/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/kikimr_configs"
2025-11-21 14:06:01,434 - INFO - ydb.tests.library.harness.kikimr_runner.1143719  - __make_run_command: Final command: /home/runner/.ya/build/build_root/evw0/005d8e/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/evw0/005d8e/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/node_1/logfile_yolnc1dd.log --grpc-port=15242 --mon-port=28183 --ic-port=8060
2025-11-21 14:06:01,440 - DEBUG - ya.test.1143719  - execute: Executing '('/home/runner/.ya/build/build_root/evw0/005d8e/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/evw0/005d8e/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/evw0/005d8e/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/node_1/logfile_yolnc1dd.log', '--grpc-port=15242', '--mon-port=28183', '--ic-port=8060')' in '/home/runner/.ya/build/build_root/evw0/005d8e/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/node_1' (no wait)
2025-11-21 14:06:01,452 - DEBUG - ya.test.1143719  - execute: Command pid: 1146300
2025-11-21 14:06:01,453 - INFO - ydb.tests.library.harness.kikimr_runner.1143719  - start: Started node localhost:15242/1
2025-11-21 14:06:01,455 - DEBUG - ya.test.1143719  - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-11-21 14:06:01,456 - DEBUG - ya.test.1143719  - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-11-21 14:06:01,456 - DEBUG - ya.test.1143719  - execute: Executing '['/home/runner/.ya/build/build_root/evw0/005d8e/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-21 14:06:01,471 - DEBUG - ya.test.1143719  - execute: Command pid: 1146301
2025-11-21 14:06:02,587 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146301) rc: 0
2025-11-21 14:06:02,588 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146301) elapsed time (sec): 1.1095242500305176
2025-11-21 14:06:02,588 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146301) idrss: 0
2025-11-21 14:06:02,588 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146301) inblock: 0
2025-11-21 14:06:02,589 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146301) isrss: 0
2025-11-21 14:06:02,589 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146301) ixrss: 0
2025-11-21 14:06:02,590 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146301) majflt: 0
2025-11-21 14:06:02,590 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146301) maxrss: 485408
2025-11-21 14:06:02,591 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146301) minflt: 45619
2025-11-21 14:06:02,591 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146301) msgrcv: 0
2025-11-21 14:06:02,591 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146301) msgsnd: 0
2025-11-21 14:06:02,592 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146301) nivcsw: 193
2025-11-21 14:06:02,592 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146301) nsignals: 0
2025-11-21 14:06:02,592 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146301) nswap: 0
2025-11-21 14:06:02,615 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146301) nvcsw: 14
2025-11-21 14:06:02,616 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146301) oublock: 8
2025-11-21 14:06:02,616 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146301) stime: 0.237872
2025-11-21 14:06:02,616 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146301) utime: 0.567801
2025-11-21 14:06:02,617 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146301) wtime: 1.125
2025-11-21 14:06:02,617 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146301) output:
Arc info:
    Branch: unknown-vcs-branch
    Commit: THIS_REVISION_IS_A_DUMMY
    Author: ordinal
    Summary: No VCS
    Last Changed Rev: -1
    Last Changed Date: 2015-03-14T06:05:35.000000Z
Other info:
    Build by: runner
    Top src dir: 
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-acwccf6kvy    Host information: 
        Linux ghrun-acwccf6kvy 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/10302026024/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/10302026024/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -DCATBOOST_OPENSOURCE=yes -fsanitize=address -Daddress_sanitizer_enabled -fno-omit-frame-pointer -fsanitize-blacklist=/home/runner/actions_runner/_work/ydb/ydb/build/sanitize-blacklist.txt -fno-sanitize-link-runtime -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -std=c++20 -Wimport-preprocessor-directive-pedantic -Woverloaded-virtual -Wno-ambiguous-reversed-operator -Wno-defaulted-function-deleted -Wno-deprecated-anon-enum-enum-conversion -Wno-deprecated-enum-enum-conversion -Wno-deprecated-enum-float-conversion -Wno-deprecated-volatile -Wno-pessimizing-move -Wno-undefined-var-template -nostdinc++ -DCATBOOST_OPENSOURCE=yes -nostdinc++

2025-11-21 14:06:02,617 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1146301) errors:

2025-11-21 14:06:02,618 - INFO - ydb.tests.library.harness.kikimr_runner.1143719  - start: Node 1 version:
Arc info:
    Branch: unknown-vcs-branch
    Commit: THIS_REVISION_IS_A_DUMMY
    Author: ordinal
    Summary: No VCS
    Last Changed Rev: -1
    Last Changed Date: 2015-03-14T06:05:35.000000Z
Other info:
    Build by: runner
    Top src dir: 
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-acwccf6kvy    Host information: 
        Linux ghrun-acwccf6kvy 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64
2025-11-21 14:06:11,058 - DEBUG - ya.test.1143719  - get_binary: Binary was found by /home/runner/.ya/build/build_root/evw0/005d8e/ydb/apps/ydbd/ydbd
2025-11-21 14:06:11,059 - DEBUG - ydb.tests.library.harness.kikimr_runner.1143719  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/evw0/005d8e/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:15242', '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: 8060\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-21 14:06:11,060 - DEBUG - ya.test.1143719  - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-11-21 14:06:11,061 - DEBUG - ya.test.1143719  - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-11-21 14:06:11,061 - DEBUG - ya.test.1143719  - execute: Executing '['/home/runner/.ya/build/build_root/evw0/005d8e/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:15242', '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: 8060\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-21 14:06:11,079 - DEBUG - ya.test.1143719  - execute: Command pid: 1149373
2025-11-21 14:06:13,447 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1149373) rc: 0
2025-11-21 14:06:13,448 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1149373) elapsed time (sec): 2.3229124546051025
2025-11-21 14:06:13,448 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1149373) idrss: 0
2025-11-21 14:06:13,449 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1149373) inblock: 0
2025-11-21 14:06:13,449 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1149373) isrss: 0
2025-11-21 14:06:13,449 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1149373) ixrss: 0
2025-11-21 14:06:13,450 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1149373) majflt: 0
2025-11-21 14:06:13,450 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1149373) maxrss: 600684
2025-11-21 14:06:13,450 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1149373) minflt: 52061
2025-11-21 14:06:13,451 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1149373) msgrcv: 0
2025-11-21 14:06:13,451 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1149373) msgsnd: 0
2025-11-21 14:06:13,451 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1149373) nivcsw: 279
2025-11-21 14:06:13,452 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1149373) nsignals: 0
2025-11-21 14:06:13,452 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1149373) nswap: 0
2025-11-21 14:06:13,452 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1149373) nvcsw: 609
2025-11-21 14:06:13,452 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1149373) oublock: 8
2025-11-21 14:06:13,453 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1149373) stime: 0.309145
2025-11-21 14:06:13,453 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1149373) utime: 0.68643
2025-11-21 14:06:13,453 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1149373) wtime: 2.341
2025-11-21 14:06:13,454 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1149373) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-21 14:06:13,454 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1149373) errors:

2025-11-21 14:06:13,460 - DEBUG - ya.test.1143719  - get_binary: Binary was found by /home/runner/.ya/build/build_root/evw0/005d8e/ydb/apps/ydbd/ydbd
2025-11-21 14:06:13,461 - DEBUG - ydb.tests.library.harness.kikimr_runner.1143719  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/evw0/005d8e/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:15242', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']
2025-11-21 14:06:13,462 - DEBUG - ya.test.1143719  - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-11-21 14:06:13,469 - DEBUG - ya.test.1143719  - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-11-21 14:06:13,469 - DEBUG - ya.test.1143719  - execute: Executing '['/home/runner/.ya/build/build_root/evw0/005d8e/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:15242', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-21 14:06:13,479 - DEBUG - ya.test.1143719  - execute: Command pid: 1150062
2025-11-21 14:06:15,283 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1150062) rc: 0
2025-11-21 14:06:15,284 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1150062) elapsed time (sec): 1.8014099597930908
2025-11-21 14:06:15,284 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1150062) idrss: 0
2025-11-21 14:06:15,284 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1150062) inblock: 0
2025-11-21 14:06:15,285 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1150062) isrss: 0
2025-11-21 14:06:15,285 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1150062) ixrss: 0
2025-11-21 14:06:15,285 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1150062) majflt: 0
2025-11-21 14:06:15,286 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1150062) maxrss: 601324
2025-11-21 14:06:15,286 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1150062) minflt: 52087
2025-11-21 14:06:15,286 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1150062) msgrcv: 0
2025-11-21 14:06:15,286 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1150062) msgsnd: 0
2025-11-21 14:06:15,287 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1150062) nivcsw: 243
2025-11-21 14:06:15,287 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1150062) nsignals: 0
2025-11-21 14:06:15,287 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1150062) nswap: 0
2025-11-21 14:06:15,288 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1150062) nvcsw: 579
2025-11-21 14:06:15,288 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1150062) oublock: 8
2025-11-21 14:06:15,288 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1150062) stime: 0.25129399999999996
2025-11-21 14:06:15,289 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1150062) utime: 0.601198
2025-11-21 14:06:15,289 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1150062) wtime: 1.811
2025-11-21 14:06:15,289 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1150062) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-11-21 14:06:15,290 - DEBUG - ya.test.1143719  - _save_outputs: Command (pid 1150062) errors:

2025-11-21 14:06:15,290 - INFO - ydb.tests.library.harness.kikimr_runner.1143719  - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-21 14:06:15,420 - INFO - ydb.tests.library.harness.kikimr_runner.1143719  - __run: Cluster started and initialized
2025-11-21 14:06:15,538 - DEBUG - ydb.connection.1143719  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-21 14:06:15,541 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1143719  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-21 14:06:15,543 - DEBUG - ydb.connection.1143719  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-21 14:06:15,567 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1143719  - context_resolve: Resolving endpoints for database /Root
2025-11-21 14:06:15,568 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ListEndpoints, 8e0cb543-69d7-468e-a6b4-abe9b4b3e9f6, localhost:15242): creating call state
2025-11-21 14:06:15,569 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ListEndpoints, 8e0cb543-69d7-468e-a6b4-abe9b4b3e9f6, localhost:15242): request = { database: "/Root" }
2025-11-21 14:06:15,580 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ListEndpoints, 8e0cb543-69d7-468e-a6b4-abe9b4b3e9f6, localhost:15242): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-acwccf6kvy.auto.internal" port: 15242 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-11-21 14:06:15,581 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1143719  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-acwccf6kvy.auto.internal:15242, location 1, ssl: False>]>
2025-11-21 14:06:15,582 - DEBUG - ydb.connection.1143719  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-21 14:06:15,619 - DEBUG - ydb.connection.1143719  - close: Closing channel for endpoint localhost:15242
2025-11-21 14:06:15,622 - DEBUG - ydb.query.pool.1143719  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-21 14:06:15,624 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(CreateSession, fa5fc597-5f54-439a-a904-edcd5ccae09a, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:06:15,624 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(CreateSession, fa5fc597-5f54-439a-a904-edcd5ccae09a, ghrun-acwccf6kvy.auto.internal:15242): request = {  }
2025-11-21 14:06:15,632 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(CreateSession, fa5fc597-5f54-439a-a904-edcd5ccae09a, ghrun-acwccf6kvy.auto.internal:15242): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" node_id: 1 }
2025-11-21 14:06:15,633 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(AttachSession, 51d7f451-b21a-42e7-b6bb-b6488eb9cfa5, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:06:15,634 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(AttachSession, 51d7f451-b21a-42e7-b6bb-b6488eb9cfa5, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" }
2025-11-21 14:06:15,644 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(AttachSession, 51d7f451-b21a-42e7-b6bb-b6488eb9cfa5, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:15,665 - DEBUG - ydb.query.pool.1143719  - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:15,667 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 40734ae5-7ae4-4d54-a3e5-e6dd714ecaef, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:06:15,668 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 40734ae5-7ae4-4d54-a3e5-e6dd714ecaef, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/off_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"off\")\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:06:15,669 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 40734ae5-7ae4-4d54-a3e5-e6dd714ecaef, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:19,291 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:19,292 - INFO - __tests__.alter_compression.1143719  - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-11-21 14:06:19,293 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:19,294 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, bebb7f90-b2f2-448d-a543-a4b105152db7, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:06:19,295 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, bebb7f90-b2f2-448d-a543-a4b105152db7, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/off_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:06:19,296 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, bebb7f90-b2f2-448d-a543-a4b105152db7, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:20,947 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:20,948 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:20,949 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, e881a634-700f-47f3-ba70-f45432094aeb, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:06:20,950 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, e881a634-700f-47f3-ba70-f45432094aeb, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 0;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:06:20,954 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, e881a634-700f-47f3-ba70-f45432094aeb, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:22,396 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:22,396 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:22,397 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, dc7a6127-7a0b-42e5-b2d8-e99038909b34, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:06:22,398 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, dc7a6127-7a0b-42e5-b2d8-e99038909b34, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:06:22,400 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, dc7a6127-7a0b-42e5-b2d8-e99038909b34, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:24,336 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:24,337 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:24,337 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 7fdcd060-413d-499f-b0da-a9438de815be, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:06:24,338 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 7fdcd060-413d-499f-b0da-a9438de815be, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:06:24,340 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 7fdcd060-413d-499f-b0da-a9438de815be, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:27,130 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:27,131 - INFO - __tests__.alter_compression.1143719  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 1618432, 'BlobCount': 128}}
2025-11-21 14:06:27,131 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:27,132 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 1b374f82-509a-4daf-8e6f-2df33244d192, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:06:27,133 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 1b374f82-509a-4daf-8e6f-2df33244d192, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 100000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:06:27,134 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 1b374f82-509a-4daf-8e6f-2df33244d192, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:28,335 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:28,336 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:28,337 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, ad4a8c17-f3b4-4a37-8439-7e4b44000525, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:06:28,337 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, ad4a8c17-f3b4-4a37-8439-7e4b44000525, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:06:28,339 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, ad4a8c17-f3b4-4a37-8439-7e4b44000525, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:28,672 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:28,672 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:28,673 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, b4c51c1b-9470-41db-a130-33f5e0cc8c9e, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:06:28,674 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, b4c51c1b-9470-41db-a130-33f5e0cc8c9e, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:06:28,674 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, b4c51c1b-9470-41db-a130-33f5e0cc8c9e, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:29,174 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:29,175 - INFO - __tests__.alter_compression.1143719  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 3236864, 'BlobCount': 256}}
2025-11-21 14:06:29,176 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:29,176 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 850ea701-9a25-460e-90fd-19b9b8ec6fb0, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:06:29,177 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 850ea701-9a25-460e-90fd-19b9b8ec6fb0, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 200000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:06:29,187 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 850ea701-9a25-460e-90fd-19b9b8ec6fb0, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:30,503 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:30,549 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:30,550 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 385a1a8a-7d77-456a-b1e9-92d74e011128, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:06:30,551 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 385a1a8a-7d77-456a-b1e9-92d74e011128, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:06:30,556 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 385a1a8a-7d77-456a-b1e9-92d74e011128, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:31,094 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:31,095 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:31,175 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 4d96d4ba-c5bf-4498-a73d-b39995a5a0f1, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:06:31,176 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 4d96d4ba-c5bf-4498-a73d-b39995a5a0f1, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:06:31,178 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 4d96d4ba-c5bf-4498-a73d-b39995a5a0f1, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:32,390 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:32,391 - INFO - __tests__.alter_compression.1143719  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 4855296, 'BlobCount': 384}}
2025-11-21 14:06:32,391 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:32,392 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, a13af85c-e559-47f3-ba22-9c90845217c2, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:06:32,393 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, a13af85c-e559-47f3-ba22-9c90845217c2, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 300000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:06:32,401 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, a13af85c-e559-47f3-ba22-9c90845217c2, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:34,573 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:34,574 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:34,575 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 3aee09c5-294a-49b8-bf2f-4003d0cb3cf3, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:06:34,576 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 3aee09c5-294a-49b8-bf2f-4003d0cb3cf3, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:06:34,577 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 3aee09c5-294a-49b8-bf2f-4003d0cb3cf3, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:35,066 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:35,067 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:35,067 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 0c86dd89-8a5a-4d09-85f5-042c64a8cfd0, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:06:35,068 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 0c86dd89-8a5a-4d09-85f5-042c64a8cfd0, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:06:35,070 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 0c86dd89-8a5a-4d09-85f5-042c64a8cfd0, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:37,704 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:37,705 - INFO - __tests__.alter_compression.1143719  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 6473728, 'BlobCount': 512}}
2025-11-21 14:06:37,705 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:37,706 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, d8d3b87c-7395-491a-93d7-2c6b8cf57af3, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:06:37,711 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, d8d3b87c-7395-491a-93d7-2c6b8cf57af3, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 400000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:06:37,712 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, d8d3b87c-7395-491a-93d7-2c6b8cf57af3, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:39,397 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:39,398 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:39,399 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 8995798d-d1c3-44e0-bfc3-eabd35712f22, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:06:39,400 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 8995798d-d1c3-44e0-bfc3-eabd35712f22, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:06:39,402 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 8995798d-d1c3-44e0-bfc3-eabd35712f22, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:39,926 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:39,927 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:39,928 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 00c34f38-acee-437e-ada2-340c9f4ef5ca, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:06:39,929 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 00c34f38-acee-437e-ada2-340c9f4ef5ca, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:06:39,932 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 00c34f38-acee-437e-ada2-340c9f4ef5ca, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:41,503 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:41,503 - INFO - __tests__.alter_compression.1143719  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 8092160, 'BlobCount': 640}}
2025-11-21 14:06:41,504 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:41,505 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 84495711-9fe1-4c05-b08b-8c6759e893bb, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:06:41,506 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 84495711-9fe1-4c05-b08b-8c6759e893bb, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 500000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:06:41,528 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 84495711-9fe1-4c05-b08b-8c6759e893bb, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:43,627 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:43,627 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:43,628 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 47c44531-4708-43a4-a087-7feec5a6c493, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:06:43,629 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 47c44531-4708-43a4-a087-7feec5a6c493, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:06:43,630 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 47c44531-4708-43a4-a087-7feec5a6c493, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:44,316 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:44,317 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:44,318 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 2a0541e4-8371-4ae6-ba27-97f25257bb94, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:06:44,319 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 2a0541e4-8371-4ae6-ba27-97f25257bb94, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:06:44,323 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 2a0541e4-8371-4ae6-ba27-97f25257bb94, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:45,832 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:45,833 - INFO - __tests__.alter_compression.1143719  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 9710592, 'BlobCount': 768}}
2025-11-21 14:06:45,834 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:45,835 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 69d5721a-a116-4ff4-8cbd-7320ba314088, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:06:45,836 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 69d5721a-a116-4ff4-8cbd-7320ba314088, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 600000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:06:45,846 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 69d5721a-a116-4ff4-8cbd-7320ba314088, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:47,503 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:47,504 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:47,505 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 520f98ec-cf9a-4ee9-8330-26bb10ff824d, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:06:47,505 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 520f98ec-cf9a-4ee9-8330-26bb10ff824d, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:06:47,523 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 520f98ec-cf9a-4ee9-8330-26bb10ff824d, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:48,416 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:48,417 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:48,417 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 37b649cc-4981-40c1-8f8f-cdc852121cb8, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:06:48,418 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 37b649cc-4981-40c1-8f8f-cdc852121cb8, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:06:48,421 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 37b649cc-4981-40c1-8f8f-cdc852121cb8, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:50,995 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:50,995 - INFO - __tests__.alter_compression.1143719  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 11329024, 'BlobCount': 896}}
2025-11-21 14:06:50,996 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:50,997 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 8e8f86c5-6a04-41ff-a954-b7f8da363a72, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:06:50,998 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 8e8f86c5-6a04-41ff-a954-b7f8da363a72, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 700000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:06:51,002 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 8e8f86c5-6a04-41ff-a954-b7f8da363a72, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:52,768 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:52,769 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:52,770 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 2c63ddc5-7909-4d8c-8f76-9cfc4500a4c5, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:06:52,771 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 2c63ddc5-7909-4d8c-8f76-9cfc4500a4c5, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:06:52,779 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 2c63ddc5-7909-4d8c-8f76-9cfc4500a4c5, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:53,476 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:53,477 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:53,479 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, ca73c839-66ed-4f38-9f00-64a64db49831, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:06:53,480 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, ca73c839-66ed-4f38-9f00-64a64db49831, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:06:53,481 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, ca73c839-66ed-4f38-9f00-64a64db49831, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:57,100 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:57,101 - INFO - __tests__.alter_compression.1143719  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 12947456, 'BlobCount': 1024}}
2025-11-21 14:06:57,101 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:57,102 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 5ba425e2-4c0a-41ef-8631-d66ac616a4df, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:06:57,104 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 5ba425e2-4c0a-41ef-8631-d66ac616a4df, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 800000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:06:57,106 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 5ba425e2-4c0a-41ef-8631-d66ac616a4df, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:59,894 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:59,895 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:06:59,896 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 2ec6f9d3-875f-4642-bbf8-90ac6c448656, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:06:59,897 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 2ec6f9d3-875f-4642-bbf8-90ac6c448656, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:06:59,898 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 2ec6f9d3-875f-4642-bbf8-90ac6c448656, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:07:00,355 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:07:00,356 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:07:00,357 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, ebb80375-9edf-4f63-8990-41e1a8877f32, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:07:00,358 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, ebb80375-9edf-4f63-8990-41e1a8877f32, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:07:00,360 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, ebb80375-9edf-4f63-8990-41e1a8877f32, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:07:01,654 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:07:01,655 - INFO - __tests__.alter_compression.1143719  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 14565888, 'BlobCount': 1152}}
2025-11-21 14:07:01,655 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:07:01,656 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, a38b046e-313e-48fd-9291-6bdbd3679d2f, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:07:01,657 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, a38b046e-313e-48fd-9291-6bdbd3679d2f, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 900000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:07:01,658 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, a38b046e-313e-48fd-9291-6bdbd3679d2f, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:07:03,412 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:07:03,413 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:07:03,414 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 062b6199-2fc4-4947-afd7-e9be09a70d01, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:07:03,415 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 062b6199-2fc4-4947-afd7-e9be09a70d01, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:07:03,421 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 062b6199-2fc4-4947-afd7-e9be09a70d01, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:07:03,916 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:07:03,917 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:07:03,918 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 4d0851f2-a4f2-4c9d-9d2f-1d6fef51d3b7, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:07:03,920 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 4d0851f2-a4f2-4c9d-9d2f-1d6fef51d3b7, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:07:03,921 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 4d0851f2-a4f2-4c9d-9d2f-1d6fef51d3b7, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:07:05,762 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:07:05,763 - INFO - __tests__.alter_compression.1143719  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 16184320, 'BlobCount': 1280}}
2025-11-21 14:07:05,763 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:07:05,764 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, ac4c3a2f-dcfd-48bc-a7fd-6d630b4bc114, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:07:05,765 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, ac4c3a2f-dcfd-48bc-a7fd-6d630b4bc114, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/off_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:07:05,767 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, ac4c3a2f-dcfd-48bc-a7fd-6d630b4bc114, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:07:09,718 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:07:09,719 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:07:09,720 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, d1ee0eca-1c38-4737-8fa4-25ff7d611efc, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:07:09,720 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, d1ee0eca-1c38-4737-8fa4-25ff7d611efc, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:07:09,740 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, d1ee0eca-1c38-4737-8fa4-25ff7d611efc, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:07:10,415 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:07:10,416 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:07:10,417 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, d65e1790-917e-4492-beb8-a0e979c9fb08, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:07:10,417 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, d65e1790-917e-4492-beb8-a0e979c9fb08, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:07:10,431 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, d65e1790-917e-4492-beb8-a0e979c9fb08, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:07:11,208 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:07:11,208 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:07:11,209 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 002cf535-e46e-4d8f-9c57-0e8ffe8317f6, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:07:11,210 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 002cf535-e46e-4d8f-9c57-0e8ffe8317f6, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:07:11,214 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 002cf535-e46e-4d8f-9c57-0e8ffe8317f6, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:07:19,773 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:07:29,831 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:07:29,832 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 4454a1f7-8842-48a3-9b71-5659e3281c95, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:07:29,833 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 4454a1f7-8842-48a3-9b71-5659e3281c95, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:07:29,834 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 4454a1f7-8842-48a3-9b71-5659e3281c95, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:07:34,359 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:07:44,389 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:07:44,390 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, d93288cc-d087-4e3a-b806-03d1c5d28e0e, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:07:44,391 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, d93288cc-d087-4e3a-b806-03d1c5d28e0e, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:07:44,392 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, d93288cc-d087-4e3a-b806-03d1c5d28e0e, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:07:46,000 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:07:53,595 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1143719  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-21 14:07:53,596 - DEBUG - ydb.connection.1143719  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-21 14:07:53,633 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1143719  - context_resolve: Resolving endpoints for database /Root
2025-11-21 14:07:53,634 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ListEndpoints, 1bb88bdb-547c-4d9b-a6c4-476db7709ddd, localhost:15242): creating call state
2025-11-21 14:07:53,635 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ListEndpoints, 1bb88bdb-547c-4d9b-a6c4-476db7709ddd, localhost:15242): request = { database: "/Root" }
2025-11-21 14:07:53,649 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ListEndpoints, 1bb88bdb-547c-4d9b-a6c4-476db7709ddd, localhost:15242): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-acwccf6kvy.auto.internal" port: 15242 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-11-21 14:07:53,650 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1143719  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-acwccf6kvy.auto.internal:15242, location 1, ssl: False>]>
2025-11-21 14:07:53,650 - DEBUG - ydb.connection.1143719  - close: Closing channel for endpoint localhost:15242
2025-11-21 14:07:56,011 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:07:56,012 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, e3e4333b-cfc5-4d64-8839-f2880fec5270, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:07:56,013 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, e3e4333b-cfc5-4d64-8839-f2880fec5270, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:07:56,015 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, e3e4333b-cfc5-4d64-8839-f2880fec5270, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:07:57,237 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:07:57,242 - INFO - root.1143719  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8009216)
2025-11-21 14:07:57,243 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:07:57,244 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 5bca6c53-9ec3-4c3f-a3e8-edd5601475be, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:07:57,245 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 5bca6c53-9ec3-4c3f-a3e8-edd5601475be, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:07:57,246 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 5bca6c53-9ec3-4c3f-a3e8-edd5601475be, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:07:58,518 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:08,525 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:08,526 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, ec6fdb9d-0e86-4918-8e6c-6b77d589ae2d, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:08:08,527 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, ec6fdb9d-0e86-4918-8e6c-6b77d589ae2d, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:08,528 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, ec6fdb9d-0e86-4918-8e6c-6b77d589ae2d, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:11,592 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:11,597 - INFO - root.1143719  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8009216)
2025-11-21 14:08:11,598 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:11,598 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 955e6331-e85d-4e68-a266-c5d45cf13b6c, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:08:11,624 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 955e6331-e85d-4e68-a266-c5d45cf13b6c, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:11,626 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 955e6331-e85d-4e68-a266-c5d45cf13b6c, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:12,566 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:12,570 - INFO - ya.test.1143719  - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_8_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 8])
2025-11-21 14:08:12,572 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:12,573 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 10ece0de-5d04-40f1-9a6d-f89f651249e5, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:08:12,574 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 10ece0de-5d04-40f1-9a6d-f89f651249e5, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_8_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 8)\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:12,576 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 10ece0de-5d04-40f1-9a6d-f89f651249e5, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:21,551 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:21,552 - INFO - __tests__.alter_compression.1143719  - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_8_compression created
2025-11-21 14:08:21,553 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:21,554 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, b56acc89-27ff-49bd-a9f4-27a1d079219a, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:08:21,555 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, b56acc89-27ff-49bd-a9f4-27a1d079219a, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_8_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:21,556 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, b56acc89-27ff-49bd-a9f4-27a1d079219a, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:23,056 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:23,057 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:23,058 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, c7cc2707-fca1-494f-86af-43cc8e6a5478, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:08:23,061 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, c7cc2707-fca1-494f-86af-43cc8e6a5478, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 0;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:23,063 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, c7cc2707-fca1-494f-86af-43cc8e6a5478, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:27,790 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:27,791 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:27,792 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 8782d8b8-1764-4373-82fb-ce3b9322f2cb, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:08:27,793 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 8782d8b8-1764-4373-82fb-ce3b9322f2cb, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:27,794 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 8782d8b8-1764-4373-82fb-ce3b9322f2cb, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:30,242 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:30,243 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:30,244 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 42668f5a-9258-494b-997c-619c4185a2a7, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:08:30,245 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 42668f5a-9258-494b-997c-619c4185a2a7, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:30,260 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 42668f5a-9258-494b-997c-619c4185a2a7, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:33,505 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:33,553 - INFO - __tests__.alter_compression.1143719  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318016, 'BlobCount': 128}}
2025-11-21 14:08:33,554 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:33,559 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 89f36915-f666-401a-ba03-dd6c5e884ecf, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:08:33,560 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 89f36915-f666-401a-ba03-dd6c5e884ecf, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 100000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:33,562 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 89f36915-f666-401a-ba03-dd6c5e884ecf, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:37,648 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:37,649 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:37,650 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 0f7ad10d-d5f5-41bb-8850-f96f4cc6f10b, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:08:37,651 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 0f7ad10d-d5f5-41bb-8850-f96f4cc6f10b, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:37,652 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 0f7ad10d-d5f5-41bb-8850-f96f4cc6f10b, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:38,307 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:38,307 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:38,308 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 22420f69-95cf-4ba8-b771-a3f568967f5d, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:08:38,309 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 22420f69-95cf-4ba8-b771-a3f568967f5d, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:38,327 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 22420f69-95cf-4ba8-b771-a3f568967f5d, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:39,066 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:39,067 - INFO - __tests__.alter_compression.1143719  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 637312, 'BlobCount': 256}}
2025-11-21 14:08:39,067 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:39,068 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 65b91715-cb70-404b-adbe-dea6b950ede3, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:08:39,069 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 65b91715-cb70-404b-adbe-dea6b950ede3, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 200000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:39,075 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 65b91715-cb70-404b-adbe-dea6b950ede3, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:42,719 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:42,720 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:42,721 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 61edfd9e-7d7a-4d01-8cd4-0caa33f79baa, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:08:42,728 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 61edfd9e-7d7a-4d01-8cd4-0caa33f79baa, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:42,729 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 61edfd9e-7d7a-4d01-8cd4-0caa33f79baa, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:43,374 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:43,375 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:43,376 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, f07ad51d-eafb-42f7-be55-5e7f6079fb34, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:08:43,377 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, f07ad51d-eafb-42f7-be55-5e7f6079fb34, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:43,378 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, f07ad51d-eafb-42f7-be55-5e7f6079fb34, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:44,253 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:44,254 - INFO - __tests__.alter_compression.1143719  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 956352, 'BlobCount': 384}}
2025-11-21 14:08:44,254 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:44,255 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 858d9f86-1ef4-4da3-8bdb-ccd01d490162, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:08:44,256 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 858d9f86-1ef4-4da3-8bdb-ccd01d490162, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 300000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:44,258 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 858d9f86-1ef4-4da3-8bdb-ccd01d490162, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:48,268 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:48,269 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:48,270 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 90d8c5f7-ea42-40e3-8bd9-d3c40f356b26, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:08:48,271 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 90d8c5f7-ea42-40e3-8bd9-d3c40f356b26, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:48,274 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 90d8c5f7-ea42-40e3-8bd9-d3c40f356b26, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:49,115 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:49,116 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:49,116 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, c2312eb8-959b-4450-b0bf-1477d31b0b7b, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:08:49,117 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, c2312eb8-959b-4450-b0bf-1477d31b0b7b, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:49,124 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, c2312eb8-959b-4450-b0bf-1477d31b0b7b, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:50,468 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:50,469 - INFO - __tests__.alter_compression.1143719  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1275712, 'BlobCount': 512}}
2025-11-21 14:08:50,469 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:50,470 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 465f2154-14d6-4e71-9594-cea29f647c41, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:08:50,471 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 465f2154-14d6-4e71-9594-cea29f647c41, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 400000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:50,473 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 465f2154-14d6-4e71-9594-cea29f647c41, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:53,823 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:53,824 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:53,824 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, d0ef02ed-a927-4532-a77e-0c6e8c5eb6e0, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:08:53,825 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, d0ef02ed-a927-4532-a77e-0c6e8c5eb6e0, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:53,837 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, d0ef02ed-a927-4532-a77e-0c6e8c5eb6e0, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:54,357 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:54,358 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:54,359 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 77c854c1-bbdf-4a04-be11-52ff505b84ec, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:08:54,360 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 77c854c1-bbdf-4a04-be11-52ff505b84ec, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:54,362 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 77c854c1-bbdf-4a04-be11-52ff505b84ec, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:55,844 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:55,845 - INFO - __tests__.alter_compression.1143719  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1594672, 'BlobCount': 640}}
2025-11-21 14:08:55,846 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:08:55,847 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, a76323a6-aa4a-4c1e-b3a7-8716cdd240ef, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:08:55,848 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, a76323a6-aa4a-4c1e-b3a7-8716cdd240ef, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 500000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:55,849 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, a76323a6-aa4a-4c1e-b3a7-8716cdd240ef, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:01,355 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:01,356 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:01,356 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, dfe12e97-48bd-4ac8-b2a5-73edf7283bc5, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:09:01,357 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, dfe12e97-48bd-4ac8-b2a5-73edf7283bc5, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:01,364 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, dfe12e97-48bd-4ac8-b2a5-73edf7283bc5, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:01,968 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:01,968 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:01,969 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, ac356720-c040-4ef8-9b6c-6c89348a25b6, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:09:01,970 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, ac356720-c040-4ef8-9b6c-6c89348a25b6, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:01,972 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, ac356720-c040-4ef8-9b6c-6c89348a25b6, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:03,135 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:03,136 - INFO - __tests__.alter_compression.1143719  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1913856, 'BlobCount': 768}}
2025-11-21 14:09:03,137 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:03,138 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, fce2ed07-a8b6-4113-a3de-a234c9b6a268, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:09:03,167 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, fce2ed07-a8b6-4113-a3de-a234c9b6a268, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 600000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:03,169 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, fce2ed07-a8b6-4113-a3de-a234c9b6a268, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:06,949 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:06,949 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:06,950 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 8a5e0711-c9d8-4ec9-bbdf-4463c5b1910e, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:09:06,951 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 8a5e0711-c9d8-4ec9-bbdf-4463c5b1910e, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:06,954 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 8a5e0711-c9d8-4ec9-bbdf-4463c5b1910e, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:08,052 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:08,053 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:08,054 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 2639cac8-b82a-498f-97e3-b5cc88095983, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:09:08,055 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 2639cac8-b82a-498f-97e3-b5cc88095983, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:08,066 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 2639cac8-b82a-498f-97e3-b5cc88095983, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:09,304 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:09,305 - INFO - __tests__.alter_compression.1143719  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2232992, 'BlobCount': 896}}
2025-11-21 14:09:09,306 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:09,306 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, d287495c-869a-440c-bb72-2d4833196201, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:09:09,312 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, d287495c-869a-440c-bb72-2d4833196201, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 700000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:09,313 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, d287495c-869a-440c-bb72-2d4833196201, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:12,233 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:12,234 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:12,235 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 255b2977-ab42-460c-875e-283447b7fdb6, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:09:12,236 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 255b2977-ab42-460c-875e-283447b7fdb6, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:12,240 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 255b2977-ab42-460c-875e-283447b7fdb6, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:12,763 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:12,824 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:12,825 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 5a114610-3b9b-4742-844c-818b772e415b, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:09:12,825 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 5a114610-3b9b-4742-844c-818b772e415b, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:12,827 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 5a114610-3b9b-4742-844c-818b772e415b, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:13,755 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:13,756 - INFO - __tests__.alter_compression.1143719  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2552480, 'BlobCount': 1024}}
2025-11-21 14:09:13,756 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:13,757 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 855680fc-bcd8-4d85-a8eb-24e6b6685e6f, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:09:13,758 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 855680fc-bcd8-4d85-a8eb-24e6b6685e6f, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 800000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:13,760 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 855680fc-bcd8-4d85-a8eb-24e6b6685e6f, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:16,862 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:16,863 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:16,864 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 6bba466c-8433-4c86-8e1a-a513676fcfdb, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:09:16,865 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 6bba466c-8433-4c86-8e1a-a513676fcfdb, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:16,867 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 6bba466c-8433-4c86-8e1a-a513676fcfdb, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:17,552 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:17,553 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:17,554 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, b1388575-19fe-436a-9539-65cccb5f880a, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:09:17,555 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, b1388575-19fe-436a-9539-65cccb5f880a, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:17,557 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, b1388575-19fe-436a-9539-65cccb5f880a, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:19,025 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:19,025 - INFO - __tests__.alter_compression.1143719  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2871488, 'BlobCount': 1152}}
2025-11-21 14:09:19,026 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:19,026 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 21ebdcaf-fc78-47d4-a4c7-763acc51f5f3, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:09:19,027 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 21ebdcaf-fc78-47d4-a4c7-763acc51f5f3, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 900000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:19,029 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 21ebdcaf-fc78-47d4-a4c7-763acc51f5f3, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:22,659 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:22,660 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:22,661 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, b363e950-018d-4792-914f-d8d7fdcb385a, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:09:22,661 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, b363e950-018d-4792-914f-d8d7fdcb385a, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:22,663 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, b363e950-018d-4792-914f-d8d7fdcb385a, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:23,222 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:23,273 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:23,274 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 83d4726d-167e-474f-b25a-b2ca384b5322, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:09:23,275 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 83d4726d-167e-474f-b25a-b2ca384b5322, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:23,276 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 83d4726d-167e-474f-b25a-b2ca384b5322, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:23,303 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1143719  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-21 14:09:23,304 - DEBUG - ydb.connection.1143719  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-21 14:09:23,351 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1143719  - context_resolve: Resolving endpoints for database /Root
2025-11-21 14:09:23,353 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ListEndpoints, aeedc1dc-6eb4-4bcd-ad45-fffcb342e696, localhost:15242): creating call state
2025-11-21 14:09:23,357 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ListEndpoints, aeedc1dc-6eb4-4bcd-ad45-fffcb342e696, localhost:15242): request = { database: "/Root" }
2025-11-21 14:09:23,601 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ListEndpoints, aeedc1dc-6eb4-4bcd-ad45-fffcb342e696, localhost:15242): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-acwccf6kvy.auto.internal" port: 15242 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-11-21 14:09:23,602 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1143719  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-acwccf6kvy.auto.internal:15242, location 1, ssl: False>]>
2025-11-21 14:09:23,609 - DEBUG - ydb.connection.1143719  - close: Closing channel for endpoint localhost:15242
2025-11-21 14:09:25,492 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:25,493 - INFO - __tests__.alter_compression.1143719  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3190992, 'BlobCount': 1280}}
2025-11-21 14:09:25,494 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:25,494 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 65245c88-254a-4da8-ae7c-f809b5a9804f, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:09:25,495 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 65245c88-254a-4da8-ae7c-f809b5a9804f, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_8_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:25,497 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 65245c88-254a-4da8-ae7c-f809b5a9804f, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:28,145 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:28,145 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:28,146 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 355697f7-b1ec-4edf-a36c-f0762b87d081, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:09:28,147 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 355697f7-b1ec-4edf-a36c-f0762b87d081, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:28,155 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 355697f7-b1ec-4edf-a36c-f0762b87d081, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:29,040 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:29,041 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:29,041 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 05751297-1848-47be-99eb-147eca66438c, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:09:29,042 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 05751297-1848-47be-99eb-147eca66438c, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:29,045 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 05751297-1848-47be-99eb-147eca66438c, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:29,761 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:29,762 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:29,762 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 009be5ea-c11b-49dd-82ee-7259c1ab4468, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:09:29,777 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 009be5ea-c11b-49dd-82ee-7259c1ab4468, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:29,778 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 009be5ea-c11b-49dd-82ee-7259c1ab4468, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:38,252 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:48,411 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:48,412 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, d8acd961-518a-4840-8291-d5fbe31dd237, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:09:48,413 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, d8acd961-518a-4840-8291-d5fbe31dd237, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:48,414 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, d8acd961-518a-4840-8291-d5fbe31dd237, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:53,322 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:53,390 - INFO - root.1143719  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_8_compression`, volumes `value` (8000000, 1595496)
2025-11-21 14:09:53,391 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:53,392 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, cc15c1ae-8403-477b-b98d-47489acb31b3, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:09:53,393 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, cc15c1ae-8403-477b-b98d-47489acb31b3, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:53,394 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, cc15c1ae-8403-477b-b98d-47489acb31b3, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:54,113 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:54,119 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:09:54,119 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 9b01e1bc-fc24-42ad-9d63-1685a4125a17, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:09:54,120 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 9b01e1bc-fc24-42ad-9d63-1685a4125a17, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:54,135 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 9b01e1bc-fc24-42ad-9d63-1685a4125a17, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:10:00,750 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:10:10,879 - DEBUG - ydb.query.pool.1143719  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:10:10,880 - DEBUG - ydb.connection.1143719  - _prepare_call: RpcState(ExecuteQuery, 2e4e4725-ad8c-4123-8803-3a94ba5bf0a1, ghrun-acwccf6kvy.auto.internal:15242): creating call state
2025-11-21 14:10:10,881 - DEBUG - ydb.connection.1143719  - _log_request: RpcState(ExecuteQuery, 2e4e4725-ad8c-4123-8803-3a94ba5bf0a1, ghrun-acwccf6kvy.auto.internal:15242): request = { session_id: "ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:10:10,909 - DEBUG - ydb.connection.1143719  - _log_response: RpcState(ExecuteQuery, 2e4e4725-ad8c-4123-8803-3a94ba5bf0a1, ghrun-acwccf6kvy.auto.internal:15242): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:10:18,901 - DEBUG - ydb.query.pool.1143719  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzE0NjJmMzktYWVkMGRmZjctMWEwNGRlMjQtODUwYzg5NzY=
2025-11-21 14:10:19,063 - INFO - root.1143719  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_8_compression`, volumes `value` (8000000, 1595496)
2025-11-21 14:10:19,063 - INFO - root.1143719  - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_8_compression` 8009216 / 1595496: 5.019890993145705
2025-11-21 14:10:19,075 - INFO - ya.test.1143719  - pytest_runtest_teardown: Test teardown
