2025-11-21 20:42:55,008 - INFO - ya.test.669971  - pytest_runtest_setup: ####################################################################################################
2025-11-21 20:42:55,009 - INFO - ya.test.669971  - pytest_runtest_setup: test_all_supported_compression[zstd_2_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 2]
2025-11-21 20:42:55,009 - INFO - ya.test.669971  - pytest_runtest_setup: ####################################################################################################
2025-11-21 20:42:55,009 - INFO - ya.test.669971  - pytest_runtest_setup: Test setup
2025-11-21 20:42:55,011 - DEBUG - ya.test.669971  - _get_command_output_file: Command out will be placed to ydbd.out
2025-11-21 20:42:55,012 - DEBUG - ya.test.669971  - _get_command_output_file: Command err will be placed to ydbd.err
2025-11-21 20:42:55,013 - DEBUG - ya.test.669971  - execute: Executing '['/home/runner/.ya/build/build_root/tshh/002756/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-21 20:42:55,014 - DEBUG - ya.test.669971  - execute: Command pid: 672902
2025-11-21 20:42:55,871 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 672902) rc: 0
2025-11-21 20:42:55,871 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 672902) elapsed time (sec): 0.8556680679321289
2025-11-21 20:42:55,872 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 672902) idrss: 0
2025-11-21 20:42:55,872 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 672902) inblock: 0
2025-11-21 20:42:55,872 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 672902) isrss: 0
2025-11-21 20:42:55,873 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 672902) ixrss: 0
2025-11-21 20:42:55,873 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 672902) majflt: 0
2025-11-21 20:42:55,873 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 672902) maxrss: 494076
2025-11-21 20:42:55,874 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 672902) minflt: 45599
2025-11-21 20:42:55,874 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 672902) msgrcv: 0
2025-11-21 20:42:55,874 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 672902) msgsnd: 0
2025-11-21 20:42:55,874 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 672902) nivcsw: 140
2025-11-21 20:42:55,879 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 672902) nsignals: 0
2025-11-21 20:42:55,879 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 672902) nswap: 0
2025-11-21 20:42:55,880 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 672902) nvcsw: 14
2025-11-21 20:42:55,880 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 672902) oublock: 8
2025-11-21 20:42:55,880 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 672902) stime: 0.20232699999999998
2025-11-21 20:42:55,880 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 672902) utime: 0.493564
2025-11-21 20:42:55,881 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 672902) wtime: 0.858
2025-11-21 20:42:55,881 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 672902) 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-frzglb4yoy    Host information: 
        Linux ghrun-frzglb4yoy 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 20:42:55,882 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 672902) errors:

2025-11-21 20:42:55,882 - INFO - __tests__.base.669971  - _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-frzglb4yoy    Host information: 
        Linux ghrun-frzglb4yoy 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 20:42:56,001 - DEBUG - ya.test.669971  - get_binary: Binary was found by /home/runner/.ya/build/build_root/tshh/002756/ydb/apps/ydbd/ydbd
2025-11-21 20:42:56,002 - DEBUG - library.python.filelock.669971  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/31540
2025-11-21 20:42:56,004 - DEBUG - ydb.tests.library.harness.kikimr_runner.669971  - start: Working directory: /home/runner/.ya/build/build_root/tshh/002756/r3tmp/kikimr_cluster_zp0j2ac4
2025-11-21 20:42:56,042 - DEBUG - ya.test.669971  - get_binary: Binary was found by /home/runner/.ya/build/build_root/tshh/002756/ydb/apps/ydbd/ydbd
2025-11-21 20:42:56,043 - DEBUG - library.python.filelock.669971  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/6158
2025-11-21 20:42:56,043 - DEBUG - library.python.filelock.669971  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/18108
2025-11-21 20:42:56,044 - DEBUG - library.python.filelock.669971  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/15673
2025-11-21 20:42:56,045 - DEBUG - library.python.filelock.669971  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/25081
2025-11-21 20:42:56,046 - INFO - ydb.tests.library.harness.kikimr_runner.669971  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/tshh/002756/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk5/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_2_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.2/cluster/kikimr_configs"
2025-11-21 20:42:56,046 - INFO - ydb.tests.library.harness.kikimr_runner.669971  - __make_run_command: Final command: /home/runner/.ya/build/build_root/tshh/002756/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/tshh/002756/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk5/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_2_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.2/cluster/node_1/logfile_hizhoces.log --grpc-port=6158 --mon-port=18108 --ic-port=31540
2025-11-21 20:42:56,047 - DEBUG - ydb.tests.library.harness.kikimr_runner.669971  - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:6158/1, disk_size 68719476736
2025-11-21 20:42:56,047 - INFO - ydb.tests.library.harness.kikimr_runner.669971  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/tshh/002756/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk5/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_2_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.2/cluster/kikimr_configs"
2025-11-21 20:42:56,047 - INFO - ydb.tests.library.harness.kikimr_runner.669971  - __make_run_command: Final command: /home/runner/.ya/build/build_root/tshh/002756/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/tshh/002756/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk5/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_2_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.2/cluster/node_1/logfile_hizhoces.log --grpc-port=6158 --mon-port=18108 --ic-port=31540
2025-11-21 20:42:56,048 - DEBUG - ya.test.669971  - execute: Executing '('/home/runner/.ya/build/build_root/tshh/002756/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/tshh/002756/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk5/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_2_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.2/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/tshh/002756/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk5/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_2_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.2/cluster/node_1/logfile_hizhoces.log', '--grpc-port=6158', '--mon-port=18108', '--ic-port=31540')' in '/home/runner/.ya/build/build_root/tshh/002756/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk5/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_2_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.2/cluster/node_1' (no wait)
2025-11-21 20:42:56,051 - DEBUG - ya.test.669971  - execute: Command pid: 673773
2025-11-21 20:42:56,052 - INFO - ydb.tests.library.harness.kikimr_runner.669971  - start: Started node localhost:6158/1
2025-11-21 20:42:56,053 - DEBUG - ya.test.669971  - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-11-21 20:42:56,054 - DEBUG - ya.test.669971  - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-11-21 20:42:56,054 - DEBUG - ya.test.669971  - execute: Executing '['/home/runner/.ya/build/build_root/tshh/002756/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-21 20:42:56,057 - DEBUG - ya.test.669971  - execute: Command pid: 673777
2025-11-21 20:42:56,861 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 673777) rc: 0
2025-11-21 20:42:56,862 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 673777) elapsed time (sec): 0.8040235042572021
2025-11-21 20:42:56,862 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 673777) idrss: 0
2025-11-21 20:42:56,863 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 673777) inblock: 0
2025-11-21 20:42:56,863 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 673777) isrss: 0
2025-11-21 20:42:56,863 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 673777) ixrss: 0
2025-11-21 20:42:56,863 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 673777) majflt: 0
2025-11-21 20:42:56,864 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 673777) maxrss: 503292
2025-11-21 20:42:56,864 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 673777) minflt: 45608
2025-11-21 20:42:56,864 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 673777) msgrcv: 0
2025-11-21 20:42:56,865 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 673777) msgsnd: 0
2025-11-21 20:42:56,865 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 673777) nivcsw: 138
2025-11-21 20:42:56,865 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 673777) nsignals: 0
2025-11-21 20:42:56,865 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 673777) nswap: 0
2025-11-21 20:42:56,866 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 673777) nvcsw: 15
2025-11-21 20:42:56,866 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 673777) oublock: 8
2025-11-21 20:42:56,866 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 673777) stime: 0.20305199999999998
2025-11-21 20:42:56,866 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 673777) utime: 0.484556
2025-11-21 20:42:56,874 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 673777) wtime: 0.806
2025-11-21 20:42:56,874 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 673777) 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-frzglb4yoy    Host information: 
        Linux ghrun-frzglb4yoy 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 20:42:56,875 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 673777) errors:

2025-11-21 20:42:56,875 - INFO - ydb.tests.library.harness.kikimr_runner.669971  - 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-frzglb4yoy    Host information: 
        Linux ghrun-frzglb4yoy 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64
2025-11-21 20:43:01,821 - DEBUG - ya.test.669971  - get_binary: Binary was found by /home/runner/.ya/build/build_root/tshh/002756/ydb/apps/ydbd/ydbd
2025-11-21 20:43:01,821 - DEBUG - ydb.tests.library.harness.kikimr_runner.669971  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/tshh/002756/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:6158', '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: 31540\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-21 20:43:01,823 - DEBUG - ya.test.669971  - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-11-21 20:43:01,823 - DEBUG - ya.test.669971  - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-11-21 20:43:01,824 - DEBUG - ya.test.669971  - execute: Executing '['/home/runner/.ya/build/build_root/tshh/002756/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:6158', '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: 31540\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-21 20:43:01,825 - DEBUG - ya.test.669971  - execute: Command pid: 677732
2025-11-21 20:43:02,771 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 677732) rc: 0
2025-11-21 20:43:02,771 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 677732) elapsed time (sec): 0.9450774192810059
2025-11-21 20:43:02,772 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 677732) idrss: 0
2025-11-21 20:43:02,772 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 677732) inblock: 0
2025-11-21 20:43:02,772 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 677732) isrss: 0
2025-11-21 20:43:02,773 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 677732) ixrss: 0
2025-11-21 20:43:02,773 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 677732) majflt: 0
2025-11-21 20:43:02,773 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 677732) maxrss: 596468
2025-11-21 20:43:02,773 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 677732) minflt: 51967
2025-11-21 20:43:02,774 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 677732) msgrcv: 0
2025-11-21 20:43:02,774 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 677732) msgsnd: 0
2025-11-21 20:43:02,774 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 677732) nivcsw: 165
2025-11-21 20:43:02,777 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 677732) nsignals: 0
2025-11-21 20:43:02,777 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 677732) nswap: 0
2025-11-21 20:43:02,777 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 677732) nvcsw: 620
2025-11-21 20:43:02,778 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 677732) oublock: 8
2025-11-21 20:43:02,778 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 677732) stime: 0.284375
2025-11-21 20:43:02,778 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 677732) utime: 0.517316
2025-11-21 20:43:02,778 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 677732) wtime: 0.947
2025-11-21 20:43:02,779 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 677732) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-21 20:43:02,779 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 677732) errors:

2025-11-21 20:43:02,780 - DEBUG - ya.test.669971  - get_binary: Binary was found by /home/runner/.ya/build/build_root/tshh/002756/ydb/apps/ydbd/ydbd
2025-11-21 20:43:02,781 - DEBUG - ydb.tests.library.harness.kikimr_runner.669971  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/tshh/002756/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:6158', '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 20:43:02,782 - DEBUG - ya.test.669971  - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-11-21 20:43:02,783 - DEBUG - ya.test.669971  - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-11-21 20:43:02,783 - DEBUG - ya.test.669971  - execute: Executing '['/home/runner/.ya/build/build_root/tshh/002756/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:6158', '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 20:43:02,785 - DEBUG - ya.test.669971  - execute: Command pid: 678369
2025-11-21 20:43:03,718 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 678369) rc: 0
2025-11-21 20:43:03,718 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 678369) elapsed time (sec): 0.9318904876708984
2025-11-21 20:43:03,719 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 678369) idrss: 0
2025-11-21 20:43:03,719 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 678369) inblock: 0
2025-11-21 20:43:03,719 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 678369) isrss: 0
2025-11-21 20:43:03,720 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 678369) ixrss: 0
2025-11-21 20:43:03,720 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 678369) majflt: 0
2025-11-21 20:43:03,720 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 678369) maxrss: 596904
2025-11-21 20:43:03,720 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 678369) minflt: 51956
2025-11-21 20:43:03,721 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 678369) msgrcv: 0
2025-11-21 20:43:03,721 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 678369) msgsnd: 0
2025-11-21 20:43:03,721 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 678369) nivcsw: 137
2025-11-21 20:43:03,721 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 678369) nsignals: 0
2025-11-21 20:43:03,722 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 678369) nswap: 0
2025-11-21 20:43:03,722 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 678369) nvcsw: 937
2025-11-21 20:43:03,722 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 678369) oublock: 8
2025-11-21 20:43:03,723 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 678369) stime: 0.266245
2025-11-21 20:43:03,723 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 678369) utime: 0.5086999999999999
2025-11-21 20:43:03,723 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 678369) wtime: 0.934
2025-11-21 20:43:03,724 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 678369) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-11-21 20:43:03,724 - DEBUG - ya.test.669971  - _save_outputs: Command (pid 678369) errors:

2025-11-21 20:43:03,724 - INFO - ydb.tests.library.harness.kikimr_runner.669971  - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-21 20:43:03,791 - INFO - ydb.tests.library.harness.kikimr_runner.669971  - __run: Cluster started and initialized
2025-11-21 20:43:03,846 - DEBUG - ydb.connection.669971  - 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 20:43:03,850 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.669971  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-21 20:43:03,853 - DEBUG - ydb.connection.669971  - 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 20:43:03,914 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.669971  - context_resolve: Resolving endpoints for database /Root
2025-11-21 20:43:03,915 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ListEndpoints, 00c97cb2-e182-4d11-a254-ec8319bd816d, localhost:6158): creating call state
2025-11-21 20:43:03,916 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ListEndpoints, 00c97cb2-e182-4d11-a254-ec8319bd816d, localhost:6158): request = { database: "/Root" }
2025-11-21 20:43:03,925 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ListEndpoints, 00c97cb2-e182-4d11-a254-ec8319bd816d, localhost:6158): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-frzglb4yoy.auto.internal" port: 6158 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 20:43:03,925 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.669971  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-frzglb4yoy.auto.internal:6158, location 1, ssl: False>]>
2025-11-21 20:43:03,926 - DEBUG - ydb.connection.669971  - 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 20:43:03,944 - DEBUG - ydb.connection.669971  - close: Closing channel for endpoint localhost:6158
2025-11-21 20:43:03,945 - DEBUG - ydb.query.pool.669971  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-21 20:43:03,946 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(CreateSession, f74976a7-0604-43cf-8972-6bd158e7e2e0, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:03,947 - DEBUG - ydb.connection.669971  - _log_request: RpcState(CreateSession, f74976a7-0604-43cf-8972-6bd158e7e2e0, ghrun-frzglb4yoy.auto.internal:6158): request = {  }
2025-11-21 20:43:03,954 - DEBUG - ydb.connection.669971  - _log_response: RpcState(CreateSession, f74976a7-0604-43cf-8972-6bd158e7e2e0, ghrun-frzglb4yoy.auto.internal:6158): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" node_id: 1 }
2025-11-21 20:43:03,955 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(AttachSession, e7f94774-669e-4d3a-ba9c-8a88e129c031, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:03,956 - DEBUG - ydb.connection.669971  - _log_request: RpcState(AttachSession, e7f94774-669e-4d3a-ba9c-8a88e129c031, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" }
2025-11-21 20:43:03,959 - DEBUG - ydb.connection.669971  - _log_response: RpcState(AttachSession, e7f94774-669e-4d3a-ba9c-8a88e129c031, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:03,973 - DEBUG - ydb.query.pool.669971  - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:03,974 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 3a72158f-10ed-41b1-9cbc-27960c0fc6cb, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:03,975 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 3a72158f-10ed-41b1-9cbc-27960c0fc6cb, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:03,976 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 3a72158f-10ed-41b1-9cbc-27960c0fc6cb, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:06,378 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:06,378 - INFO - __tests__.alter_compression.669971  - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-11-21 20:43:06,379 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:06,380 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 91caf5b7-5388-49b7-bfa0-ee85b9ed1cf3, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:06,381 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 91caf5b7-5388-49b7-bfa0-ee85b9ed1cf3, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:06,382 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 91caf5b7-5388-49b7-bfa0-ee85b9ed1cf3, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:07,255 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:07,255 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:07,256 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 2f5f82bc-e4fe-435d-b546-d3f7f9d3e166, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:07,257 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 2f5f82bc-e4fe-435d-b546-d3f7f9d3e166, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:07,258 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 2f5f82bc-e4fe-435d-b546-d3f7f9d3e166, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:08,158 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:08,159 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:08,159 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 9ba1645c-fa3b-4514-9876-e13da834f90a, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:08,160 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 9ba1645c-fa3b-4514-9876-e13da834f90a, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:08,161 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 9ba1645c-fa3b-4514-9876-e13da834f90a, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:08,872 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:08,873 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:08,873 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 00e2f567-e63b-43a9-a9da-30b3991386a8, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:08,874 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 00e2f567-e63b-43a9-a9da-30b3991386a8, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:08,875 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 00e2f567-e63b-43a9-a9da-30b3991386a8, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:10,130 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:10,131 - INFO - __tests__.alter_compression.669971  - 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 20:43:10,131 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:10,132 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 9b889f2e-6afe-459b-bc41-445ae6b0a6a4, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:10,133 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 9b889f2e-6afe-459b-bc41-445ae6b0a6a4, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:10,134 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 9b889f2e-6afe-459b-bc41-445ae6b0a6a4, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:10,852 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:10,853 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:10,854 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 12a1281d-7646-4075-bd4c-0e2798918cd1, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:10,855 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 12a1281d-7646-4075-bd4c-0e2798918cd1, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:10,856 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 12a1281d-7646-4075-bd4c-0e2798918cd1, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:11,023 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:11,024 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:11,025 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 78c0b1a0-bb11-471a-8d92-cab63747bf67, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:11,026 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 78c0b1a0-bb11-471a-8d92-cab63747bf67, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:11,027 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 78c0b1a0-bb11-471a-8d92-cab63747bf67, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:11,254 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:11,255 - INFO - __tests__.alter_compression.669971  - 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 20:43:11,255 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:11,256 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 32c1964b-3d06-49b2-a823-cf303a7aa7cb, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:11,257 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 32c1964b-3d06-49b2-a823-cf303a7aa7cb, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:11,258 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 32c1964b-3d06-49b2-a823-cf303a7aa7cb, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:12,073 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:12,074 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:12,074 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 161e6086-c965-4a78-8d60-2e7f9193232e, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:12,075 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 161e6086-c965-4a78-8d60-2e7f9193232e, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:12,076 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 161e6086-c965-4a78-8d60-2e7f9193232e, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:12,267 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:12,268 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:12,269 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, bd6c2558-2e3c-43bd-8838-b52d0d608aa3, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:12,270 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, bd6c2558-2e3c-43bd-8838-b52d0d608aa3, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:12,271 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, bd6c2558-2e3c-43bd-8838-b52d0d608aa3, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:12,522 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:12,522 - INFO - __tests__.alter_compression.669971  - 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 20:43:12,523 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:12,523 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, e670bfa3-6611-4f1b-a7da-313541e8773b, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:12,524 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, e670bfa3-6611-4f1b-a7da-313541e8773b, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:12,526 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, e670bfa3-6611-4f1b-a7da-313541e8773b, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:13,312 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:13,313 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:13,314 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 2dca1556-de9a-46cf-b1fc-5dfb298be92a, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:13,315 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 2dca1556-de9a-46cf-b1fc-5dfb298be92a, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:13,316 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 2dca1556-de9a-46cf-b1fc-5dfb298be92a, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:13,541 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:13,542 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:13,542 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 187e7c0c-5405-4e35-8384-c43d321a3eba, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:13,543 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 187e7c0c-5405-4e35-8384-c43d321a3eba, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:13,544 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 187e7c0c-5405-4e35-8384-c43d321a3eba, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:13,836 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:13,837 - INFO - __tests__.alter_compression.669971  - 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 20:43:13,837 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:13,838 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 05323640-1ab1-4dec-b8fd-054d8907de25, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:13,839 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 05323640-1ab1-4dec-b8fd-054d8907de25, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:13,840 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 05323640-1ab1-4dec-b8fd-054d8907de25, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:14,623 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:14,624 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:14,625 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 8dc2d4f9-636f-434d-9de3-1e04b9cedbdb, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:14,626 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 8dc2d4f9-636f-434d-9de3-1e04b9cedbdb, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:14,627 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 8dc2d4f9-636f-434d-9de3-1e04b9cedbdb, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:14,821 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:14,822 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:14,823 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 9826c7e0-4e53-45fa-a574-7aaffbadf000, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:14,824 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 9826c7e0-4e53-45fa-a574-7aaffbadf000, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:14,825 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 9826c7e0-4e53-45fa-a574-7aaffbadf000, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:15,171 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:15,172 - INFO - __tests__.alter_compression.669971  - 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 20:43:15,172 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:15,173 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 1cd7c0cd-bd05-4c04-98b6-9fd6fcefa49e, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:15,174 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 1cd7c0cd-bd05-4c04-98b6-9fd6fcefa49e, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:15,179 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 1cd7c0cd-bd05-4c04-98b6-9fd6fcefa49e, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:16,047 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:16,048 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:16,049 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, e05b3604-da69-452a-8ee3-61b510017bba, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:16,049 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, e05b3604-da69-452a-8ee3-61b510017bba, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:16,051 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, e05b3604-da69-452a-8ee3-61b510017bba, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:16,240 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:16,241 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:16,242 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, f7791cd2-4ba6-4bbc-b94b-024f7ba44e79, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:16,242 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, f7791cd2-4ba6-4bbc-b94b-024f7ba44e79, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:16,244 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, f7791cd2-4ba6-4bbc-b94b-024f7ba44e79, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:17,039 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:17,040 - INFO - __tests__.alter_compression.669971  - 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 20:43:17,040 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:17,041 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, bf296920-b6aa-4daf-a7eb-38351c765817, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:17,042 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, bf296920-b6aa-4daf-a7eb-38351c765817, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:17,043 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, bf296920-b6aa-4daf-a7eb-38351c765817, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:17,919 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:17,920 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:17,921 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, b9a2aa24-3c71-4882-b58b-7e91a1cd3a93, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:17,922 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, b9a2aa24-3c71-4882-b58b-7e91a1cd3a93, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:17,923 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, b9a2aa24-3c71-4882-b58b-7e91a1cd3a93, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:18,124 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:18,125 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:18,126 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 0fd08a07-3940-4ea6-8abb-b0dcfd47f104, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:18,127 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 0fd08a07-3940-4ea6-8abb-b0dcfd47f104, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:18,128 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 0fd08a07-3940-4ea6-8abb-b0dcfd47f104, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:18,551 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:18,552 - INFO - __tests__.alter_compression.669971  - 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 20:43:18,552 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:18,552 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 8e249c48-bacc-447b-b8cf-621f11cd5f7e, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:18,553 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 8e249c48-bacc-447b-b8cf-621f11cd5f7e, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:18,554 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 8e249c48-bacc-447b-b8cf-621f11cd5f7e, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:19,423 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:19,423 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:19,424 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, b54d3c31-05f0-47e1-bf2d-a498aebf2740, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:19,425 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, b54d3c31-05f0-47e1-bf2d-a498aebf2740, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:19,426 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, b54d3c31-05f0-47e1-bf2d-a498aebf2740, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:19,615 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:19,616 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:19,616 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 7e1a6ea0-12d8-4b35-ad89-3d53dd034924, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:19,617 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 7e1a6ea0-12d8-4b35-ad89-3d53dd034924, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:19,620 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 7e1a6ea0-12d8-4b35-ad89-3d53dd034924, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:20,071 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:20,072 - INFO - __tests__.alter_compression.669971  - 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 20:43:20,072 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:20,072 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 815c4268-ab7a-4016-a36d-7aef6b6eaca8, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:20,073 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 815c4268-ab7a-4016-a36d-7aef6b6eaca8, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:20,074 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 815c4268-ab7a-4016-a36d-7aef6b6eaca8, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:20,877 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:20,878 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:20,878 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 0445f9d2-a3cd-43fc-ad41-4967e8eef3a2, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:20,879 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 0445f9d2-a3cd-43fc-ad41-4967e8eef3a2, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:20,880 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 0445f9d2-a3cd-43fc-ad41-4967e8eef3a2, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:21,095 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:21,096 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:21,097 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 7a4a29c4-7609-413b-84fc-3d26ddff2433, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:21,098 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 7a4a29c4-7609-413b-84fc-3d26ddff2433, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:21,100 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 7a4a29c4-7609-413b-84fc-3d26ddff2433, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:21,664 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:21,665 - INFO - __tests__.alter_compression.669971  - 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 20:43:21,665 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:21,666 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, fe11e5be-3fdb-4abe-96af-b93843eaa29a, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:21,667 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, fe11e5be-3fdb-4abe-96af-b93843eaa29a, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:21,669 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, fe11e5be-3fdb-4abe-96af-b93843eaa29a, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:22,727 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:22,728 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:22,729 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 9060b160-9620-4998-9c45-5c2b63bc01cb, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:22,730 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 9060b160-9620-4998-9c45-5c2b63bc01cb, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:22,731 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 9060b160-9620-4998-9c45-5c2b63bc01cb, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:22,986 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:22,987 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:22,988 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, e074c55f-bdc9-4e58-ae4f-8c732caea15b, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:22,989 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, e074c55f-bdc9-4e58-ae4f-8c732caea15b, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:22,990 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, e074c55f-bdc9-4e58-ae4f-8c732caea15b, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:23,529 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:23,529 - INFO - __tests__.alter_compression.669971  - 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 20:43:23,530 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:23,531 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 74164648-1f43-4853-a38d-f2965fc0c424, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:23,531 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 74164648-1f43-4853-a38d-f2965fc0c424, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:23,533 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 74164648-1f43-4853-a38d-f2965fc0c424, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:24,435 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:24,436 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:24,437 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, efa2e694-c9bf-4735-a5a8-0a404cb77b6d, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:24,438 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, efa2e694-c9bf-4735-a5a8-0a404cb77b6d, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:24,439 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, efa2e694-c9bf-4735-a5a8-0a404cb77b6d, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:24,674 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:24,675 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:24,675 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 40983b78-f7e3-4272-940a-e41a2c0a5e55, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:24,676 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 40983b78-f7e3-4272-940a-e41a2c0a5e55, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:24,677 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 40983b78-f7e3-4272-940a-e41a2c0a5e55, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:24,909 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:24,910 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:24,910 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, c23cf1ce-492c-4393-8ee7-cf616984a1cf, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:24,911 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, c23cf1ce-492c-4393-8ee7-cf616984a1cf, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:24,913 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, c23cf1ce-492c-4393-8ee7-cf616984a1cf, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:28,224 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:38,259 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:38,260 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, a4b4a098-aa63-416d-b8eb-d590c40c5bb6, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:38,261 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, a4b4a098-aa63-416d-b8eb-d590c40c5bb6, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:38,262 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, a4b4a098-aa63-416d-b8eb-d590c40c5bb6, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:40,904 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:40,943 - INFO - root.669971  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-11-21 20:43:40,943 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:40,944 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 8a1939c0-459b-459a-9698-843fffc9e605, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:40,945 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 8a1939c0-459b-459a-9698-843fffc9e605, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:40,945 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 8a1939c0-459b-459a-9698-843fffc9e605, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:43,424 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:53,460 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:53,461 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 99753aa0-aa67-44f5-806e-4a09e0b7600d, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:53,462 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 99753aa0-aa67-44f5-806e-4a09e0b7600d, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:53,463 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 99753aa0-aa67-44f5-806e-4a09e0b7600d, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:55,753 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:55,798 - INFO - root.669971  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-11-21 20:43:55,799 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:55,799 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, ec47d0e6-44e9-43b4-ace3-c36dbea9b7f3, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:55,800 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, ec47d0e6-44e9-43b4-ace3-c36dbea9b7f3, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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 20:43:55,801 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, ec47d0e6-44e9-43b4-ace3-c36dbea9b7f3, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:55,996 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:55,999 - INFO - ya.test.669971  - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_2_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 2])
2025-11-21 20:43:56,000 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:56,001 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 1127013a-7edb-4df1-84ad-950f13f85788, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:56,002 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 1127013a-7edb-4df1-84ad-950f13f85788, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_2_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 2)\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:56,003 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 1127013a-7edb-4df1-84ad-950f13f85788, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:58,473 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:58,473 - INFO - __tests__.alter_compression.669971  - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_2_compression created
2025-11-21 20:43:58,474 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:58,475 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 59cc1742-82f9-4c0a-98b7-b9b81e0e1ea5, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:58,476 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 59cc1742-82f9-4c0a-98b7-b9b81e0e1ea5, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_2_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:58,478 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 59cc1742-82f9-4c0a-98b7-b9b81e0e1ea5, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:59,164 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:59,165 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:43:59,165 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 121653b0-30fd-4a8c-a5aa-bf58f557b754, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:43:59,166 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 121653b0-30fd-4a8c-a5aa-bf58f557b754, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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_2_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:59,167 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 121653b0-30fd-4a8c-a5aa-bf58f557b754, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:00,119 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:00,119 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:00,120 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, efc3a4c4-3132-41cd-bd67-cb92810abd1b, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:44:00,121 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, efc3a4c4-3132-41cd-bd67-cb92810abd1b, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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_2_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:00,122 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, efc3a4c4-3132-41cd-bd67-cb92810abd1b, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:00,903 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:00,904 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:00,904 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 8385dc0d-491b-4762-b5be-9030e64b26a4, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:44:00,905 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 8385dc0d-491b-4762-b5be-9030e64b26a4, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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_2_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:00,907 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 8385dc0d-491b-4762-b5be-9030e64b26a4, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:02,523 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:02,524 - INFO - __tests__.alter_compression.669971  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_2_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318880, 'BlobCount': 128}}
2025-11-21 20:44:02,524 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:02,525 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, f38a25f3-91d1-4b85-9940-fd88624045af, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:44:02,525 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, f38a25f3-91d1-4b85-9940-fd88624045af, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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_2_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:02,527 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, f38a25f3-91d1-4b85-9940-fd88624045af, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:03,507 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:03,508 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:03,508 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 0993471c-9167-42a9-951f-e0c4a28455fd, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:44:03,509 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 0993471c-9167-42a9-951f-e0c4a28455fd, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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_2_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:03,511 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 0993471c-9167-42a9-951f-e0c4a28455fd, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:03,794 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:03,794 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:03,795 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 91a7e6b4-b98f-44a5-9d28-3672f84580ee, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:44:03,796 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 91a7e6b4-b98f-44a5-9d28-3672f84580ee, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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_2_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:03,797 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 91a7e6b4-b98f-44a5-9d28-3672f84580ee, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:04,128 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:04,129 - INFO - __tests__.alter_compression.669971  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_2_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 638656, 'BlobCount': 256}}
2025-11-21 20:44:04,129 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:04,130 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 11a508db-746e-4bb7-9489-d2d1e941ff8c, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:44:04,131 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 11a508db-746e-4bb7-9489-d2d1e941ff8c, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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_2_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:04,132 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 11a508db-746e-4bb7-9489-d2d1e941ff8c, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:05,443 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:05,444 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:05,445 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 4f5b54fd-ebf8-48d6-a488-eed9b1dafa2c, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:44:05,445 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 4f5b54fd-ebf8-48d6-a488-eed9b1dafa2c, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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_2_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:05,448 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 4f5b54fd-ebf8-48d6-a488-eed9b1dafa2c, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:05,710 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:05,710 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:05,711 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 79ffdd64-7da2-4231-a401-c7eec0c395bd, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:44:05,712 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 79ffdd64-7da2-4231-a401-c7eec0c395bd, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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_2_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:05,713 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 79ffdd64-7da2-4231-a401-c7eec0c395bd, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:06,102 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:06,103 - INFO - __tests__.alter_compression.669971  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_2_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 957984, 'BlobCount': 384}}
2025-11-21 20:44:06,103 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:06,104 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 0c9be2ae-8b9a-44b3-8b8e-6854e9e908c7, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:44:06,104 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 0c9be2ae-8b9a-44b3-8b8e-6854e9e908c7, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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_2_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:06,105 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 0c9be2ae-8b9a-44b3-8b8e-6854e9e908c7, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:07,447 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:07,448 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:07,448 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, e0a872c2-ff47-49b7-bc5d-e9d302623d27, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:44:07,449 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, e0a872c2-ff47-49b7-bc5d-e9d302623d27, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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_2_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:07,451 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, e0a872c2-ff47-49b7-bc5d-e9d302623d27, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:07,765 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:07,766 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:07,766 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 3afada94-8f36-479e-9c50-ac6312d8dd3f, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:44:07,767 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 3afada94-8f36-479e-9c50-ac6312d8dd3f, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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_2_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:07,768 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 3afada94-8f36-479e-9c50-ac6312d8dd3f, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:08,311 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:08,312 - INFO - __tests__.alter_compression.669971  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_2_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1277728, 'BlobCount': 512}}
2025-11-21 20:44:08,312 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:08,313 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 8fb15b24-1bd1-4e6c-a648-7fb5fc50a1ee, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:44:08,314 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 8fb15b24-1bd1-4e6c-a648-7fb5fc50a1ee, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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_2_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:08,315 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 8fb15b24-1bd1-4e6c-a648-7fb5fc50a1ee, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:09,613 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:09,614 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:09,615 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, c1e22fd9-934b-4bfb-9eef-1f45118066d9, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:44:09,615 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, c1e22fd9-934b-4bfb-9eef-1f45118066d9, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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_2_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:09,617 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, c1e22fd9-934b-4bfb-9eef-1f45118066d9, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:09,880 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:09,881 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:09,881 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 9b7f20de-7c73-413b-b2a9-b0495eb0052b, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:44:09,882 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 9b7f20de-7c73-413b-b2a9-b0495eb0052b, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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_2_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:09,883 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 9b7f20de-7c73-413b-b2a9-b0495eb0052b, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:10,346 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:10,347 - INFO - __tests__.alter_compression.669971  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_2_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1597184, 'BlobCount': 640}}
2025-11-21 20:44:10,347 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:10,348 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, d6d1d803-99ac-4121-8dd6-6a782e32cf37, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:44:10,349 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, d6d1d803-99ac-4121-8dd6-6a782e32cf37, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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_2_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:10,351 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, d6d1d803-99ac-4121-8dd6-6a782e32cf37, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:11,436 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:11,436 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:11,437 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 2e16ae3a-4eb9-47ae-8d3f-d10975a2eb42, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:44:11,438 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 2e16ae3a-4eb9-47ae-8d3f-d10975a2eb42, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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_2_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:11,439 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 2e16ae3a-4eb9-47ae-8d3f-d10975a2eb42, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:11,820 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:11,821 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:11,822 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 09517151-4044-4b4e-a116-a522721d5716, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:44:11,822 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 09517151-4044-4b4e-a116-a522721d5716, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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_2_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:11,824 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 09517151-4044-4b4e-a116-a522721d5716, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:12,540 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:12,541 - INFO - __tests__.alter_compression.669971  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_2_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1916800, 'BlobCount': 768}}
2025-11-21 20:44:12,541 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:12,542 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 72f1ec08-b87b-41d2-b700-516f3b18d0c7, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:44:12,542 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 72f1ec08-b87b-41d2-b700-516f3b18d0c7, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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_2_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:12,544 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 72f1ec08-b87b-41d2-b700-516f3b18d0c7, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:13,560 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:13,561 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:13,561 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 86d299b2-7866-43d3-93a4-0e97c920131e, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:44:13,562 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 86d299b2-7866-43d3-93a4-0e97c920131e, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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_2_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:13,563 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 86d299b2-7866-43d3-93a4-0e97c920131e, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:13,823 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:13,823 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:13,824 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 31b98f98-86f9-4d0d-b2f6-0149f8966a50, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:44:13,824 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 31b98f98-86f9-4d0d-b2f6-0149f8966a50, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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_2_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:13,825 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 31b98f98-86f9-4d0d-b2f6-0149f8966a50, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:14,360 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:14,361 - INFO - __tests__.alter_compression.669971  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_2_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2236496, 'BlobCount': 896}}
2025-11-21 20:44:14,361 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:14,362 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 444dfbda-21ef-4a9e-8eab-e1ed99311305, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:44:14,363 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 444dfbda-21ef-4a9e-8eab-e1ed99311305, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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_2_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:14,364 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 444dfbda-21ef-4a9e-8eab-e1ed99311305, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:15,491 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:15,492 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:15,493 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, ccb5117d-8ed4-483f-b290-7ac65e9d14d2, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:44:15,493 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, ccb5117d-8ed4-483f-b290-7ac65e9d14d2, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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_2_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:15,496 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, ccb5117d-8ed4-483f-b290-7ac65e9d14d2, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:15,730 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:15,731 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:15,732 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, b3d259c9-4989-40e4-93a3-30659e41c0d6, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:44:15,733 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, b3d259c9-4989-40e4-93a3-30659e41c0d6, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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_2_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:15,734 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, b3d259c9-4989-40e4-93a3-30659e41c0d6, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:16,324 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:16,325 - INFO - __tests__.alter_compression.669971  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_2_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2556272, 'BlobCount': 1024}}
2025-11-21 20:44:16,325 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:16,326 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, d014cf0b-4c01-42f7-8595-844ba7630ed9, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:44:16,327 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, d014cf0b-4c01-42f7-8595-844ba7630ed9, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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_2_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:16,329 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, d014cf0b-4c01-42f7-8595-844ba7630ed9, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:17,377 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:17,378 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:17,379 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 4699354a-7a81-4f23-8e3c-1f379f70979c, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:44:17,380 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 4699354a-7a81-4f23-8e3c-1f379f70979c, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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_2_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:17,381 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 4699354a-7a81-4f23-8e3c-1f379f70979c, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:17,609 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:17,610 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:17,611 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, a0d5fe76-acf3-4ee5-a806-56a5887214a7, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:44:17,612 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, a0d5fe76-acf3-4ee5-a806-56a5887214a7, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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_2_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:17,614 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, a0d5fe76-acf3-4ee5-a806-56a5887214a7, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:18,183 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:18,184 - INFO - __tests__.alter_compression.669971  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_2_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2875584, 'BlobCount': 1152}}
2025-11-21 20:44:18,184 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:18,185 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 71babcc6-c9ea-4a27-83c2-0b1a70db61c5, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:44:18,186 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 71babcc6-c9ea-4a27-83c2-0b1a70db61c5, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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_2_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:18,190 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 71babcc6-c9ea-4a27-83c2-0b1a70db61c5, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:19,247 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:19,248 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:19,248 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 946a6a3c-2944-4a2a-8904-053be45771d9, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:44:19,249 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 946a6a3c-2944-4a2a-8904-053be45771d9, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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_2_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:19,251 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 946a6a3c-2944-4a2a-8904-053be45771d9, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:19,505 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:19,506 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:19,506 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, f2f9db11-068b-4870-8d53-dd44cf6978e1, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:44:19,507 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, f2f9db11-068b-4870-8d53-dd44cf6978e1, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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_2_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:19,508 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, f2f9db11-068b-4870-8d53-dd44cf6978e1, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:20,216 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:20,217 - INFO - __tests__.alter_compression.669971  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_2_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3195568, 'BlobCount': 1280}}
2025-11-21 20:44:20,217 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:20,218 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 9a1cc93b-67f4-498b-aa91-40fbe780a2d3, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:44:20,219 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 9a1cc93b-67f4-498b-aa91-40fbe780a2d3, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_2_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:20,220 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 9a1cc93b-67f4-498b-aa91-40fbe780a2d3, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:21,299 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:21,300 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:21,300 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, e78d7269-8f0c-4c96-91c5-1f0d2c90d934, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:44:21,301 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, e78d7269-8f0c-4c96-91c5-1f0d2c90d934, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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_2_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:21,302 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, e78d7269-8f0c-4c96-91c5-1f0d2c90d934, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:21,539 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:21,540 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:21,540 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, e75747ca-a8a9-4183-883c-c1a171e54ea1, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:44:21,541 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, e75747ca-a8a9-4183-883c-c1a171e54ea1, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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_2_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:21,542 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, e75747ca-a8a9-4183-883c-c1a171e54ea1, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:21,785 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:21,786 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:21,787 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 41cfd0da-63d0-43b5-a3ac-642a488da841, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:44:21,788 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 41cfd0da-63d0-43b5-a3ac-642a488da841, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_2_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:21,789 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 41cfd0da-63d0-43b5-a3ac-642a488da841, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:25,444 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:35,499 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:35,500 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 380a9717-0864-4f18-86d3-5ca96ee592a5, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:44:35,500 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 380a9717-0864-4f18-86d3-5ca96ee592a5, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_2_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:35,502 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 380a9717-0864-4f18-86d3-5ca96ee592a5, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:41,639 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:41,690 - INFO - root.669971  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_2_compression`, volumes `value` (8000000, 1597784)
2025-11-21 20:44:41,691 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:41,692 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 59693228-3f42-40da-a7a5-3ddc8694ac4f, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:44:41,693 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 59693228-3f42-40da-a7a5-3ddc8694ac4f, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" 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_2_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:41,694 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 59693228-3f42-40da-a7a5-3ddc8694ac4f, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:42,164 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:42,165 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:42,230 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, a4f8d103-1c5a-428e-be44-d379de09bb8f, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:44:42,231 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, a4f8d103-1c5a-428e-be44-d379de09bb8f, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_2_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:42,232 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, a4f8d103-1c5a-428e-be44-d379de09bb8f, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:46,869 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:56,914 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:44:56,915 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, feb99319-0737-4960-8b4b-f9e26317a48f, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:44:56,916 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, feb99319-0737-4960-8b4b-f9e26317a48f, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_2_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:56,917 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, feb99319-0737-4960-8b4b-f9e26317a48f, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:59,331 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.669971  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-21 20:44:59,332 - DEBUG - ydb.connection.669971  - 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 20:44:59,383 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.669971  - context_resolve: Resolving endpoints for database /Root
2025-11-21 20:44:59,383 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ListEndpoints, 5746dfc7-8631-4944-84d4-3d17d9adef09, localhost:6158): creating call state
2025-11-21 20:44:59,384 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ListEndpoints, 5746dfc7-8631-4944-84d4-3d17d9adef09, localhost:6158): request = { database: "/Root" }
2025-11-21 20:44:59,418 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ListEndpoints, 5746dfc7-8631-4944-84d4-3d17d9adef09, localhost:6158): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-frzglb4yoy.auto.internal" port: 6158 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 20:44:59,426 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.669971  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-frzglb4yoy.auto.internal:6158, location 1, ssl: False>]>
2025-11-21 20:44:59,427 - DEBUG - ydb.connection.669971  - close: Closing channel for endpoint localhost:6158
2025-11-21 20:45:03,499 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:45:13,631 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:45:13,632 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 3665aebf-f245-4bb8-9d53-af73702a77d9, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:45:13,632 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 3665aebf-f245-4bb8-9d53-af73702a77d9, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_2_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:45:13,634 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 3665aebf-f245-4bb8-9d53-af73702a77d9, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:45:16,750 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:45:26,763 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:45:26,764 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, be1b3d37-85db-4887-8cd0-c3174ab24d86, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:45:26,765 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, be1b3d37-85db-4887-8cd0-c3174ab24d86, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_2_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:45:26,766 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, be1b3d37-85db-4887-8cd0-c3174ab24d86, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:45:28,417 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:45:38,423 - DEBUG - ydb.query.pool.669971  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:45:38,424 - DEBUG - ydb.connection.669971  - _prepare_call: RpcState(ExecuteQuery, 2d4790c9-3c1e-4db6-bd43-c7ada2e91321, ghrun-frzglb4yoy.auto.internal:6158): creating call state
2025-11-21 20:45:38,424 - DEBUG - ydb.connection.669971  - _log_request: RpcState(ExecuteQuery, 2d4790c9-3c1e-4db6-bd43-c7ada2e91321, ghrun-frzglb4yoy.auto.internal:6158): request = { session_id: "ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_2_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:45:38,426 - DEBUG - ydb.connection.669971  - _log_response: RpcState(ExecuteQuery, 2d4790c9-3c1e-4db6-bd43-c7ada2e91321, ghrun-frzglb4yoy.auto.internal:6158): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:45:39,754 - DEBUG - ydb.query.pool.669971  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZmM4OTY4Y2YtMmUxNmYzM2QtNTAxMzZiZjctZGVmNjhjMzU=
2025-11-21 20:45:39,758 - INFO - root.669971  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_2_compression`, volumes `value` (8000000, 1465320)
2025-11-21 20:45:39,759 - INFO - root.669971  - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_2_compression` 8092160 / 1465320: 5.522452433598122
2025-11-21 20:45:39,766 - INFO - ya.test.669971  - pytest_runtest_teardown: Test teardown
