2025-11-19 11:19:59,247 - INFO - ya.test.421802  - pytest_runtest_setup: ####################################################################################################
2025-11-19 11:19:59,248 - INFO - ya.test.421802  - pytest_runtest_setup: test_all_supported_compression[zstd_8_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 8]
2025-11-19 11:19:59,249 - INFO - ya.test.421802  - pytest_runtest_setup: ####################################################################################################
2025-11-19 11:19:59,249 - INFO - ya.test.421802  - pytest_runtest_setup: Test setup
2025-11-19 11:19:59,251 - DEBUG - ya.test.421802  - _get_command_output_file: Command out will be placed to ydbd.out
2025-11-19 11:19:59,252 - DEBUG - ya.test.421802  - _get_command_output_file: Command err will be placed to ydbd.err
2025-11-19 11:19:59,253 - DEBUG - ya.test.421802  - execute: Executing '['/home/runner/.ya/build/build_root/pbux/001558/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-19 11:19:59,262 - DEBUG - ya.test.421802  - execute: Command pid: 422683
2025-11-19 11:20:00,255 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422683) rc: 0
2025-11-19 11:20:00,255 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422683) elapsed time (sec): 0.9914772510528564
2025-11-19 11:20:00,256 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422683) idrss: 0
2025-11-19 11:20:00,256 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422683) inblock: 0
2025-11-19 11:20:00,256 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422683) isrss: 0
2025-11-19 11:20:00,257 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422683) ixrss: 0
2025-11-19 11:20:00,257 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422683) majflt: 0
2025-11-19 11:20:00,257 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422683) maxrss: 494576
2025-11-19 11:20:00,258 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422683) minflt: 45371
2025-11-19 11:20:00,258 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422683) msgrcv: 0
2025-11-19 11:20:00,258 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422683) msgsnd: 0
2025-11-19 11:20:00,258 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422683) nivcsw: 161
2025-11-19 11:20:00,259 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422683) nsignals: 0
2025-11-19 11:20:00,259 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422683) nswap: 0
2025-11-19 11:20:00,259 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422683) nvcsw: 14
2025-11-19 11:20:00,260 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422683) oublock: 8
2025-11-19 11:20:00,260 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422683) stime: 0.221084
2025-11-19 11:20:00,260 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422683) utime: 0.5618299999999999
2025-11-19 11:20:00,261 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422683) wtime: 1.001
2025-11-19 11:20:00,261 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422683) 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-alsqrntpxi    Host information: 
        Linux ghrun-alsqrntpxi 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-19 11:20:00,261 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422683) errors:

2025-11-19 11:20:00,262 - INFO - __tests__.base.421802  - _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-alsqrntpxi    Host information: 
        Linux ghrun-alsqrntpxi 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-19 11:20:00,399 - DEBUG - ya.test.421802  - get_binary: Binary was found by /home/runner/.ya/build/build_root/pbux/001558/ydb/apps/ydbd/ydbd
2025-11-19 11:20:00,400 - DEBUG - library.python.filelock.421802  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/12425
2025-11-19 11:20:00,402 - DEBUG - ydb.tests.library.harness.kikimr_runner.421802  - start: Working directory: /home/runner/.ya/build/build_root/pbux/001558/r3tmp/kikimr_cluster_begdkd2d
2025-11-19 11:20:00,465 - DEBUG - ya.test.421802  - get_binary: Binary was found by /home/runner/.ya/build/build_root/pbux/001558/ydb/apps/ydbd/ydbd
2025-11-19 11:20:00,465 - DEBUG - library.python.filelock.421802  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/12732
2025-11-19 11:20:00,466 - DEBUG - library.python.filelock.421802  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/14803
2025-11-19 11:20:00,467 - DEBUG - library.python.filelock.421802  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/29167
2025-11-19 11:20:00,467 - DEBUG - library.python.filelock.421802  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/25616
2025-11-19 11:20:00,468 - INFO - ydb.tests.library.harness.kikimr_runner.421802  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/pbux/001558/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/kikimr_configs"
2025-11-19 11:20:00,469 - INFO - ydb.tests.library.harness.kikimr_runner.421802  - __make_run_command: Final command: /home/runner/.ya/build/build_root/pbux/001558/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/pbux/001558/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/node_1/logfile_k_xypifj.log --grpc-port=12732 --mon-port=14803 --ic-port=12425
2025-11-19 11:20:00,469 - DEBUG - ydb.tests.library.harness.kikimr_runner.421802  - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:12732/1, disk_size 68719476736
2025-11-19 11:20:00,470 - INFO - ydb.tests.library.harness.kikimr_runner.421802  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/pbux/001558/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/kikimr_configs"
2025-11-19 11:20:00,470 - INFO - ydb.tests.library.harness.kikimr_runner.421802  - __make_run_command: Final command: /home/runner/.ya/build/build_root/pbux/001558/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/pbux/001558/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/node_1/logfile_k_xypifj.log --grpc-port=12732 --mon-port=14803 --ic-port=12425
2025-11-19 11:20:00,471 - DEBUG - ya.test.421802  - execute: Executing '('/home/runner/.ya/build/build_root/pbux/001558/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/pbux/001558/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/pbux/001558/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/node_1/logfile_k_xypifj.log', '--grpc-port=12732', '--mon-port=14803', '--ic-port=12425')' in '/home/runner/.ya/build/build_root/pbux/001558/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/node_1' (no wait)
2025-11-19 11:20:00,477 - DEBUG - ya.test.421802  - execute: Command pid: 422979
2025-11-19 11:20:00,478 - INFO - ydb.tests.library.harness.kikimr_runner.421802  - start: Started node localhost:12732/1
2025-11-19 11:20:00,480 - DEBUG - ya.test.421802  - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-11-19 11:20:00,481 - DEBUG - ya.test.421802  - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-11-19 11:20:00,481 - DEBUG - ya.test.421802  - execute: Executing '['/home/runner/.ya/build/build_root/pbux/001558/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-19 11:20:00,492 - DEBUG - ya.test.421802  - execute: Command pid: 422983
2025-11-19 11:20:01,432 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422983) rc: 0
2025-11-19 11:20:01,433 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422983) elapsed time (sec): 0.9391400814056396
2025-11-19 11:20:01,433 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422983) idrss: 0
2025-11-19 11:20:01,434 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422983) inblock: 0
2025-11-19 11:20:01,434 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422983) isrss: 0
2025-11-19 11:20:01,434 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422983) ixrss: 0
2025-11-19 11:20:01,434 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422983) majflt: 0
2025-11-19 11:20:01,435 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422983) maxrss: 496928
2025-11-19 11:20:01,435 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422983) minflt: 45394
2025-11-19 11:20:01,435 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422983) msgrcv: 0
2025-11-19 11:20:01,436 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422983) msgsnd: 0
2025-11-19 11:20:01,436 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422983) nivcsw: 146
2025-11-19 11:20:01,437 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422983) nsignals: 0
2025-11-19 11:20:01,437 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422983) nswap: 0
2025-11-19 11:20:01,437 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422983) nvcsw: 16
2025-11-19 11:20:01,438 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422983) oublock: 8
2025-11-19 11:20:01,438 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422983) stime: 0.230232
2025-11-19 11:20:01,438 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422983) utime: 0.537848
2025-11-19 11:20:01,438 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422983) wtime: 0.95
2025-11-19 11:20:01,439 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422983) 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-alsqrntpxi    Host information: 
        Linux ghrun-alsqrntpxi 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-19 11:20:01,439 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 422983) errors:

2025-11-19 11:20:01,441 - INFO - ydb.tests.library.harness.kikimr_runner.421802  - 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-alsqrntpxi    Host information: 
        Linux ghrun-alsqrntpxi 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64
2025-11-19 11:20:06,569 - DEBUG - ya.test.421802  - get_binary: Binary was found by /home/runner/.ya/build/build_root/pbux/001558/ydb/apps/ydbd/ydbd
2025-11-19 11:20:06,570 - DEBUG - ydb.tests.library.harness.kikimr_runner.421802  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/pbux/001558/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:12732', '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: 12425\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-19 11:20:06,571 - DEBUG - ya.test.421802  - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-11-19 11:20:06,572 - DEBUG - ya.test.421802  - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-11-19 11:20:06,573 - DEBUG - ya.test.421802  - execute: Executing '['/home/runner/.ya/build/build_root/pbux/001558/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:12732', '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: 12425\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-19 11:20:06,579 - DEBUG - ya.test.421802  - execute: Command pid: 424539
2025-11-19 11:20:07,636 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424539) rc: 0
2025-11-19 11:20:07,637 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424539) elapsed time (sec): 1.055741310119629
2025-11-19 11:20:07,637 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424539) idrss: 0
2025-11-19 11:20:07,637 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424539) inblock: 0
2025-11-19 11:20:07,637 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424539) isrss: 0
2025-11-19 11:20:07,638 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424539) ixrss: 0
2025-11-19 11:20:07,638 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424539) majflt: 0
2025-11-19 11:20:07,638 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424539) maxrss: 591476
2025-11-19 11:20:07,638 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424539) minflt: 51615
2025-11-19 11:20:07,639 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424539) msgrcv: 0
2025-11-19 11:20:07,639 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424539) msgsnd: 0
2025-11-19 11:20:07,639 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424539) nivcsw: 236
2025-11-19 11:20:07,640 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424539) nsignals: 0
2025-11-19 11:20:07,640 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424539) nswap: 0
2025-11-19 11:20:07,640 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424539) nvcsw: 633
2025-11-19 11:20:07,641 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424539) oublock: 8
2025-11-19 11:20:07,641 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424539) stime: 0.300241
2025-11-19 11:20:07,646 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424539) utime: 0.572323
2025-11-19 11:20:07,647 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424539) wtime: 1.063
2025-11-19 11:20:07,647 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424539) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-19 11:20:07,647 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424539) errors:

2025-11-19 11:20:07,649 - DEBUG - ya.test.421802  - get_binary: Binary was found by /home/runner/.ya/build/build_root/pbux/001558/ydb/apps/ydbd/ydbd
2025-11-19 11:20:07,649 - DEBUG - ydb.tests.library.harness.kikimr_runner.421802  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/pbux/001558/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:12732', '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-19 11:20:07,650 - DEBUG - ya.test.421802  - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-11-19 11:20:07,651 - DEBUG - ya.test.421802  - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-11-19 11:20:07,652 - DEBUG - ya.test.421802  - execute: Executing '['/home/runner/.ya/build/build_root/pbux/001558/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:12732', '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-19 11:20:07,660 - DEBUG - ya.test.421802  - execute: Command pid: 424817
2025-11-19 11:20:08,695 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424817) rc: 0
2025-11-19 11:20:08,696 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424817) elapsed time (sec): 1.0341460704803467
2025-11-19 11:20:08,696 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424817) idrss: 0
2025-11-19 11:20:08,697 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424817) inblock: 0
2025-11-19 11:20:08,697 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424817) isrss: 0
2025-11-19 11:20:08,697 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424817) ixrss: 0
2025-11-19 11:20:08,698 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424817) majflt: 0
2025-11-19 11:20:08,698 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424817) maxrss: 591476
2025-11-19 11:20:08,698 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424817) minflt: 51696
2025-11-19 11:20:08,699 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424817) msgrcv: 0
2025-11-19 11:20:08,699 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424817) msgsnd: 0
2025-11-19 11:20:08,699 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424817) nivcsw: 198
2025-11-19 11:20:08,699 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424817) nsignals: 0
2025-11-19 11:20:08,708 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424817) nswap: 0
2025-11-19 11:20:08,708 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424817) nvcsw: 619
2025-11-19 11:20:08,709 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424817) oublock: 8
2025-11-19 11:20:08,709 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424817) stime: 0.27805599999999997
2025-11-19 11:20:08,709 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424817) utime: 0.546519
2025-11-19 11:20:08,710 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424817) wtime: 1.039
2025-11-19 11:20:08,710 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424817) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-11-19 11:20:08,710 - DEBUG - ya.test.421802  - _save_outputs: Command (pid 424817) errors:

2025-11-19 11:20:08,711 - INFO - ydb.tests.library.harness.kikimr_runner.421802  - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-19 11:20:08,912 - INFO - ydb.tests.library.harness.kikimr_runner.421802  - __run: Cluster started and initialized
2025-11-19 11:20:08,948 - DEBUG - ydb.connection.421802  - 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-19 11:20:08,956 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.421802  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-19 11:20:08,957 - DEBUG - ydb.connection.421802  - 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-19 11:20:08,975 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.421802  - context_resolve: Resolving endpoints for database /Root
2025-11-19 11:20:08,976 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ListEndpoints, 7a12237a-4259-4134-a2c6-6086c8790910, localhost:12732): creating call state
2025-11-19 11:20:08,977 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ListEndpoints, 7a12237a-4259-4134-a2c6-6086c8790910, localhost:12732): request = { database: "/Root" }
2025-11-19 11:20:08,992 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ListEndpoints, 7a12237a-4259-4134-a2c6-6086c8790910, localhost:12732): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-alsqrntpxi.auto.internal" port: 12732 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-19 11:20:08,993 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.421802  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-alsqrntpxi.auto.internal:12732, location 1, ssl: False>]>
2025-11-19 11:20:08,994 - DEBUG - ydb.connection.421802  - 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-19 11:20:09,032 - DEBUG - ydb.connection.421802  - close: Closing channel for endpoint localhost:12732
2025-11-19 11:20:09,033 - DEBUG - ydb.query.pool.421802  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-19 11:20:09,034 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(CreateSession, c54da414-2289-4d1f-b4c7-0984b6fec4ad, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:09,035 - DEBUG - ydb.connection.421802  - _log_request: RpcState(CreateSession, c54da414-2289-4d1f-b4c7-0984b6fec4ad, ghrun-alsqrntpxi.auto.internal:12732): request = {  }
2025-11-19 11:20:09,049 - DEBUG - ydb.connection.421802  - _log_response: RpcState(CreateSession, c54da414-2289-4d1f-b4c7-0984b6fec4ad, ghrun-alsqrntpxi.auto.internal:12732): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" node_id: 1 }
2025-11-19 11:20:09,050 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(AttachSession, 1fc7849d-0d8d-47da-bc93-43c6f36a63aa, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:09,050 - DEBUG - ydb.connection.421802  - _log_request: RpcState(AttachSession, 1fc7849d-0d8d-47da-bc93-43c6f36a63aa, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" }
2025-11-19 11:20:09,061 - DEBUG - ydb.connection.421802  - _log_response: RpcState(AttachSession, 1fc7849d-0d8d-47da-bc93-43c6f36a63aa, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:09,092 - DEBUG - ydb.query.pool.421802  - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:09,093 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 4f186be8-ef6c-419d-b3ed-0321e0446f61, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:09,094 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 4f186be8-ef6c-419d-b3ed-0321e0446f61, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:09,095 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 4f186be8-ef6c-419d-b3ed-0321e0446f61, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:12,019 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:12,020 - INFO - __tests__.alter_compression.421802  - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-11-19 11:20:12,020 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:12,021 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, e38bcf53-9664-4276-8620-54a0f8dd0091, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:12,022 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, e38bcf53-9664-4276-8620-54a0f8dd0091, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:12,024 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, e38bcf53-9664-4276-8620-54a0f8dd0091, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:13,038 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:13,039 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:13,040 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 9f447dad-364e-4364-a881-b165c3921721, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:13,041 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 9f447dad-364e-4364-a881-b165c3921721, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:13,043 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 9f447dad-364e-4364-a881-b165c3921721, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:14,268 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:14,269 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:14,270 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 01c8f232-d5b8-4cce-8239-72916b1e7117, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:14,271 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 01c8f232-d5b8-4cce-8239-72916b1e7117, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:14,273 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 01c8f232-d5b8-4cce-8239-72916b1e7117, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:15,184 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:15,185 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:15,186 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, e6a4481b-5751-4e85-b11e-a74627bca917, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:15,187 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, e6a4481b-5751-4e85-b11e-a74627bca917, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:15,189 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, e6a4481b-5751-4e85-b11e-a74627bca917, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:16,532 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:16,533 - INFO - __tests__.alter_compression.421802  - 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-19 11:20:16,534 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:16,535 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, d46b4b81-8d29-4c07-82ad-2fd256d4c1cd, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:16,536 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, d46b4b81-8d29-4c07-82ad-2fd256d4c1cd, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:16,538 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, d46b4b81-8d29-4c07-82ad-2fd256d4c1cd, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:17,429 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:17,430 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:17,430 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 19e8ed15-ce40-41ed-8142-55f1002feaf2, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:17,431 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 19e8ed15-ce40-41ed-8142-55f1002feaf2, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:17,433 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 19e8ed15-ce40-41ed-8142-55f1002feaf2, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:17,728 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:17,729 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:17,730 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, bc61e7f9-db2f-4a75-8310-04ee4c29db6d, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:17,731 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, bc61e7f9-db2f-4a75-8310-04ee4c29db6d, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:17,733 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, bc61e7f9-db2f-4a75-8310-04ee4c29db6d, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:18,126 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:18,126 - INFO - __tests__.alter_compression.421802  - 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-19 11:20:18,127 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:18,128 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 8c0a7ced-7781-4a45-a96e-8481e7ab4b4e, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:18,129 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 8c0a7ced-7781-4a45-a96e-8481e7ab4b4e, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:18,139 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 8c0a7ced-7781-4a45-a96e-8481e7ab4b4e, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:19,289 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:19,290 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:19,290 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 4adb1a1d-da32-493e-a891-d732a791376f, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:19,291 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 4adb1a1d-da32-493e-a891-d732a791376f, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:19,293 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 4adb1a1d-da32-493e-a891-d732a791376f, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:19,629 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:19,630 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:19,631 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, e5e29348-c253-4d14-8f9b-b1f1773e3b7e, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:19,635 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, e5e29348-c253-4d14-8f9b-b1f1773e3b7e, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:19,637 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, e5e29348-c253-4d14-8f9b-b1f1773e3b7e, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:19,999 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:20,000 - INFO - __tests__.alter_compression.421802  - 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-19 11:20:20,000 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:20,001 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 13cc5016-a7df-40ed-b6c8-20a58532e737, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:20,002 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 13cc5016-a7df-40ed-b6c8-20a58532e737, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:20,003 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 13cc5016-a7df-40ed-b6c8-20a58532e737, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:21,094 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:21,094 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:21,095 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 0df9745d-ba7d-4329-b8fe-31aa9a571647, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:21,096 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 0df9745d-ba7d-4329-b8fe-31aa9a571647, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:21,097 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 0df9745d-ba7d-4329-b8fe-31aa9a571647, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:21,415 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:21,415 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:21,416 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 4d0ac5b8-dc9f-47c2-a662-0640d7c3f8c3, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:21,417 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 4d0ac5b8-dc9f-47c2-a662-0640d7c3f8c3, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:21,419 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 4d0ac5b8-dc9f-47c2-a662-0640d7c3f8c3, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:21,860 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:21,861 - INFO - __tests__.alter_compression.421802  - 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-19 11:20:21,862 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:21,862 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 16a45296-748a-442a-9973-f56dcdbf79b0, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:21,863 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 16a45296-748a-442a-9973-f56dcdbf79b0, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:21,865 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 16a45296-748a-442a-9973-f56dcdbf79b0, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:22,913 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:22,914 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:22,915 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 0a55527c-df8a-4b0d-8429-097c09e7b91c, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:22,915 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 0a55527c-df8a-4b0d-8429-097c09e7b91c, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:22,917 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 0a55527c-df8a-4b0d-8429-097c09e7b91c, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:23,329 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:23,329 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:23,330 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 53e0c32a-3e5f-4fa4-90eb-b4d4e3fb43a3, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:23,331 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 53e0c32a-3e5f-4fa4-90eb-b4d4e3fb43a3, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:23,334 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 53e0c32a-3e5f-4fa4-90eb-b4d4e3fb43a3, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:23,789 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:23,790 - INFO - __tests__.alter_compression.421802  - 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-19 11:20:23,791 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:23,791 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 0a0ab058-789f-4c1f-9250-60a9af04bf37, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:23,792 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 0a0ab058-789f-4c1f-9250-60a9af04bf37, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:23,794 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 0a0ab058-789f-4c1f-9250-60a9af04bf37, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:25,033 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:25,034 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:25,034 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 9388463a-2ca8-454e-a092-7e44f506f21f, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:25,035 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 9388463a-2ca8-454e-a092-7e44f506f21f, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:25,037 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 9388463a-2ca8-454e-a092-7e44f506f21f, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:25,328 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:25,328 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:25,329 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 5a5b03cf-802f-48cd-ba12-8977bb814afd, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:25,330 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 5a5b03cf-802f-48cd-ba12-8977bb814afd, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:25,333 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 5a5b03cf-802f-48cd-ba12-8977bb814afd, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:25,890 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:25,890 - INFO - __tests__.alter_compression.421802  - 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-19 11:20:25,891 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:25,891 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 14553411-a832-4bf8-8cdc-465a54cc261e, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:25,892 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 14553411-a832-4bf8-8cdc-465a54cc261e, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:25,894 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 14553411-a832-4bf8-8cdc-465a54cc261e, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:26,904 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:26,905 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:26,906 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 32c4eace-5f2c-4398-96e3-966bb8aa94f2, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:26,906 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 32c4eace-5f2c-4398-96e3-966bb8aa94f2, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:26,909 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 32c4eace-5f2c-4398-96e3-966bb8aa94f2, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:27,191 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:27,192 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:27,192 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, ebd5e1df-3618-49d2-a4e6-3021627278ae, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:27,193 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, ebd5e1df-3618-49d2-a4e6-3021627278ae, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:27,194 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, ebd5e1df-3618-49d2-a4e6-3021627278ae, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:27,663 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:27,664 - INFO - __tests__.alter_compression.421802  - 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-19 11:20:27,664 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:27,665 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 9bc1b5bf-2a03-42d3-a791-73fadd01c2f9, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:27,666 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 9bc1b5bf-2a03-42d3-a791-73fadd01c2f9, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:27,669 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 9bc1b5bf-2a03-42d3-a791-73fadd01c2f9, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:28,789 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:28,790 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:28,790 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, a7a03d40-94e8-4429-a099-effb8b8ec379, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:28,791 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, a7a03d40-94e8-4429-a099-effb8b8ec379, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:28,793 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, a7a03d40-94e8-4429-a099-effb8b8ec379, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:29,122 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:29,122 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:29,123 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 366d44e2-e2a9-476c-acab-84f0502a93bf, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:29,124 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 366d44e2-e2a9-476c-acab-84f0502a93bf, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:29,126 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 366d44e2-e2a9-476c-acab-84f0502a93bf, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:29,795 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:29,796 - INFO - __tests__.alter_compression.421802  - 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-19 11:20:29,797 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:29,798 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 8b252121-2b32-44a3-b105-b9aaa5c673cc, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:29,799 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 8b252121-2b32-44a3-b105-b9aaa5c673cc, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:29,800 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 8b252121-2b32-44a3-b105-b9aaa5c673cc, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:30,994 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:30,995 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:30,996 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 023921ae-ed78-4094-bde1-6a9ad9b3058d, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:30,997 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 023921ae-ed78-4094-bde1-6a9ad9b3058d, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:30,998 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 023921ae-ed78-4094-bde1-6a9ad9b3058d, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:31,242 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:31,243 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:31,244 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 9b38e779-ec47-46df-8322-edf381b75ccb, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:31,245 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 9b38e779-ec47-46df-8322-edf381b75ccb, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:31,246 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 9b38e779-ec47-46df-8322-edf381b75ccb, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:31,920 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:31,921 - INFO - __tests__.alter_compression.421802  - 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-19 11:20:31,922 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:31,923 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 350752e4-7d8b-4bcd-bc44-1c0a320ba4d1, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:31,924 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 350752e4-7d8b-4bcd-bc44-1c0a320ba4d1, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:31,925 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 350752e4-7d8b-4bcd-bc44-1c0a320ba4d1, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:33,117 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:33,118 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:33,119 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, ae5a6acc-7dc1-407f-9ae1-8b2a312cb022, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:33,119 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, ae5a6acc-7dc1-407f-9ae1-8b2a312cb022, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:33,121 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, ae5a6acc-7dc1-407f-9ae1-8b2a312cb022, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:33,435 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:33,436 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:33,437 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 1c761d3e-6c82-4242-8c66-7ba42a7dc15e, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:33,438 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 1c761d3e-6c82-4242-8c66-7ba42a7dc15e, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:33,439 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 1c761d3e-6c82-4242-8c66-7ba42a7dc15e, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:34,124 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:34,125 - INFO - __tests__.alter_compression.421802  - 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-19 11:20:34,126 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:34,126 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 9a9b35e8-cf0f-4019-b81f-5c44a9509d47, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:34,127 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 9a9b35e8-cf0f-4019-b81f-5c44a9509d47, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:34,129 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 9a9b35e8-cf0f-4019-b81f-5c44a9509d47, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:35,368 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:35,369 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:35,370 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 2f203ba1-b08c-444c-b694-de1d7fac663f, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:35,371 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 2f203ba1-b08c-444c-b694-de1d7fac663f, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:35,372 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 2f203ba1-b08c-444c-b694-de1d7fac663f, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:35,610 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:35,611 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:35,612 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, eddb8266-e1a2-4f1a-858c-b998c9c708aa, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:35,613 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, eddb8266-e1a2-4f1a-858c-b998c9c708aa, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:35,615 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, eddb8266-e1a2-4f1a-858c-b998c9c708aa, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:35,900 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:35,901 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:35,902 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, b020a819-aa09-4b28-af6e-0333293a3210, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:35,903 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, b020a819-aa09-4b28-af6e-0333293a3210, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:35,904 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, b020a819-aa09-4b28-af6e-0333293a3210, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:39,700 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:49,748 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:49,749 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 361abf8e-c339-4bc3-b6de-1965fcb0337a, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:49,750 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 361abf8e-c339-4bc3-b6de-1965fcb0337a, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:49,752 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 361abf8e-c339-4bc3-b6de-1965fcb0337a, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:52,678 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:52,722 - INFO - root.421802  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-11-19 11:20:52,723 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:20:52,723 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, e7a5b938-869f-4273-b707-9ac4464583b0, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:20:52,724 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, e7a5b938-869f-4273-b707-9ac4464583b0, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:20:52,726 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, e7a5b938-869f-4273-b707-9ac4464583b0, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:55,862 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:05,916 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:05,917 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, ed8a43f2-28d4-4ef7-bf4e-d1c72d645790, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:05,918 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, ed8a43f2-28d4-4ef7-bf4e-d1c72d645790, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:21:05,919 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, ed8a43f2-28d4-4ef7-bf4e-d1c72d645790, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:09,185 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:09,228 - INFO - root.421802  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-11-19 11:21:09,229 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:09,229 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, b9f46b65-3602-44d6-adfa-d7974ed5d852, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:09,230 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, b9f46b65-3602-44d6-adfa-d7974ed5d852, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" 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-19 11:21:09,232 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, b9f46b65-3602-44d6-adfa-d7974ed5d852, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:09,488 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:09,493 - INFO - ya.test.421802  - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_8_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 8])
2025-11-19 11:21:09,494 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:09,495 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, fd65e759-f1de-4de8-892f-c2a9c0624b3b, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:09,496 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, fd65e759-f1de-4de8-892f-c2a9c0624b3b, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_8_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 8)\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:09,501 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, fd65e759-f1de-4de8-892f-c2a9c0624b3b, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:13,645 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:13,646 - INFO - __tests__.alter_compression.421802  - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_8_compression created
2025-11-19 11:21:13,646 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:13,647 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 6a1a1da0-1237-4e9e-b334-8872dc4e51cd, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:13,648 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 6a1a1da0-1237-4e9e-b334-8872dc4e51cd, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_8_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:13,650 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 6a1a1da0-1237-4e9e-b334-8872dc4e51cd, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:14,484 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:14,485 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:14,486 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, d0763559-dedb-4831-b2c0-f7ec56af2626, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:14,487 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, d0763559-dedb-4831-b2c0-f7ec56af2626, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 0;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:14,489 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, d0763559-dedb-4831-b2c0-f7ec56af2626, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:16,730 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:16,731 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:16,732 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 6e1b4cc4-24a0-4e82-87cb-8b29e2057353, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:16,733 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 6e1b4cc4-24a0-4e82-87cb-8b29e2057353, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:16,735 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 6e1b4cc4-24a0-4e82-87cb-8b29e2057353, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:17,750 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:17,751 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:17,752 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 22fbb6b2-1e66-43db-90a2-5f2bf6eb92f7, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:17,753 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 22fbb6b2-1e66-43db-90a2-5f2bf6eb92f7, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:17,755 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 22fbb6b2-1e66-43db-90a2-5f2bf6eb92f7, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:19,638 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:19,639 - INFO - __tests__.alter_compression.421802  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318016, 'BlobCount': 128}}
2025-11-19 11:21:19,639 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:19,640 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 2c3a8b16-27f6-46dd-927f-c090d511cd45, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:19,641 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 2c3a8b16-27f6-46dd-927f-c090d511cd45, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 100000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:19,642 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 2c3a8b16-27f6-46dd-927f-c090d511cd45, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:21,510 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:21,511 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:21,512 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, c33ba863-b581-4672-92a9-7c0034a05697, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:21,513 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, c33ba863-b581-4672-92a9-7c0034a05697, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:21,514 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, c33ba863-b581-4672-92a9-7c0034a05697, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:21,792 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:21,793 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:21,800 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, bfee6c16-3645-42f0-bf1c-2eaae4c07cd8, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:21,800 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, bfee6c16-3645-42f0-bf1c-2eaae4c07cd8, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:21,802 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, bfee6c16-3645-42f0-bf1c-2eaae4c07cd8, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:22,158 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:22,159 - INFO - __tests__.alter_compression.421802  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 637312, 'BlobCount': 256}}
2025-11-19 11:21:22,159 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:22,160 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 1d246415-7c6a-4a24-a49a-935f15645c95, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:22,161 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 1d246415-7c6a-4a24-a49a-935f15645c95, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 200000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:22,162 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 1d246415-7c6a-4a24-a49a-935f15645c95, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:24,013 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:24,014 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:24,015 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, e1e16855-1df8-4209-aa75-82dd1ed1d4c2, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:24,016 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, e1e16855-1df8-4209-aa75-82dd1ed1d4c2, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:24,017 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, e1e16855-1df8-4209-aa75-82dd1ed1d4c2, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:24,312 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:24,313 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:24,314 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 3970bc20-dd25-4f75-9a51-9270249399d1, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:24,315 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 3970bc20-dd25-4f75-9a51-9270249399d1, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:24,316 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 3970bc20-dd25-4f75-9a51-9270249399d1, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:24,688 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:24,689 - INFO - __tests__.alter_compression.421802  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 956352, 'BlobCount': 384}}
2025-11-19 11:21:24,689 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:24,690 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 580fcdc2-9956-4722-8d91-7b2aa8d3f250, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:24,691 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 580fcdc2-9956-4722-8d91-7b2aa8d3f250, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 300000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:24,692 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 580fcdc2-9956-4722-8d91-7b2aa8d3f250, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:26,561 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:26,562 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:26,562 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 686763b2-f56b-4c82-99a7-969c0bf0cc25, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:26,563 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 686763b2-f56b-4c82-99a7-969c0bf0cc25, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:26,565 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 686763b2-f56b-4c82-99a7-969c0bf0cc25, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:26,858 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:26,859 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:26,860 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 27127ef4-f8a1-48a6-9397-87eee41a72bc, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:26,861 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 27127ef4-f8a1-48a6-9397-87eee41a72bc, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:26,863 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 27127ef4-f8a1-48a6-9397-87eee41a72bc, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:27,430 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:27,431 - INFO - __tests__.alter_compression.421802  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1275712, 'BlobCount': 512}}
2025-11-19 11:21:27,431 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:27,464 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 7a0f0577-2dfc-4584-bb3b-ab1c3f7a04e2, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:27,466 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 7a0f0577-2dfc-4584-bb3b-ab1c3f7a04e2, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 400000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:27,467 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 7a0f0577-2dfc-4584-bb3b-ab1c3f7a04e2, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:29,401 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:29,402 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:29,402 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 5d4f8ccb-106c-4822-9467-07a527b77cc3, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:29,403 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 5d4f8ccb-106c-4822-9467-07a527b77cc3, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:29,405 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 5d4f8ccb-106c-4822-9467-07a527b77cc3, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:29,709 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:29,710 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:29,711 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, ace54b83-cb72-41c2-a02d-d8869d60f801, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:29,714 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, ace54b83-cb72-41c2-a02d-d8869d60f801, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:29,715 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, ace54b83-cb72-41c2-a02d-d8869d60f801, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:30,398 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:30,409 - INFO - __tests__.alter_compression.421802  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1594672, 'BlobCount': 640}}
2025-11-19 11:21:30,409 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:30,410 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, cc44d149-ac53-42b9-a0ba-94e57050d602, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:30,411 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, cc44d149-ac53-42b9-a0ba-94e57050d602, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 500000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:30,413 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, cc44d149-ac53-42b9-a0ba-94e57050d602, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:32,658 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:32,659 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:32,660 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, b05ef8de-35ee-4abc-ae01-d817e01977c3, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:32,661 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, b05ef8de-35ee-4abc-ae01-d817e01977c3, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:32,666 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, b05ef8de-35ee-4abc-ae01-d817e01977c3, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:32,964 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:32,964 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:32,965 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, f179f4a1-b7f1-4e86-b2fe-8296d9db7225, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:32,965 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, f179f4a1-b7f1-4e86-b2fe-8296d9db7225, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:32,966 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, f179f4a1-b7f1-4e86-b2fe-8296d9db7225, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:33,513 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:33,514 - INFO - __tests__.alter_compression.421802  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1913856, 'BlobCount': 768}}
2025-11-19 11:21:33,514 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:33,515 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 42af3ef5-51ff-483d-b10d-1f7f733b210f, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:33,516 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 42af3ef5-51ff-483d-b10d-1f7f733b210f, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 600000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:33,517 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 42af3ef5-51ff-483d-b10d-1f7f733b210f, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:35,594 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:35,594 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:35,595 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 5007594b-f89e-4220-b808-f0b143545ff5, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:35,596 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 5007594b-f89e-4220-b808-f0b143545ff5, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:35,606 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 5007594b-f89e-4220-b808-f0b143545ff5, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:35,905 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:35,906 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:35,907 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 9993d984-1b17-4f70-afa8-40b10f20bf5f, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:35,908 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 9993d984-1b17-4f70-afa8-40b10f20bf5f, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:35,909 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 9993d984-1b17-4f70-afa8-40b10f20bf5f, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:36,534 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:36,535 - INFO - __tests__.alter_compression.421802  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2232992, 'BlobCount': 896}}
2025-11-19 11:21:36,536 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:36,536 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, c77969d6-2c33-4b16-9a36-b78d5eade6a7, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:36,537 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, c77969d6-2c33-4b16-9a36-b78d5eade6a7, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 700000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:36,539 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, c77969d6-2c33-4b16-9a36-b78d5eade6a7, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:38,758 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:38,759 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:38,760 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 4d6df249-58df-4e2d-8ef9-39431a9e6d5d, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:38,761 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 4d6df249-58df-4e2d-8ef9-39431a9e6d5d, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:38,762 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 4d6df249-58df-4e2d-8ef9-39431a9e6d5d, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:39,045 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:39,046 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:39,047 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, f6648987-dfb9-46b1-9fb3-418b5e08fccd, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:39,048 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, f6648987-dfb9-46b1-9fb3-418b5e08fccd, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:39,049 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, f6648987-dfb9-46b1-9fb3-418b5e08fccd, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:39,093 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.421802  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-19 11:21:39,094 - DEBUG - ydb.connection.421802  - 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-19 11:21:39,132 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.421802  - context_resolve: Resolving endpoints for database /Root
2025-11-19 11:21:39,133 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ListEndpoints, abbec13b-bb2d-469d-be88-f8b0f3a26db0, localhost:12732): creating call state
2025-11-19 11:21:39,133 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ListEndpoints, abbec13b-bb2d-469d-be88-f8b0f3a26db0, localhost:12732): request = { database: "/Root" }
2025-11-19 11:21:39,159 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ListEndpoints, abbec13b-bb2d-469d-be88-f8b0f3a26db0, localhost:12732): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-alsqrntpxi.auto.internal" port: 12732 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-19 11:21:39,160 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.421802  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-alsqrntpxi.auto.internal:12732, location 1, ssl: False>]>
2025-11-19 11:21:39,160 - DEBUG - ydb.connection.421802  - close: Closing channel for endpoint localhost:12732
2025-11-19 11:21:39,612 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:39,613 - INFO - __tests__.alter_compression.421802  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2552480, 'BlobCount': 1024}}
2025-11-19 11:21:39,620 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:39,621 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, f9747766-dfaf-42c7-8f13-e6c05791f21f, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:39,637 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, f9747766-dfaf-42c7-8f13-e6c05791f21f, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 800000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:39,638 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, f9747766-dfaf-42c7-8f13-e6c05791f21f, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:41,487 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:41,488 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:41,498 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 492f52ad-acbd-4b33-8cac-a471d57a0420, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:41,500 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 492f52ad-acbd-4b33-8cac-a471d57a0420, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:41,505 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 492f52ad-acbd-4b33-8cac-a471d57a0420, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:41,790 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:41,791 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:41,792 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 853dc6d6-2b9a-4148-a649-7faf15f19dd1, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:41,793 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 853dc6d6-2b9a-4148-a649-7faf15f19dd1, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:41,795 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 853dc6d6-2b9a-4148-a649-7faf15f19dd1, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:42,506 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:42,507 - INFO - __tests__.alter_compression.421802  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2871488, 'BlobCount': 1152}}
2025-11-19 11:21:42,507 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:42,508 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 7bcd72ff-189b-4d02-acc6-da2649b31215, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:42,509 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 7bcd72ff-189b-4d02-acc6-da2649b31215, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 900000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:42,511 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 7bcd72ff-189b-4d02-acc6-da2649b31215, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:44,261 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:44,262 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:44,263 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, fd4170db-bcfe-49db-a899-da824a0ad278, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:44,264 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, fd4170db-bcfe-49db-a899-da824a0ad278, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:44,265 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, fd4170db-bcfe-49db-a899-da824a0ad278, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:44,547 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:44,548 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:44,549 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 4887dcb8-5d1f-4c44-b225-1a2b61857b57, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:44,550 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 4887dcb8-5d1f-4c44-b225-1a2b61857b57, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:44,551 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 4887dcb8-5d1f-4c44-b225-1a2b61857b57, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:45,216 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:45,217 - INFO - __tests__.alter_compression.421802  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3190992, 'BlobCount': 1280}}
2025-11-19 11:21:45,217 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:45,219 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 32dbf024-4b38-47ff-8caf-90c60c4e3d29, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:45,220 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 32dbf024-4b38-47ff-8caf-90c60c4e3d29, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_8_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:45,221 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 32dbf024-4b38-47ff-8caf-90c60c4e3d29, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:46,257 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:46,258 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:46,259 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 02c4d9f2-d35b-4a99-ad10-173c12577a13, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:46,260 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 02c4d9f2-d35b-4a99-ad10-173c12577a13, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:46,262 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 02c4d9f2-d35b-4a99-ad10-173c12577a13, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:46,553 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:46,554 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:46,555 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 4aa31fbc-d4d7-4177-9dfe-93239b8dcc9c, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:46,555 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 4aa31fbc-d4d7-4177-9dfe-93239b8dcc9c, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:46,557 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 4aa31fbc-d4d7-4177-9dfe-93239b8dcc9c, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:46,836 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:46,837 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:21:46,838 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, e9a3cf3d-10bf-4b40-959b-7cde8b17e64f, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:21:46,839 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, e9a3cf3d-10bf-4b40-959b-7cde8b17e64f, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:46,841 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, e9a3cf3d-10bf-4b40-959b-7cde8b17e64f, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:50,030 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:22:00,076 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:22:00,077 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 1c44089a-b0ee-4789-a4b3-fc57a5d23ffd, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:22:00,078 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 1c44089a-b0ee-4789-a4b3-fc57a5d23ffd, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:22:00,079 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 1c44089a-b0ee-4789-a4b3-fc57a5d23ffd, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:22:06,351 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:22:06,392 - INFO - root.421802  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_8_compression`, volumes `value` (8000000, 1595496)
2025-11-19 11:22:06,393 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:22:06,394 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, b3bcf2db-a619-471b-91c8-91e0c642a529, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:22:06,395 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, b3bcf2db-a619-471b-91c8-91e0c642a529, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:22:06,396 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, b3bcf2db-a619-471b-91c8-91e0c642a529, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:22:06,910 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:22:06,911 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:22:06,912 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, dcb6dc71-befb-4593-883c-4f379af77b31, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:22:06,913 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, dcb6dc71-befb-4593-883c-4f379af77b31, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:22:06,917 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, dcb6dc71-befb-4593-883c-4f379af77b31, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:22:15,581 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:22:25,808 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:22:25,809 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 2f82e45d-6df7-4385-93ee-daee67518390, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:22:25,810 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 2f82e45d-6df7-4385-93ee-daee67518390, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:22:25,813 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 2f82e45d-6df7-4385-93ee-daee67518390, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:22:29,838 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:22:39,881 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:22:39,884 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 22b9ac72-bced-4c02-90a8-5d869ffbcf43, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:22:39,885 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 22b9ac72-bced-4c02-90a8-5d869ffbcf43, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:22:39,889 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 22b9ac72-bced-4c02-90a8-5d869ffbcf43, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:22:41,281 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:22:50,357 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.421802  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-19 11:22:50,357 - DEBUG - ydb.connection.421802  - 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-19 11:22:50,407 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.421802  - context_resolve: Resolving endpoints for database /Root
2025-11-19 11:22:50,408 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ListEndpoints, 522d175f-33b7-4222-94e1-3ed52889fa39, localhost:12732): creating call state
2025-11-19 11:22:50,408 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ListEndpoints, 522d175f-33b7-4222-94e1-3ed52889fa39, localhost:12732): request = { database: "/Root" }
2025-11-19 11:22:50,415 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ListEndpoints, 522d175f-33b7-4222-94e1-3ed52889fa39, localhost:12732): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-alsqrntpxi.auto.internal" port: 12732 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-19 11:22:50,416 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.421802  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-alsqrntpxi.auto.internal:12732, location 1, ssl: False>]>
2025-11-19 11:22:50,416 - DEBUG - ydb.connection.421802  - close: Closing channel for endpoint localhost:12732
2025-11-19 11:22:51,288 - DEBUG - ydb.query.pool.421802  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:22:51,289 - DEBUG - ydb.connection.421802  - _prepare_call: RpcState(ExecuteQuery, 137173e2-0d26-44c6-9fbd-2321deceb010, ghrun-alsqrntpxi.auto.internal:12732): creating call state
2025-11-19 11:22:51,290 - DEBUG - ydb.connection.421802  - _log_request: RpcState(ExecuteQuery, 137173e2-0d26-44c6-9fbd-2321deceb010, ghrun-alsqrntpxi.auto.internal:12732): request = { session_id: "ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:22:51,295 - DEBUG - ydb.connection.421802  - _log_response: RpcState(ExecuteQuery, 137173e2-0d26-44c6-9fbd-2321deceb010, ghrun-alsqrntpxi.auto.internal:12732): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:22:52,679 - DEBUG - ydb.query.pool.421802  - release: Session returned to queue: ydb://session/3?node_id=1&id=MjEzYjk3ZDgtOTIwNjAwZDAtM2FiZGFhYjctMmUyMDNiZDE=
2025-11-19 11:22:52,683 - INFO - root.421802  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_8_compression`, volumes `value` (8000000, 1465240)
2025-11-19 11:22:52,684 - INFO - root.421802  - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_8_compression` 8092160 / 1465240: 5.522753951571073
2025-11-19 11:22:52,687 - INFO - ya.test.421802  - pytest_runtest_teardown: Test teardown
