2025-11-21 12:08:21,935 - INFO - ya.test.1722366  - pytest_runtest_setup: ####################################################################################################
2025-11-21 12:08:21,936 - INFO - ya.test.1722366  - pytest_runtest_setup: test_all_supported_compression[zstd_compression-COMPRESSION = "zstd"]
2025-11-21 12:08:21,936 - INFO - ya.test.1722366  - pytest_runtest_setup: ####################################################################################################
2025-11-21 12:08:21,940 - INFO - ya.test.1722366  - pytest_runtest_setup: Test setup
2025-11-21 12:08:21,942 - DEBUG - ya.test.1722366  - _get_command_output_file: Command out will be placed to ydbd.out
2025-11-21 12:08:21,948 - DEBUG - ya.test.1722366  - _get_command_output_file: Command err will be placed to ydbd.err
2025-11-21 12:08:21,949 - DEBUG - ya.test.1722366  - execute: Executing '['/home/runner/.ya/build/build_root/vsfo/002837/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-21 12:08:21,964 - DEBUG - ya.test.1722366  - execute: Command pid: 1723037
2025-11-21 12:08:22,744 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723037) rc: 0
2025-11-21 12:08:22,745 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723037) elapsed time (sec): 0.779365062713623
2025-11-21 12:08:22,745 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723037) idrss: 0
2025-11-21 12:08:22,746 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723037) inblock: 0
2025-11-21 12:08:22,746 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723037) isrss: 0
2025-11-21 12:08:22,746 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723037) ixrss: 0
2025-11-21 12:08:22,747 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723037) majflt: 0
2025-11-21 12:08:22,747 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723037) maxrss: 492420
2025-11-21 12:08:22,747 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723037) minflt: 45631
2025-11-21 12:08:22,748 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723037) msgrcv: 0
2025-11-21 12:08:22,748 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723037) msgsnd: 0
2025-11-21 12:08:22,748 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723037) nivcsw: 174
2025-11-21 12:08:22,749 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723037) nsignals: 0
2025-11-21 12:08:22,749 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723037) nswap: 0
2025-11-21 12:08:22,749 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723037) nvcsw: 14
2025-11-21 12:08:22,750 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723037) oublock: 8
2025-11-21 12:08:22,750 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723037) stime: 0.212576
2025-11-21 12:08:22,750 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723037) utime: 0.46993599999999996
2025-11-21 12:08:22,750 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723037) wtime: 0.795
2025-11-21 12:08:22,751 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723037) 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-ts5cnd6jre    Host information: 
        Linux ghrun-ts5cnd6jre 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 12:08:22,751 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723037) errors:

2025-11-21 12:08:22,752 - INFO - __tests__.base.1722366  - _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-ts5cnd6jre    Host information: 
        Linux ghrun-ts5cnd6jre 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 12:08:22,916 - DEBUG - ya.test.1722366  - get_binary: Binary was found by /home/runner/.ya/build/build_root/vsfo/002837/ydb/apps/ydbd/ydbd
2025-11-21 12:08:22,918 - DEBUG - library.python.filelock.1722366  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/18653
2025-11-21 12:08:22,920 - DEBUG - ydb.tests.library.harness.kikimr_runner.1722366  - start: Working directory: /home/runner/.ya/build/build_root/vsfo/002837/r3tmp/kikimr_cluster_vtcpx3pn
2025-11-21 12:08:23,012 - DEBUG - ya.test.1722366  - get_binary: Binary was found by /home/runner/.ya/build/build_root/vsfo/002837/ydb/apps/ydbd/ydbd
2025-11-21 12:08:23,013 - DEBUG - library.python.filelock.1722366  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/13786
2025-11-21 12:08:23,015 - DEBUG - library.python.filelock.1722366  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/16998
2025-11-21 12:08:23,015 - DEBUG - library.python.filelock.1722366  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/22902
2025-11-21 12:08:23,016 - DEBUG - library.python.filelock.1722366  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/17713
2025-11-21 12:08:23,017 - INFO - ydb.tests.library.harness.kikimr_runner.1722366  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/vsfo/002837/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_compression-COMPRESSION.=.zstd/cluster/kikimr_configs"
2025-11-21 12:08:23,017 - INFO - ydb.tests.library.harness.kikimr_runner.1722366  - __make_run_command: Final command: /home/runner/.ya/build/build_root/vsfo/002837/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/vsfo/002837/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_compression-COMPRESSION.=.zstd/cluster/node_1/logfile_vkv2tvv4.log --grpc-port=13786 --mon-port=16998 --ic-port=18653
2025-11-21 12:08:23,018 - DEBUG - ydb.tests.library.harness.kikimr_runner.1722366  - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:13786/1, disk_size 68719476736
2025-11-21 12:08:23,018 - INFO - ydb.tests.library.harness.kikimr_runner.1722366  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/vsfo/002837/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_compression-COMPRESSION.=.zstd/cluster/kikimr_configs"
2025-11-21 12:08:23,019 - INFO - ydb.tests.library.harness.kikimr_runner.1722366  - __make_run_command: Final command: /home/runner/.ya/build/build_root/vsfo/002837/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/vsfo/002837/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_compression-COMPRESSION.=.zstd/cluster/node_1/logfile_vkv2tvv4.log --grpc-port=13786 --mon-port=16998 --ic-port=18653
2025-11-21 12:08:23,025 - DEBUG - ya.test.1722366  - execute: Executing '('/home/runner/.ya/build/build_root/vsfo/002837/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/vsfo/002837/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_compression-COMPRESSION.=.zstd/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/vsfo/002837/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_compression-COMPRESSION.=.zstd/cluster/node_1/logfile_vkv2tvv4.log', '--grpc-port=13786', '--mon-port=16998', '--ic-port=18653')' in '/home/runner/.ya/build/build_root/vsfo/002837/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_compression-COMPRESSION.=.zstd/cluster/node_1' (no wait)
2025-11-21 12:08:23,043 - DEBUG - ya.test.1722366  - execute: Command pid: 1723401
2025-11-21 12:08:23,044 - INFO - ydb.tests.library.harness.kikimr_runner.1722366  - start: Started node localhost:13786/1
2025-11-21 12:08:23,046 - DEBUG - ya.test.1722366  - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-11-21 12:08:23,047 - DEBUG - ya.test.1722366  - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-11-21 12:08:23,047 - DEBUG - ya.test.1722366  - execute: Executing '['/home/runner/.ya/build/build_root/vsfo/002837/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-21 12:08:23,059 - DEBUG - ya.test.1722366  - execute: Command pid: 1723408
2025-11-21 12:08:24,051 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723408) rc: 0
2025-11-21 12:08:24,052 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723408) elapsed time (sec): 0.9906892776489258
2025-11-21 12:08:24,052 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723408) idrss: 0
2025-11-21 12:08:24,053 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723408) inblock: 0
2025-11-21 12:08:24,053 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723408) isrss: 0
2025-11-21 12:08:24,053 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723408) ixrss: 0
2025-11-21 12:08:24,054 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723408) majflt: 0
2025-11-21 12:08:24,054 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723408) maxrss: 497592
2025-11-21 12:08:24,054 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723408) minflt: 45656
2025-11-21 12:08:24,054 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723408) msgrcv: 0
2025-11-21 12:08:24,055 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723408) msgsnd: 0
2025-11-21 12:08:24,056 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723408) nivcsw: 201
2025-11-21 12:08:24,056 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723408) nsignals: 0
2025-11-21 12:08:24,057 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723408) nswap: 0
2025-11-21 12:08:24,057 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723408) nvcsw: 14
2025-11-21 12:08:24,057 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723408) oublock: 8
2025-11-21 12:08:24,058 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723408) stime: 0.24995799999999999
2025-11-21 12:08:24,058 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723408) utime: 0.48485399999999995
2025-11-21 12:08:24,058 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723408) wtime: 1.003
2025-11-21 12:08:24,059 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723408) 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-ts5cnd6jre    Host information: 
        Linux ghrun-ts5cnd6jre 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 12:08:24,059 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1723408) errors:

2025-11-21 12:08:24,060 - INFO - ydb.tests.library.harness.kikimr_runner.1722366  - 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-ts5cnd6jre    Host information: 
        Linux ghrun-ts5cnd6jre 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64
2025-11-21 12:08:30,512 - DEBUG - ya.test.1722366  - get_binary: Binary was found by /home/runner/.ya/build/build_root/vsfo/002837/ydb/apps/ydbd/ydbd
2025-11-21 12:08:30,513 - DEBUG - ydb.tests.library.harness.kikimr_runner.1722366  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/vsfo/002837/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:13786', '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: 18653\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-21 12:08:30,514 - DEBUG - ya.test.1722366  - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-11-21 12:08:30,515 - DEBUG - ya.test.1722366  - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-11-21 12:08:30,524 - DEBUG - ya.test.1722366  - execute: Executing '['/home/runner/.ya/build/build_root/vsfo/002837/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:13786', '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: 18653\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-21 12:08:30,547 - DEBUG - ya.test.1722366  - execute: Command pid: 1725844
2025-11-21 12:08:32,611 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1725844) rc: 0
2025-11-21 12:08:32,611 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1725844) elapsed time (sec): 2.061972141265869
2025-11-21 12:08:32,612 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1725844) idrss: 0
2025-11-21 12:08:32,612 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1725844) inblock: 0
2025-11-21 12:08:32,612 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1725844) isrss: 0
2025-11-21 12:08:32,612 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1725844) ixrss: 0
2025-11-21 12:08:32,613 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1725844) majflt: 0
2025-11-21 12:08:32,613 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1725844) maxrss: 588008
2025-11-21 12:08:32,613 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1725844) minflt: 51977
2025-11-21 12:08:32,614 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1725844) msgrcv: 0
2025-11-21 12:08:32,614 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1725844) msgsnd: 0
2025-11-21 12:08:32,614 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1725844) nivcsw: 302
2025-11-21 12:08:32,614 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1725844) nsignals: 0
2025-11-21 12:08:32,615 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1725844) nswap: 0
2025-11-21 12:08:32,615 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1725844) nvcsw: 336
2025-11-21 12:08:32,618 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1725844) oublock: 8
2025-11-21 12:08:32,619 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1725844) stime: 0.30242199999999997
2025-11-21 12:08:32,619 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1725844) utime: 0.6544949999999999
2025-11-21 12:08:32,619 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1725844) wtime: 2.086
2025-11-21 12:08:32,620 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1725844) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-21 12:08:32,620 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1725844) errors:

2025-11-21 12:08:32,622 - DEBUG - ya.test.1722366  - get_binary: Binary was found by /home/runner/.ya/build/build_root/vsfo/002837/ydb/apps/ydbd/ydbd
2025-11-21 12:08:32,622 - DEBUG - ydb.tests.library.harness.kikimr_runner.1722366  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/vsfo/002837/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:13786', '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 12:08:32,627 - DEBUG - ya.test.1722366  - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-11-21 12:08:32,628 - DEBUG - ya.test.1722366  - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-11-21 12:08:32,629 - DEBUG - ya.test.1722366  - execute: Executing '['/home/runner/.ya/build/build_root/vsfo/002837/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:13786', '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 12:08:32,636 - DEBUG - ya.test.1722366  - execute: Command pid: 1726285
2025-11-21 12:08:34,282 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1726285) rc: 0
2025-11-21 12:08:34,283 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1726285) elapsed time (sec): 1.6450088024139404
2025-11-21 12:08:34,283 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1726285) idrss: 0
2025-11-21 12:08:34,284 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1726285) inblock: 0
2025-11-21 12:08:34,284 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1726285) isrss: 0
2025-11-21 12:08:34,284 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1726285) ixrss: 0
2025-11-21 12:08:34,284 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1726285) majflt: 0
2025-11-21 12:08:34,285 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1726285) maxrss: 588008
2025-11-21 12:08:34,285 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1726285) minflt: 52102
2025-11-21 12:08:34,285 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1726285) msgrcv: 0
2025-11-21 12:08:34,286 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1726285) msgsnd: 0
2025-11-21 12:08:34,286 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1726285) nivcsw: 271
2025-11-21 12:08:34,286 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1726285) nsignals: 0
2025-11-21 12:08:34,287 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1726285) nswap: 0
2025-11-21 12:08:34,287 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1726285) nvcsw: 602
2025-11-21 12:08:34,288 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1726285) oublock: 8
2025-11-21 12:08:34,288 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1726285) stime: 0.309214
2025-11-21 12:08:34,288 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1726285) utime: 0.580461
2025-11-21 12:08:34,289 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1726285) wtime: 1.652
2025-11-21 12:08:34,289 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1726285) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-11-21 12:08:34,289 - DEBUG - ya.test.1722366  - _save_outputs: Command (pid 1726285) errors:

2025-11-21 12:08:34,290 - INFO - ydb.tests.library.harness.kikimr_runner.1722366  - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-21 12:08:34,462 - INFO - ydb.tests.library.harness.kikimr_runner.1722366  - __run: Cluster started and initialized
2025-11-21 12:08:34,536 - DEBUG - ydb.connection.1722366  - 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 12:08:34,556 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1722366  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-21 12:08:34,557 - DEBUG - ydb.connection.1722366  - 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 12:08:34,644 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1722366  - context_resolve: Resolving endpoints for database /Root
2025-11-21 12:08:34,645 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ListEndpoints, d3b6b317-48d5-4e8a-a4aa-ff1b2821a5f5, localhost:13786): creating call state
2025-11-21 12:08:34,646 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ListEndpoints, d3b6b317-48d5-4e8a-a4aa-ff1b2821a5f5, localhost:13786): request = { database: "/Root" }
2025-11-21 12:08:34,657 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ListEndpoints, d3b6b317-48d5-4e8a-a4aa-ff1b2821a5f5, localhost:13786): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-ts5cnd6jre.auto.internal" port: 13786 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 12:08:34,658 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1722366  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-ts5cnd6jre.auto.internal:13786, location 1, ssl: False>]>
2025-11-21 12:08:34,659 - DEBUG - ydb.connection.1722366  - 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 12:08:34,696 - DEBUG - ydb.connection.1722366  - close: Closing channel for endpoint localhost:13786
2025-11-21 12:08:34,697 - DEBUG - ydb.query.pool.1722366  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-21 12:08:34,698 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(CreateSession, 056dd714-9fda-402e-bf58-5259bada1d44, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:08:34,699 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(CreateSession, 056dd714-9fda-402e-bf58-5259bada1d44, ghrun-ts5cnd6jre.auto.internal:13786): request = {  }
2025-11-21 12:08:34,713 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(CreateSession, 056dd714-9fda-402e-bf58-5259bada1d44, ghrun-ts5cnd6jre.auto.internal:13786): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" node_id: 1 }
2025-11-21 12:08:34,714 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(AttachSession, 827e7ddb-0086-41fc-95eb-d2670981efd7, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:08:34,715 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(AttachSession, 827e7ddb-0086-41fc-95eb-d2670981efd7, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" }
2025-11-21 12:08:34,728 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(AttachSession, 827e7ddb-0086-41fc-95eb-d2670981efd7, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:08:34,747 - DEBUG - ydb.query.pool.1722366  - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:08:34,749 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, eb2462ec-c2e4-4635-9eb5-173958f330aa, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:08:34,750 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, eb2462ec-c2e4-4635-9eb5-173958f330aa, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:08:34,754 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, eb2462ec-c2e4-4635-9eb5-173958f330aa, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:08:41,636 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:08:41,637 - INFO - __tests__.alter_compression.1722366  - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-11-21 12:08:41,637 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:08:41,638 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 05632684-9ef4-499b-82ea-1edd18ba8cf3, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:08:41,642 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 05632684-9ef4-499b-82ea-1edd18ba8cf3, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:08:41,656 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 05632684-9ef4-499b-82ea-1edd18ba8cf3, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:08:43,736 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:08:43,737 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:08:43,738 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 9df8e391-82e0-4ce3-b40a-e01fd29b5f6e, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:08:43,738 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 9df8e391-82e0-4ce3-b40a-e01fd29b5f6e, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:08:43,744 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 9df8e391-82e0-4ce3-b40a-e01fd29b5f6e, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:08:45,347 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:08:45,348 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:08:45,349 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 75fc73e3-c247-4d98-935e-53f76f1afde4, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:08:45,349 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 75fc73e3-c247-4d98-935e-53f76f1afde4, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:08:45,353 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 75fc73e3-c247-4d98-935e-53f76f1afde4, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:08:46,616 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:08:46,617 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:08:46,618 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 9502d776-cc76-4570-965a-0e4201f1e118, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:08:46,619 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 9502d776-cc76-4570-965a-0e4201f1e118, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:08:46,632 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 9502d776-cc76-4570-965a-0e4201f1e118, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:08:49,104 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:08:49,105 - INFO - __tests__.alter_compression.1722366  - 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 12:08:49,111 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:08:49,112 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 31345d37-ef16-4e5d-bd3c-92944a6bda19, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:08:49,114 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 31345d37-ef16-4e5d-bd3c-92944a6bda19, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:08:49,117 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 31345d37-ef16-4e5d-bd3c-92944a6bda19, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:08:50,755 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:08:50,756 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:08:50,757 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 57583046-57fc-4320-8b76-c7d11c31a772, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:08:50,758 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 57583046-57fc-4320-8b76-c7d11c31a772, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:08:50,760 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 57583046-57fc-4320-8b76-c7d11c31a772, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:08:51,326 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:08:51,327 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:08:51,328 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 25ba3baa-01ab-44ab-a6c9-ec8326802ca7, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:08:51,329 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 25ba3baa-01ab-44ab-a6c9-ec8326802ca7, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:08:51,333 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 25ba3baa-01ab-44ab-a6c9-ec8326802ca7, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:08:52,115 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:08:52,117 - INFO - __tests__.alter_compression.1722366  - 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 12:08:52,117 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:08:52,118 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, aa6087e3-3946-4b41-b272-529b943e7f37, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:08:52,120 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, aa6087e3-3946-4b41-b272-529b943e7f37, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:08:52,121 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, aa6087e3-3946-4b41-b272-529b943e7f37, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:08:53,958 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:08:53,959 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:08:53,960 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 3c68d11e-66e1-490d-a7dd-ff4ee7f995d8, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:08:53,961 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 3c68d11e-66e1-490d-a7dd-ff4ee7f995d8, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:08:53,962 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 3c68d11e-66e1-490d-a7dd-ff4ee7f995d8, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:08:54,806 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:08:54,806 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:08:54,807 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 370849f1-374f-4ce9-822b-69f9ce7288c9, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:08:54,808 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 370849f1-374f-4ce9-822b-69f9ce7288c9, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:08:54,812 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 370849f1-374f-4ce9-822b-69f9ce7288c9, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:08:55,616 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:08:55,617 - INFO - __tests__.alter_compression.1722366  - 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 12:08:55,618 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:08:55,618 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 6b77a20a-49aa-4e7a-b698-4657bfbea36b, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:08:55,627 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 6b77a20a-49aa-4e7a-b698-4657bfbea36b, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:08:55,629 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 6b77a20a-49aa-4e7a-b698-4657bfbea36b, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:08:57,486 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:08:57,487 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:08:57,488 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 2a3bc0bd-19d3-480b-9cee-88b9bab75a94, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:08:57,489 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 2a3bc0bd-19d3-480b-9cee-88b9bab75a94, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:08:57,492 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 2a3bc0bd-19d3-480b-9cee-88b9bab75a94, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:08:58,261 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:08:58,262 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:08:58,263 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 89e30b53-95de-403c-ac22-b40a15acbe6d, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:08:58,264 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 89e30b53-95de-403c-ac22-b40a15acbe6d, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:08:58,266 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 89e30b53-95de-403c-ac22-b40a15acbe6d, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:08:59,946 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:08:59,947 - INFO - __tests__.alter_compression.1722366  - 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 12:08:59,947 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:08:59,948 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, bc54ddaf-8938-4f8a-887c-aac77a4637c8, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:08:59,949 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, bc54ddaf-8938-4f8a-887c-aac77a4637c8, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:08:59,951 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, bc54ddaf-8938-4f8a-887c-aac77a4637c8, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:02,092 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:02,093 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:02,093 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 68ec55bf-2431-407c-93cd-435df5f6fe26, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:09:02,094 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 68ec55bf-2431-407c-93cd-435df5f6fe26, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:09:02,108 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 68ec55bf-2431-407c-93cd-435df5f6fe26, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:02,779 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:02,780 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:02,781 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 61e77ee8-def9-44ed-9d0b-4e7139e79f7d, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:09:02,782 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 61e77ee8-def9-44ed-9d0b-4e7139e79f7d, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:09:02,785 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 61e77ee8-def9-44ed-9d0b-4e7139e79f7d, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:04,428 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:04,429 - INFO - __tests__.alter_compression.1722366  - 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 12:09:04,429 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:04,430 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 0fa60cfb-7354-4686-bbe5-89585689a312, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:09:04,432 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 0fa60cfb-7354-4686-bbe5-89585689a312, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:09:04,433 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 0fa60cfb-7354-4686-bbe5-89585689a312, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:06,252 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:06,252 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:06,253 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, ce8dd69d-b54d-48b8-afd6-fd8a92a316de, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:09:06,254 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, ce8dd69d-b54d-48b8-afd6-fd8a92a316de, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:09:06,258 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, ce8dd69d-b54d-48b8-afd6-fd8a92a316de, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:06,962 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:06,963 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:06,964 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, c4964d49-61f4-46be-b3a0-f71e701136ea, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:09:06,965 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, c4964d49-61f4-46be-b3a0-f71e701136ea, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:09:06,967 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, c4964d49-61f4-46be-b3a0-f71e701136ea, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:07,696 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:07,697 - INFO - __tests__.alter_compression.1722366  - 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 12:09:07,697 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:07,698 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 1eedfa28-d843-4037-b7c4-dd82c1e355ca, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:09:07,700 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 1eedfa28-d843-4037-b7c4-dd82c1e355ca, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:09:07,702 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 1eedfa28-d843-4037-b7c4-dd82c1e355ca, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:09,000 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:09,000 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:09,001 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, e99c1137-eb2b-4719-8330-895d61099e9d, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:09:09,002 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, e99c1137-eb2b-4719-8330-895d61099e9d, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:09:09,004 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, e99c1137-eb2b-4719-8330-895d61099e9d, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:09,381 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:09,382 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:09,382 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 93994b23-81a1-4dc5-ba68-996aa9da6d97, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:09:09,383 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 93994b23-81a1-4dc5-ba68-996aa9da6d97, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:09:09,386 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 93994b23-81a1-4dc5-ba68-996aa9da6d97, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:10,431 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:10,432 - INFO - __tests__.alter_compression.1722366  - 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 12:09:10,432 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:10,433 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, fb4c3f67-2bc8-413d-b0ff-ad78ebecc894, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:09:10,434 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, fb4c3f67-2bc8-413d-b0ff-ad78ebecc894, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:09:10,438 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, fb4c3f67-2bc8-413d-b0ff-ad78ebecc894, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:12,145 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:12,146 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:12,146 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 84816c53-a45e-4b97-a033-b8da4af7931a, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:09:12,147 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 84816c53-a45e-4b97-a033-b8da4af7931a, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:09:12,149 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 84816c53-a45e-4b97-a033-b8da4af7931a, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:12,729 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:12,730 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:12,731 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, bfa3a473-00c1-4ee4-a4df-bb0a3bcfe957, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:09:12,732 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, bfa3a473-00c1-4ee4-a4df-bb0a3bcfe957, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:09:12,734 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, bfa3a473-00c1-4ee4-a4df-bb0a3bcfe957, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:13,636 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:13,636 - INFO - __tests__.alter_compression.1722366  - 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 12:09:13,637 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:13,638 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 25e97101-686b-42e9-8972-5413725269d9, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:09:13,639 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 25e97101-686b-42e9-8972-5413725269d9, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:09:13,658 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 25e97101-686b-42e9-8972-5413725269d9, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:15,372 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:15,373 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:15,373 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 9acdaafb-8d1c-4cf2-b4a7-e1f388996dbc, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:09:15,374 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 9acdaafb-8d1c-4cf2-b4a7-e1f388996dbc, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:09:15,377 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 9acdaafb-8d1c-4cf2-b4a7-e1f388996dbc, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:15,760 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:15,761 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:15,762 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 03a21bcc-ef32-4f27-aca0-6834bdab2e77, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:09:15,763 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 03a21bcc-ef32-4f27-aca0-6834bdab2e77, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:09:15,765 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 03a21bcc-ef32-4f27-aca0-6834bdab2e77, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:16,920 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:16,921 - INFO - __tests__.alter_compression.1722366  - 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 12:09:16,921 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:16,922 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 1b478698-f6fa-4a2a-a7ed-3f694ca5c8da, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:09:16,923 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 1b478698-f6fa-4a2a-a7ed-3f694ca5c8da, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:09:16,925 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 1b478698-f6fa-4a2a-a7ed-3f694ca5c8da, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:18,489 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:18,490 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:18,491 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 674db636-9fdc-4663-add4-ebdd7ba4fb29, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:09:18,492 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 674db636-9fdc-4663-add4-ebdd7ba4fb29, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:09:18,493 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 674db636-9fdc-4663-add4-ebdd7ba4fb29, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:18,864 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:18,868 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:18,869 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 86b1d38d-40ea-4a28-be3a-0bac0029ab08, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:09:18,870 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 86b1d38d-40ea-4a28-be3a-0bac0029ab08, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:09:18,877 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 86b1d38d-40ea-4a28-be3a-0bac0029ab08, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:19,941 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:19,942 - INFO - __tests__.alter_compression.1722366  - 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 12:09:19,943 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:19,944 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, b0116ef6-8d45-4daf-a4a4-c7df826fb92e, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:09:19,944 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, b0116ef6-8d45-4daf-a4a4-c7df826fb92e, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:09:19,949 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, b0116ef6-8d45-4daf-a4a4-c7df826fb92e, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:21,732 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:21,733 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:21,734 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, f4a23ae0-0038-4750-b139-fa43a9a1f6d3, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:09:21,734 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, f4a23ae0-0038-4750-b139-fa43a9a1f6d3, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:09:21,736 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, f4a23ae0-0038-4750-b139-fa43a9a1f6d3, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:22,112 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:22,113 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:22,114 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 86ec1dae-c027-4dde-a492-da3e69198fe4, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:09:22,114 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 86ec1dae-c027-4dde-a492-da3e69198fe4, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:09:22,131 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 86ec1dae-c027-4dde-a492-da3e69198fe4, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:22,576 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:22,576 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:22,577 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 08331c01-f314-44ce-9cc4-0fd9065d9f65, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:09:22,578 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 08331c01-f314-44ce-9cc4-0fd9065d9f65, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:09:22,584 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 08331c01-f314-44ce-9cc4-0fd9065d9f65, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:28,170 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:38,223 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:38,224 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 9146b5f5-5e3d-4260-af3c-6a4a5c460252, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:09:38,225 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 9146b5f5-5e3d-4260-af3c-6a4a5c460252, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:09:38,226 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 9146b5f5-5e3d-4260-af3c-6a4a5c460252, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:42,846 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:42,930 - INFO - root.1722366  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-11-21 12:09:42,931 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:42,932 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, f3629662-b33a-4e47-988d-99a5303ec859, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:09:42,933 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, f3629662-b33a-4e47-988d-99a5303ec859, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:09:42,934 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, f3629662-b33a-4e47-988d-99a5303ec859, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:46,855 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:56,888 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:09:56,889 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 3827d0da-0331-4f4c-8742-715e2f7b22d2, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:09:56,890 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 3827d0da-0331-4f4c-8742-715e2f7b22d2, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:09:56,891 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 3827d0da-0331-4f4c-8742-715e2f7b22d2, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:58,048 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:07,286 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1722366  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-21 12:10:07,287 - DEBUG - ydb.connection.1722366  - 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 12:10:07,320 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1722366  - context_resolve: Resolving endpoints for database /Root
2025-11-21 12:10:07,321 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ListEndpoints, 82386109-11bb-4cb2-9abb-d323178d933e, localhost:13786): creating call state
2025-11-21 12:10:07,322 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ListEndpoints, 82386109-11bb-4cb2-9abb-d323178d933e, localhost:13786): request = { database: "/Root" }
2025-11-21 12:10:07,331 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ListEndpoints, 82386109-11bb-4cb2-9abb-d323178d933e, localhost:13786): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-ts5cnd6jre.auto.internal" port: 13786 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 12:10:07,332 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1722366  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-ts5cnd6jre.auto.internal:13786, location 1, ssl: False>]>
2025-11-21 12:10:07,333 - DEBUG - ydb.connection.1722366  - close: Closing channel for endpoint localhost:13786
2025-11-21 12:10:08,056 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:08,057 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, c21dfba2-5158-4b02-89bd-5e1d31576c34, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:08,058 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, c21dfba2-5158-4b02-89bd-5e1d31576c34, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:10:08,059 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, c21dfba2-5158-4b02-89bd-5e1d31576c34, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:09,354 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:09,358 - INFO - root.1722366  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8009216)
2025-11-21 12:10:09,359 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:09,361 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, ab81c407-9fc3-40cf-a48e-4dd709b4f57f, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:09,362 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, ab81c407-9fc3-40cf-a48e-4dd709b4f57f, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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 12:10:09,363 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, ab81c407-9fc3-40cf-a48e-4dd709b4f57f, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:09,660 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:09,669 - INFO - ya.test.1722366  - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_compression-COMPRESSION = "zstd"])
2025-11-21 12:10:09,670 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:09,684 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 9db72a66-69fc-4139-ba9f-c2f42c79bb5f, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:09,685 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 9db72a66-69fc-4139-ba9f-c2f42c79bb5f, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\")\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:09,699 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 9db72a66-69fc-4139-ba9f-c2f42c79bb5f, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:14,314 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:14,315 - INFO - __tests__.alter_compression.1722366  - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_compression created
2025-11-21 12:10:14,316 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:14,317 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 738bc7f0-56a8-4e17-9a39-d7c699b0b004, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:14,317 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 738bc7f0-56a8-4e17-9a39-d7c699b0b004, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:14,319 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 738bc7f0-56a8-4e17-9a39-d7c699b0b004, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:15,661 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:15,662 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:15,662 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 1be8fdb3-7984-4633-a77d-15cd4ffc6f6b, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:15,663 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 1be8fdb3-7984-4633-a77d-15cd4ffc6f6b, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:15,668 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 1be8fdb3-7984-4633-a77d-15cd4ffc6f6b, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:17,250 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:17,250 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:17,251 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 9d5fbc1b-464e-4604-82d7-5cf3a9fa7192, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:17,252 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 9d5fbc1b-464e-4604-82d7-5cf3a9fa7192, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:17,254 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 9d5fbc1b-464e-4604-82d7-5cf3a9fa7192, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:18,292 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:18,293 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:18,294 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 538e1299-3da6-4708-8537-da7f42505777, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:18,294 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 538e1299-3da6-4708-8537-da7f42505777, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:18,296 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 538e1299-3da6-4708-8537-da7f42505777, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:20,585 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:20,586 - INFO - __tests__.alter_compression.1722366  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318880, 'BlobCount': 128}}
2025-11-21 12:10:20,586 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:20,587 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, d1100501-f6c3-4230-9f34-922afc8493ca, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:20,588 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, d1100501-f6c3-4230-9f34-922afc8493ca, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:20,589 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, d1100501-f6c3-4230-9f34-922afc8493ca, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:21,957 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:21,958 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:21,959 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, c5e2b79d-eeb9-4b23-974a-aa8953eed22f, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:21,960 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, c5e2b79d-eeb9-4b23-974a-aa8953eed22f, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:21,964 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, c5e2b79d-eeb9-4b23-974a-aa8953eed22f, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:22,696 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:22,697 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:22,698 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 1cbd6312-dde1-4cca-8229-6b930a876d6b, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:22,699 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 1cbd6312-dde1-4cca-8229-6b930a876d6b, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:22,701 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 1cbd6312-dde1-4cca-8229-6b930a876d6b, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:23,222 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:23,223 - INFO - __tests__.alter_compression.1722366  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 638384, 'BlobCount': 256}}
2025-11-21 12:10:23,223 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:23,224 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, fb14939a-3ae6-40ea-b98f-c1c2965f4894, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:23,225 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, fb14939a-3ae6-40ea-b98f-c1c2965f4894, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:23,226 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, fb14939a-3ae6-40ea-b98f-c1c2965f4894, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:24,752 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:24,753 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:24,754 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, bc60e7e7-2ba5-4940-81e9-b58c42d0f3f0, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:24,755 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, bc60e7e7-2ba5-4940-81e9-b58c42d0f3f0, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:24,761 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, bc60e7e7-2ba5-4940-81e9-b58c42d0f3f0, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:25,128 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:25,129 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:25,130 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 12849b35-35f4-472f-884f-bc3f82915390, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:25,131 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 12849b35-35f4-472f-884f-bc3f82915390, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:25,133 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 12849b35-35f4-472f-884f-bc3f82915390, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:25,725 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:25,725 - INFO - __tests__.alter_compression.1722366  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 957552, 'BlobCount': 384}}
2025-11-21 12:10:25,726 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:25,726 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, b0bb4201-f5ea-4aa5-aac2-868ea1720b4a, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:25,728 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, b0bb4201-f5ea-4aa5-aac2-868ea1720b4a, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:25,729 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, b0bb4201-f5ea-4aa5-aac2-868ea1720b4a, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:27,136 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:27,137 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:27,138 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 62357d8f-2fae-4838-a8c4-7369883b6bab, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:27,139 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 62357d8f-2fae-4838-a8c4-7369883b6bab, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:27,140 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 62357d8f-2fae-4838-a8c4-7369883b6bab, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:27,603 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:27,603 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:27,604 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 541219f9-ac8b-49ea-9eda-c1b089f772d5, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:27,605 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 541219f9-ac8b-49ea-9eda-c1b089f772d5, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:27,606 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 541219f9-ac8b-49ea-9eda-c1b089f772d5, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:28,163 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:28,163 - INFO - __tests__.alter_compression.1722366  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1277056, 'BlobCount': 512}}
2025-11-21 12:10:28,164 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:28,165 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 70edd130-9154-4950-a714-079c6b46cc8e, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:28,166 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 70edd130-9154-4950-a714-079c6b46cc8e, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:28,172 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 70edd130-9154-4950-a714-079c6b46cc8e, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:29,483 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:29,484 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:29,485 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 46e95cc8-d650-4f45-a0df-ed1acf372eff, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:29,486 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 46e95cc8-d650-4f45-a0df-ed1acf372eff, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:29,492 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 46e95cc8-d650-4f45-a0df-ed1acf372eff, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:30,017 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:30,018 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:30,019 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, e34448a5-40c9-40d2-9e58-aa9fea45f88a, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:30,020 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, e34448a5-40c9-40d2-9e58-aa9fea45f88a, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:30,023 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, e34448a5-40c9-40d2-9e58-aa9fea45f88a, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:30,719 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:30,720 - INFO - __tests__.alter_compression.1722366  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1596256, 'BlobCount': 640}}
2025-11-21 12:10:30,720 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:30,721 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 5dc588d5-7386-42b7-92be-a6030d59a89b, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:30,722 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 5dc588d5-7386-42b7-92be-a6030d59a89b, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:30,724 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 5dc588d5-7386-42b7-92be-a6030d59a89b, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:32,163 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:32,164 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:32,164 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 2aadc68b-2b8f-4a3b-9fe1-91ed018f7194, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:32,165 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 2aadc68b-2b8f-4a3b-9fe1-91ed018f7194, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:32,167 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 2aadc68b-2b8f-4a3b-9fe1-91ed018f7194, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:32,430 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:32,430 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:32,431 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 6472f386-f039-4155-be53-fbffd2bed54a, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:32,432 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 6472f386-f039-4155-be53-fbffd2bed54a, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:32,434 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 6472f386-f039-4155-be53-fbffd2bed54a, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:33,096 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:33,096 - INFO - __tests__.alter_compression.1722366  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1915600, 'BlobCount': 768}}
2025-11-21 12:10:33,097 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:33,098 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, aa52467a-0257-4187-98e3-ff73ceebdd9a, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:33,099 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, aa52467a-0257-4187-98e3-ff73ceebdd9a, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:33,109 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, aa52467a-0257-4187-98e3-ff73ceebdd9a, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:34,575 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:34,576 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:34,577 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, c14f2834-0c05-45c8-8e3a-b46a863fbaa7, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:34,577 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, c14f2834-0c05-45c8-8e3a-b46a863fbaa7, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:34,579 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, c14f2834-0c05-45c8-8e3a-b46a863fbaa7, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:34,916 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:34,917 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:34,917 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, a1cc99e0-02a9-4b81-afad-fb2b3aef033e, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:34,919 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, a1cc99e0-02a9-4b81-afad-fb2b3aef033e, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:34,920 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, a1cc99e0-02a9-4b81-afad-fb2b3aef033e, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:35,673 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:35,674 - INFO - __tests__.alter_compression.1722366  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2234896, 'BlobCount': 896}}
2025-11-21 12:10:35,675 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:35,675 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 6cab9e56-4cdb-401c-b5f7-030bcf8c9623, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:35,676 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 6cab9e56-4cdb-401c-b5f7-030bcf8c9623, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:35,678 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 6cab9e56-4cdb-401c-b5f7-030bcf8c9623, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:37,155 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:37,156 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:37,156 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 0ad1dcc0-c6cc-4335-a46d-9ded53020fa4, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:37,157 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 0ad1dcc0-c6cc-4335-a46d-9ded53020fa4, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:37,159 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 0ad1dcc0-c6cc-4335-a46d-9ded53020fa4, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:37,582 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:37,582 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:37,583 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, f552f7d6-53cb-403b-b11e-e9e00a38e9e2, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:37,584 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, f552f7d6-53cb-403b-b11e-e9e00a38e9e2, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:37,585 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, f552f7d6-53cb-403b-b11e-e9e00a38e9e2, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:38,745 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:38,746 - INFO - __tests__.alter_compression.1722366  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2554464, 'BlobCount': 1024}}
2025-11-21 12:10:38,746 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:38,747 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, c9eebe5e-5476-403b-bbc0-64ef55b1846b, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:38,748 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, c9eebe5e-5476-403b-bbc0-64ef55b1846b, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:38,751 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, c9eebe5e-5476-403b-bbc0-64ef55b1846b, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:40,133 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:40,134 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:40,135 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 176c9ddb-2061-4b5d-8473-a00fc2acd66f, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:40,136 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 176c9ddb-2061-4b5d-8473-a00fc2acd66f, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:40,138 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 176c9ddb-2061-4b5d-8473-a00fc2acd66f, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:40,599 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:40,599 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:40,600 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, cb28b212-d134-464d-9c05-47c36854ffde, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:40,603 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, cb28b212-d134-464d-9c05-47c36854ffde, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:40,604 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, cb28b212-d134-464d-9c05-47c36854ffde, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:41,781 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:41,781 - INFO - __tests__.alter_compression.1722366  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2873568, 'BlobCount': 1152}}
2025-11-21 12:10:41,782 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:41,782 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 35ad5fdc-530f-4bb7-b660-519330b87278, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:41,783 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 35ad5fdc-530f-4bb7-b660-519330b87278, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:41,785 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 35ad5fdc-530f-4bb7-b660-519330b87278, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:43,073 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:43,073 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:43,075 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 4cddf1ad-ce4b-499a-b62a-fec6bc127a1e, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:43,076 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 4cddf1ad-ce4b-499a-b62a-fec6bc127a1e, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:43,078 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 4cddf1ad-ce4b-499a-b62a-fec6bc127a1e, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:43,648 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:43,649 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:43,650 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 721f7aff-c3ff-4689-b00a-c28d8c513fbc, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:43,651 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 721f7aff-c3ff-4689-b00a-c28d8c513fbc, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:43,653 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 721f7aff-c3ff-4689-b00a-c28d8c513fbc, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:44,620 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:44,620 - INFO - __tests__.alter_compression.1722366  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3193216, 'BlobCount': 1280}}
2025-11-21 12:10:44,621 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:44,621 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 4fc0db51-558f-4c0d-b5e9-cd41874030fa, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:44,622 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 4fc0db51-558f-4c0d-b5e9-cd41874030fa, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:44,632 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 4fc0db51-558f-4c0d-b5e9-cd41874030fa, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:46,656 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:46,657 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:46,657 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 4fe3fc00-383c-4738-b7f0-26622f29f2e4, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:46,664 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 4fe3fc00-383c-4738-b7f0-26622f29f2e4, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:46,666 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 4fe3fc00-383c-4738-b7f0-26622f29f2e4, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:47,043 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:47,044 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:47,045 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, dd4db2ca-cf14-45e3-89dd-6d43f6035ccb, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:47,045 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, dd4db2ca-cf14-45e3-89dd-6d43f6035ccb, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:47,047 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, dd4db2ca-cf14-45e3-89dd-6d43f6035ccb, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:47,694 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:47,695 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:10:47,696 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, fc6c1c47-68bd-40f9-8105-88e29295800b, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:10:47,697 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, fc6c1c47-68bd-40f9-8105-88e29295800b, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:47,698 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, fc6c1c47-68bd-40f9-8105-88e29295800b, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:55,076 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:11:05,187 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:11:05,188 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, fb127112-8b87-4454-97e2-d50a2212be02, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:11:05,189 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, fb127112-8b87-4454-97e2-d50a2212be02, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:11:05,191 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, fb127112-8b87-4454-97e2-d50a2212be02, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:11:09,099 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:11:09,193 - INFO - root.1722366  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_compression`, volumes `value` (8000000, 1596608)
2025-11-21 12:11:09,194 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:11:09,194 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, 2ba325d4-e2fc-4696-b64c-7c1cc904eeb2, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:11:09,195 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, 2ba325d4-e2fc-4696-b64c-7c1cc904eeb2, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:11:09,204 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, 2ba325d4-e2fc-4696-b64c-7c1cc904eeb2, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:11:10,139 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:11:10,140 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:11:10,140 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, c6efa585-e741-455e-9efe-4f3a4c7c1b4d, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:11:10,141 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, c6efa585-e741-455e-9efe-4f3a4c7c1b4d, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:11:10,142 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, c6efa585-e741-455e-9efe-4f3a4c7c1b4d, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:11:14,837 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:11:24,891 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:11:24,893 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, c264848d-374a-4520-a1b5-80677a382564, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:11:24,893 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, c264848d-374a-4520-a1b5-80677a382564, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:11:24,895 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, c264848d-374a-4520-a1b5-80677a382564, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:11:27,636 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:11:37,663 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:11:37,665 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, cc780e2a-6827-4b4e-8c20-8fbc72825232, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:11:37,666 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, cc780e2a-6827-4b4e-8c20-8fbc72825232, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:11:37,667 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, cc780e2a-6827-4b4e-8c20-8fbc72825232, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:11:38,998 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:11:49,003 - DEBUG - ydb.query.pool.1722366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:11:49,004 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(ExecuteQuery, e81eaefc-2c20-4ff7-892c-e916129e7f7e, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:11:49,005 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(ExecuteQuery, e81eaefc-2c20-4ff7-892c-e916129e7f7e, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:11:49,006 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(ExecuteQuery, e81eaefc-2c20-4ff7-892c-e916129e7f7e, ghrun-ts5cnd6jre.auto.internal:13786): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:11:49,846 - DEBUG - ydb.query.pool.1722366  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==
2025-11-21 12:11:49,850 - INFO - root.1722366  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_compression`, volumes `value` (8000000, 1465272)
2025-11-21 12:11:49,850 - INFO - root.1722366  - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_compression` 8092160 / 1465272: 5.522633340430992
2025-11-21 12:11:49,865 - INFO - ya.test.1722366  - pytest_runtest_teardown: Test teardown
2025-11-21 12:11:49,866 - DEBUG - ydb.connection.1722366  - _prepare_call: RpcState(DeleteSession, d4a07cc1-b634-47c7-9c5c-675e9d7434d7, ghrun-ts5cnd6jre.auto.internal:13786): creating call state
2025-11-21 12:11:49,871 - DEBUG - ydb.connection.1722366  - _log_request: RpcState(DeleteSession, d4a07cc1-b634-47c7-9c5c-675e9d7434d7, ghrun-ts5cnd6jre.auto.internal:13786): request = { session_id: "ydb://session/3?node_id=1&id=OTdiOTY5My0xNDBkZTM4My02ZWNlOTdlNy1hMTZhODBlYQ==" }
2025-11-21 12:11:49,878 - DEBUG - ydb.connection.1722366  - _log_response: RpcState(DeleteSession, d4a07cc1-b634-47c7-9c5c-675e9d7434d7, ghrun-ts5cnd6jre.auto.internal:13786): response = { status: SUCCESS }
2025-11-21 12:11:49,879 - DEBUG - ydb.query.pool.1722366  - stop: All session were deleted.
2025-11-21 12:11:49,880 - DEBUG - ydb.topic.1722366  - close: Close topic client
2025-11-21 12:11:49,881 - DEBUG - ydb.topic.1722366  - close: Topic client was closed
2025-11-21 12:11:49,881 - DEBUG - ydb.connection.1722366  - close: Closing channel for endpoint localhost:13786
2025-11-21 12:11:49,883 - DEBUG - ydb.connection.1722366  - _rpc_error_handler: RpcState(AttachSession, 827e7ddb-0086-41fc-95eb-d2670981efd7, ghrun-ts5cnd6jre.auto.internal:13786): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.CANCELLED
	details = "Locally cancelled by application!"
	debug_error_string = "None"
>
2025-11-21 12:11:49,886 - DEBUG - ydb.connection.1722366  - close: Closing channel for endpoint ghrun-ts5cnd6jre.auto.internal:13786
2025-11-21 12:11:49,891 - INFO - ydb.pool.Discovery.1722366  - run: Successfully terminated discovery process
2025-11-21 12:12:06,932 - INFO - ydb.tests.library.harness.kikimr_runner.1722366  - stop: Stopped node localhost:13786/1
2025-11-21 12:12:06,934 - DEBUG - library.python.filelock.1722366  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/17713
2025-11-21 12:12:06,935 - DEBUG - library.python.filelock.1722366  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/22902
2025-11-21 12:12:06,935 - DEBUG - library.python.filelock.1722366  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/16998
2025-11-21 12:12:06,936 - DEBUG - library.python.filelock.1722366  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/13786
2025-11-21 12:12:06,936 - DEBUG - library.python.filelock.1722366  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/18653
