2025-11-19 11:20:02,719 - INFO - ya.test.422366  - pytest_runtest_setup: ####################################################################################################
2025-11-19 11:20:02,720 - INFO - ya.test.422366  - pytest_runtest_setup: test_all_supported_compression[zstd_4_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 4]
2025-11-19 11:20:02,720 - INFO - ya.test.422366  - pytest_runtest_setup: ####################################################################################################
2025-11-19 11:20:02,720 - INFO - ya.test.422366  - pytest_runtest_setup: Test setup
2025-11-19 11:20:02,723 - DEBUG - ya.test.422366  - _get_command_output_file: Command out will be placed to ydbd.out
2025-11-19 11:20:02,724 - DEBUG - ya.test.422366  - _get_command_output_file: Command err will be placed to ydbd.err
2025-11-19 11:20:02,725 - DEBUG - ya.test.422366  - execute: Executing '['/home/runner/.ya/build/build_root/pbux/001556/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-19 11:20:02,727 - DEBUG - ya.test.422366  - execute: Command pid: 423983
2025-11-19 11:20:03,770 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 423983) rc: 0
2025-11-19 11:20:03,771 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 423983) elapsed time (sec): 1.0414836406707764
2025-11-19 11:20:03,771 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 423983) idrss: 0
2025-11-19 11:20:03,771 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 423983) inblock: 0
2025-11-19 11:20:03,772 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 423983) isrss: 0
2025-11-19 11:20:03,772 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 423983) ixrss: 0
2025-11-19 11:20:03,772 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 423983) majflt: 0
2025-11-19 11:20:03,773 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 423983) maxrss: 493392
2025-11-19 11:20:03,773 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 423983) minflt: 45426
2025-11-19 11:20:03,773 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 423983) msgrcv: 0
2025-11-19 11:20:03,774 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 423983) msgsnd: 0
2025-11-19 11:20:03,774 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 423983) nivcsw: 176
2025-11-19 11:20:03,775 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 423983) nsignals: 0
2025-11-19 11:20:03,775 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 423983) nswap: 0
2025-11-19 11:20:03,775 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 423983) nvcsw: 15
2025-11-19 11:20:03,776 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 423983) oublock: 8
2025-11-19 11:20:03,776 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 423983) stime: 0.27886099999999997
2025-11-19 11:20:03,776 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 423983) utime: 0.494397
2025-11-19 11:20:03,777 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 423983) wtime: 1.045
2025-11-19 11:20:03,777 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 423983) 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:03,777 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 423983) errors:

2025-11-19 11:20:03,778 - INFO - __tests__.base.422366  - _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:03,910 - DEBUG - ya.test.422366  - get_binary: Binary was found by /home/runner/.ya/build/build_root/pbux/001556/ydb/apps/ydbd/ydbd
2025-11-19 11:20:03,912 - DEBUG - library.python.filelock.422366  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/15564
2025-11-19 11:20:03,915 - DEBUG - ydb.tests.library.harness.kikimr_runner.422366  - start: Working directory: /home/runner/.ya/build/build_root/pbux/001556/r3tmp/kikimr_cluster_mt67qjof
2025-11-19 11:20:03,973 - DEBUG - ya.test.422366  - get_binary: Binary was found by /home/runner/.ya/build/build_root/pbux/001556/ydb/apps/ydbd/ydbd
2025-11-19 11:20:03,973 - DEBUG - library.python.filelock.422366  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/1700
2025-11-19 11:20:03,974 - DEBUG - library.python.filelock.422366  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/25220
2025-11-19 11:20:03,975 - DEBUG - library.python.filelock.422366  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/23262
2025-11-19 11:20:03,976 - DEBUG - library.python.filelock.422366  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/11062
2025-11-19 11:20:03,977 - INFO - ydb.tests.library.harness.kikimr_runner.422366  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/pbux/001556/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/kikimr_configs"
2025-11-19 11:20:03,978 - INFO - ydb.tests.library.harness.kikimr_runner.422366  - __make_run_command: Final command: /home/runner/.ya/build/build_root/pbux/001556/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/001556/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/node_1/logfile_hda8z2ty.log --grpc-port=1700 --mon-port=25220 --ic-port=15564
2025-11-19 11:20:03,978 - DEBUG - ydb.tests.library.harness.kikimr_runner.422366  - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:1700/1, disk_size 68719476736
2025-11-19 11:20:03,979 - INFO - ydb.tests.library.harness.kikimr_runner.422366  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/pbux/001556/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/kikimr_configs"
2025-11-19 11:20:03,979 - INFO - ydb.tests.library.harness.kikimr_runner.422366  - __make_run_command: Final command: /home/runner/.ya/build/build_root/pbux/001556/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/001556/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/node_1/logfile_hda8z2ty.log --grpc-port=1700 --mon-port=25220 --ic-port=15564
2025-11-19 11:20:03,981 - DEBUG - ya.test.422366  - execute: Executing '('/home/runner/.ya/build/build_root/pbux/001556/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/pbux/001556/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/pbux/001556/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/node_1/logfile_hda8z2ty.log', '--grpc-port=1700', '--mon-port=25220', '--ic-port=15564')' in '/home/runner/.ya/build/build_root/pbux/001556/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/node_1' (no wait)
2025-11-19 11:20:03,997 - DEBUG - ya.test.422366  - execute: Command pid: 424247
2025-11-19 11:20:03,998 - INFO - ydb.tests.library.harness.kikimr_runner.422366  - start: Started node localhost:1700/1
2025-11-19 11:20:04,002 - DEBUG - ya.test.422366  - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-11-19 11:20:04,003 - DEBUG - ya.test.422366  - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-11-19 11:20:04,003 - DEBUG - ya.test.422366  - execute: Executing '['/home/runner/.ya/build/build_root/pbux/001556/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-19 11:20:04,015 - DEBUG - ya.test.422366  - execute: Command pid: 424255
2025-11-19 11:20:04,936 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 424255) rc: 0
2025-11-19 11:20:04,936 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 424255) elapsed time (sec): 0.91983962059021
2025-11-19 11:20:04,937 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 424255) idrss: 0
2025-11-19 11:20:04,937 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 424255) inblock: 0
2025-11-19 11:20:04,937 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 424255) isrss: 0
2025-11-19 11:20:04,938 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 424255) ixrss: 0
2025-11-19 11:20:04,938 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 424255) majflt: 0
2025-11-19 11:20:04,938 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 424255) maxrss: 497328
2025-11-19 11:20:04,939 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 424255) minflt: 45370
2025-11-19 11:20:04,939 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 424255) msgrcv: 0
2025-11-19 11:20:04,941 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 424255) msgsnd: 0
2025-11-19 11:20:04,942 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 424255) nivcsw: 167
2025-11-19 11:20:04,942 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 424255) nsignals: 0
2025-11-19 11:20:04,942 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 424255) nswap: 0
2025-11-19 11:20:04,943 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 424255) nvcsw: 15
2025-11-19 11:20:04,943 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 424255) oublock: 8
2025-11-19 11:20:04,943 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 424255) stime: 0.23510399999999998
2025-11-19 11:20:04,943 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 424255) utime: 0.549087
2025-11-19 11:20:04,944 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 424255) wtime: 0.931
2025-11-19 11:20:04,944 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 424255) 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:04,945 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 424255) errors:

2025-11-19 11:20:04,945 - INFO - ydb.tests.library.harness.kikimr_runner.422366  - 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:10,051 - DEBUG - ya.test.422366  - get_binary: Binary was found by /home/runner/.ya/build/build_root/pbux/001556/ydb/apps/ydbd/ydbd
2025-11-19 11:20:10,051 - DEBUG - ydb.tests.library.harness.kikimr_runner.422366  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/pbux/001556/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:1700', '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: 15564\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-19 11:20:10,053 - DEBUG - ya.test.422366  - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-11-19 11:20:10,054 - DEBUG - ya.test.422366  - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-11-19 11:20:10,054 - DEBUG - ya.test.422366  - execute: Executing '['/home/runner/.ya/build/build_root/pbux/001556/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:1700', '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: 15564\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-19 11:20:10,066 - DEBUG - ya.test.422366  - execute: Command pid: 425276
2025-11-19 11:20:11,363 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425276) rc: 0
2025-11-19 11:20:11,364 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425276) elapsed time (sec): 1.2961180210113525
2025-11-19 11:20:11,364 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425276) idrss: 0
2025-11-19 11:20:11,364 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425276) inblock: 0
2025-11-19 11:20:11,365 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425276) isrss: 0
2025-11-19 11:20:11,365 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425276) ixrss: 0
2025-11-19 11:20:11,365 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425276) majflt: 0
2025-11-19 11:20:11,365 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425276) maxrss: 590900
2025-11-19 11:20:11,366 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425276) minflt: 51622
2025-11-19 11:20:11,366 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425276) msgrcv: 0
2025-11-19 11:20:11,366 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425276) msgsnd: 0
2025-11-19 11:20:11,366 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425276) nivcsw: 197
2025-11-19 11:20:11,367 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425276) nsignals: 0
2025-11-19 11:20:11,367 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425276) nswap: 0
2025-11-19 11:20:11,367 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425276) nvcsw: 540
2025-11-19 11:20:11,367 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425276) oublock: 8
2025-11-19 11:20:11,368 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425276) stime: 0.278225
2025-11-19 11:20:11,369 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425276) utime: 0.593334
2025-11-19 11:20:11,369 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425276) wtime: 1.308
2025-11-19 11:20:11,369 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425276) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-19 11:20:11,370 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425276) errors:

2025-11-19 11:20:11,371 - DEBUG - ya.test.422366  - get_binary: Binary was found by /home/runner/.ya/build/build_root/pbux/001556/ydb/apps/ydbd/ydbd
2025-11-19 11:20:11,371 - DEBUG - ydb.tests.library.harness.kikimr_runner.422366  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/pbux/001556/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:1700', '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:11,373 - DEBUG - ya.test.422366  - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-11-19 11:20:11,374 - DEBUG - ya.test.422366  - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-11-19 11:20:11,374 - DEBUG - ya.test.422366  - execute: Executing '['/home/runner/.ya/build/build_root/pbux/001556/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:1700', '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:11,385 - DEBUG - ya.test.422366  - execute: Command pid: 425446
2025-11-19 11:20:12,438 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425446) rc: 0
2025-11-19 11:20:12,439 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425446) elapsed time (sec): 1.0526413917541504
2025-11-19 11:20:12,439 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425446) idrss: 0
2025-11-19 11:20:12,439 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425446) inblock: 0
2025-11-19 11:20:12,440 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425446) isrss: 0
2025-11-19 11:20:12,440 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425446) ixrss: 0
2025-11-19 11:20:12,440 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425446) majflt: 0
2025-11-19 11:20:12,441 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425446) maxrss: 590920
2025-11-19 11:20:12,441 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425446) minflt: 51835
2025-11-19 11:20:12,441 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425446) msgrcv: 0
2025-11-19 11:20:12,441 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425446) msgsnd: 0
2025-11-19 11:20:12,442 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425446) nivcsw: 161
2025-11-19 11:20:12,442 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425446) nsignals: 0
2025-11-19 11:20:12,442 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425446) nswap: 0
2025-11-19 11:20:12,443 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425446) nvcsw: 742
2025-11-19 11:20:12,444 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425446) oublock: 8
2025-11-19 11:20:12,444 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425446) stime: 0.285429
2025-11-19 11:20:12,444 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425446) utime: 0.55299
2025-11-19 11:20:12,444 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425446) wtime: 1.063
2025-11-19 11:20:12,445 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425446) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-11-19 11:20:12,445 - DEBUG - ya.test.422366  - _save_outputs: Command (pid 425446) errors:

2025-11-19 11:20:12,446 - INFO - ydb.tests.library.harness.kikimr_runner.422366  - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-19 11:20:12,584 - INFO - ydb.tests.library.harness.kikimr_runner.422366  - __run: Cluster started and initialized
2025-11-19 11:20:12,617 - DEBUG - ydb.connection.422366  - 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:12,622 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.422366  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-19 11:20:12,622 - DEBUG - ydb.connection.422366  - 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:12,656 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.422366  - context_resolve: Resolving endpoints for database /Root
2025-11-19 11:20:12,657 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ListEndpoints, 7e560f5e-479e-44af-9024-4ea8fdb40686, localhost:1700): creating call state
2025-11-19 11:20:12,658 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ListEndpoints, 7e560f5e-479e-44af-9024-4ea8fdb40686, localhost:1700): request = { database: "/Root" }
2025-11-19 11:20:12,674 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ListEndpoints, 7e560f5e-479e-44af-9024-4ea8fdb40686, localhost:1700): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-alsqrntpxi.auto.internal" port: 1700 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:12,675 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.422366  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-alsqrntpxi.auto.internal:1700, location 1, ssl: False>]>
2025-11-19 11:20:12,676 - DEBUG - ydb.connection.422366  - 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:12,696 - DEBUG - ydb.connection.422366  - close: Closing channel for endpoint localhost:1700
2025-11-19 11:20:12,697 - DEBUG - ydb.query.pool.422366  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-19 11:20:12,699 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(CreateSession, bdc086ff-fbdf-4988-84c7-27d354abf226, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:12,699 - DEBUG - ydb.connection.422366  - _log_request: RpcState(CreateSession, bdc086ff-fbdf-4988-84c7-27d354abf226, ghrun-alsqrntpxi.auto.internal:1700): request = {  }
2025-11-19 11:20:12,709 - DEBUG - ydb.connection.422366  - _log_response: RpcState(CreateSession, bdc086ff-fbdf-4988-84c7-27d354abf226, ghrun-alsqrntpxi.auto.internal:1700): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" node_id: 1 }
2025-11-19 11:20:12,710 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(AttachSession, 9236100d-f2f4-4153-ba7f-8047a3029690, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:12,711 - DEBUG - ydb.connection.422366  - _log_request: RpcState(AttachSession, 9236100d-f2f4-4153-ba7f-8047a3029690, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" }
2025-11-19 11:20:12,715 - DEBUG - ydb.connection.422366  - _log_response: RpcState(AttachSession, 9236100d-f2f4-4153-ba7f-8047a3029690, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:12,718 - DEBUG - ydb.query.pool.422366  - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:12,719 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 0133c4e0-ab3c-4b6e-acae-f05fe42ee64e, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:12,720 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 0133c4e0-ab3c-4b6e-acae-f05fe42ee64e, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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:12,721 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 0133c4e0-ab3c-4b6e-acae-f05fe42ee64e, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:15,440 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:15,441 - INFO - __tests__.alter_compression.422366  - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-11-19 11:20:15,441 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:15,442 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 8c74ef81-cfe9-4088-983e-5eb30d0c388f, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:15,443 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 8c74ef81-cfe9-4088-983e-5eb30d0c388f, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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:15,448 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 8c74ef81-cfe9-4088-983e-5eb30d0c388f, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:16,337 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:16,337 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:16,338 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 213ddd1c-ee7a-4720-8a82-4695ed04688c, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:16,339 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 213ddd1c-ee7a-4720-8a82-4695ed04688c, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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:16,341 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 213ddd1c-ee7a-4720-8a82-4695ed04688c, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:17,376 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:17,377 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:17,378 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 1e3014cb-809a-4277-826b-bd744648a97e, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:17,379 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 1e3014cb-809a-4277-826b-bd744648a97e, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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,380 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 1e3014cb-809a-4277-826b-bd744648a97e, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:18,249 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:18,249 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:18,250 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, dd00692a-6ce8-449d-9fa3-83b56a3e0056, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:18,251 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, dd00692a-6ce8-449d-9fa3-83b56a3e0056, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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:18,253 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, dd00692a-6ce8-449d-9fa3-83b56a3e0056, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:19,660 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:19,661 - INFO - __tests__.alter_compression.422366  - 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:19,662 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:19,662 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 121d17e6-079b-47c5-a5d6-645784ddcb0d, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:19,663 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 121d17e6-079b-47c5-a5d6-645784ddcb0d, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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:19,665 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 121d17e6-079b-47c5-a5d6-645784ddcb0d, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:20,918 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:20,919 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:20,919 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 2f1741ef-0522-403d-8ca2-463463c53792, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:20,920 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 2f1741ef-0522-403d-8ca2-463463c53792, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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:20,921 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 2f1741ef-0522-403d-8ca2-463463c53792, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:21,326 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:21,327 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:21,327 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 220588f4-40a1-4177-a3a9-d7b7ca066951, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:21,328 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 220588f4-40a1-4177-a3a9-d7b7ca066951, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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,331 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 220588f4-40a1-4177-a3a9-d7b7ca066951, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:21,773 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:21,774 - INFO - __tests__.alter_compression.422366  - 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:21,775 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:21,775 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 62fe54d4-1e81-45bc-9321-50231cb4525d, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:21,780 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 62fe54d4-1e81-45bc-9321-50231cb4525d, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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:21,781 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 62fe54d4-1e81-45bc-9321-50231cb4525d, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:22,945 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:22,946 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:22,947 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, ec4181b1-e0a4-4b16-967f-4da4f6a72f15, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:22,948 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, ec4181b1-e0a4-4b16-967f-4da4f6a72f15, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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,949 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, ec4181b1-e0a4-4b16-967f-4da4f6a72f15, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:23,190 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:23,191 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:23,192 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 14c0445a-7bfb-4538-bc29-ba696b8e7e1b, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:23,193 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 14c0445a-7bfb-4538-bc29-ba696b8e7e1b, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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,195 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 14c0445a-7bfb-4538-bc29-ba696b8e7e1b, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:23,836 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:23,837 - INFO - __tests__.alter_compression.422366  - 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:23,838 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:23,838 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 83afffb1-cff0-4b3f-b3c6-70d4060d7a7d, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:23,839 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 83afffb1-cff0-4b3f-b3c6-70d4060d7a7d, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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:23,841 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 83afffb1-cff0-4b3f-b3c6-70d4060d7a7d, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:25,017 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:25,018 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:25,019 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 39857828-665a-4b18-a3ab-055954f23048, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:25,020 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 39857828-665a-4b18-a3ab-055954f23048, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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,021 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 39857828-665a-4b18-a3ab-055954f23048, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:25,330 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:25,331 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:25,332 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, c5d81f1d-fd8b-444a-8ce7-d2087c45ff65, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:25,333 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, c5d81f1d-fd8b-444a-8ce7-d2087c45ff65, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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,334 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, c5d81f1d-fd8b-444a-8ce7-d2087c45ff65, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:25,800 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:25,801 - INFO - __tests__.alter_compression.422366  - 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:25,801 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:25,802 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, d634cbf2-e0f8-4c17-afd6-e4f7fbb8a88d, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:25,803 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, d634cbf2-e0f8-4c17-afd6-e4f7fbb8a88d, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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:25,809 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, d634cbf2-e0f8-4c17-afd6-e4f7fbb8a88d, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:26,867 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:26,868 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:26,869 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 1f4fc6ad-9a71-43fd-868e-4e2afca06008, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:26,870 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 1f4fc6ad-9a71-43fd-868e-4e2afca06008, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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,876 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 1f4fc6ad-9a71-43fd-868e-4e2afca06008, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:27,190 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:27,191 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:27,192 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, f8c06b49-164a-4e83-b3da-5ad2778491a7, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:27,193 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, f8c06b49-164a-4e83-b3da-5ad2778491a7, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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.422366  - _log_response: RpcState(ExecuteQuery, f8c06b49-164a-4e83-b3da-5ad2778491a7, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:27,647 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:27,647 - INFO - __tests__.alter_compression.422366  - 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:27,648 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:27,649 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 9a624908-3337-42c0-8415-6573fc04b4cd, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:27,650 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 9a624908-3337-42c0-8415-6573fc04b4cd, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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:27,651 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 9a624908-3337-42c0-8415-6573fc04b4cd, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:28,975 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:28,975 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:28,976 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, b60a7a77-7371-45f9-8fb5-95009dd603e8, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:28,977 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, b60a7a77-7371-45f9-8fb5-95009dd603e8, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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,978 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, b60a7a77-7371-45f9-8fb5-95009dd603e8, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:29,296 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:29,297 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:29,297 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, b0222c0b-cf9c-42a0-a634-e385f3b66949, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:29,298 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, b0222c0b-cf9c-42a0-a634-e385f3b66949, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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,300 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, b0222c0b-cf9c-42a0-a634-e385f3b66949, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:29,898 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:29,899 - INFO - __tests__.alter_compression.422366  - 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:29,899 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:29,900 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 405b7316-062d-40f1-b4e4-bc08f9824a94, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:29,901 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 405b7316-062d-40f1-b4e4-bc08f9824a94, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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:29,903 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 405b7316-062d-40f1-b4e4-bc08f9824a94, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:31,577 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:31,578 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:31,579 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 8937fc31-94d4-4f95-a378-187b2ad59e79, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:31,580 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 8937fc31-94d4-4f95-a378-187b2ad59e79, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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:31,583 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 8937fc31-94d4-4f95-a378-187b2ad59e79, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:31,853 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:31,854 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:31,854 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, a86b6e10-353e-491e-bcf0-e50d26af2a0e, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:31,855 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, a86b6e10-353e-491e-bcf0-e50d26af2a0e, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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,858 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, a86b6e10-353e-491e-bcf0-e50d26af2a0e, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:32,366 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:32,367 - INFO - __tests__.alter_compression.422366  - 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:32,368 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:32,369 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 8ae7ef54-c152-4545-b32f-486e7c3d5ecb, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:32,370 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 8ae7ef54-c152-4545-b32f-486e7c3d5ecb, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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:32,371 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 8ae7ef54-c152-4545-b32f-486e7c3d5ecb, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:33,434 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:33,434 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:33,435 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 2346cd64-1b71-4f86-b2ae-37031ac1fb66, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:33,436 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 2346cd64-1b71-4f86-b2ae-37031ac1fb66, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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,438 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 2346cd64-1b71-4f86-b2ae-37031ac1fb66, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:33,730 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:33,731 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:33,731 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, b93004c7-7e86-42b6-a8d1-4a58fb22babe, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:33,732 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, b93004c7-7e86-42b6-a8d1-4a58fb22babe, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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,734 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, b93004c7-7e86-42b6-a8d1-4a58fb22babe, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:34,358 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:34,358 - INFO - __tests__.alter_compression.422366  - 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:34,359 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:34,360 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 2290a66b-501c-4515-a479-68247cbc39cf, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:34,361 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 2290a66b-501c-4515-a479-68247cbc39cf, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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:34,372 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 2290a66b-501c-4515-a479-68247cbc39cf, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:35,466 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:35,466 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:35,467 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, fe5028d7-5769-4e05-87a3-840369c984be, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:35,468 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, fe5028d7-5769-4e05-87a3-840369c984be, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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,474 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, fe5028d7-5769-4e05-87a3-840369c984be, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:35,736 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:35,737 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:35,738 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 7cf5a8e7-dcb0-4a32-867d-21a7e69af59b, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:35,739 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 7cf5a8e7-dcb0-4a32-867d-21a7e69af59b, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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:35,741 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 7cf5a8e7-dcb0-4a32-867d-21a7e69af59b, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:36,351 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:36,351 - INFO - __tests__.alter_compression.422366  - 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:36,352 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:36,353 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, ecd28068-b8a4-46e4-8ecc-3aa0633aef4b, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:36,354 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, ecd28068-b8a4-46e4-8ecc-3aa0633aef4b, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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:36,355 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, ecd28068-b8a4-46e4-8ecc-3aa0633aef4b, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:37,404 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:37,405 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:37,406 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 8ea5e602-60ab-4a53-81f4-bedc3b18b89d, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:37,407 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 8ea5e602-60ab-4a53-81f4-bedc3b18b89d, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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:37,408 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 8ea5e602-60ab-4a53-81f4-bedc3b18b89d, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:37,684 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:37,685 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:37,686 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 16e52264-1d45-4ec7-a736-23c37b47908b, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:37,687 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 16e52264-1d45-4ec7-a736-23c37b47908b, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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:37,688 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 16e52264-1d45-4ec7-a736-23c37b47908b, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:38,353 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:38,354 - INFO - __tests__.alter_compression.422366  - 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:38,355 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:38,355 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, c88d78b0-4597-4a55-a0c3-2734a427970b, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:38,356 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, c88d78b0-4597-4a55-a0c3-2734a427970b, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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:38,358 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, c88d78b0-4597-4a55-a0c3-2734a427970b, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:39,438 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:39,439 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:39,440 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 6499223f-f97d-4679-89f9-6576b9337143, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:39,441 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 6499223f-f97d-4679-89f9-6576b9337143, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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:39,444 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 6499223f-f97d-4679-89f9-6576b9337143, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:39,634 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:39,635 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:39,636 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, c8ea5d43-b873-4dc1-a192-0e470f38be8e, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:39,637 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, c8ea5d43-b873-4dc1-a192-0e470f38be8e, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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:39,638 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, c8ea5d43-b873-4dc1-a192-0e470f38be8e, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:39,885 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:39,886 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:39,887 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, bb2a58cf-3f64-4b63-ae9e-f47d95946d6c, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:39,888 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, bb2a58cf-3f64-4b63-ae9e-f47d95946d6c, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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:39,889 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, bb2a58cf-3f64-4b63-ae9e-f47d95946d6c, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:43,277 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:53,320 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:53,321 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 7aa714a2-9da3-4ee6-be61-546a55102633, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:53,322 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 7aa714a2-9da3-4ee6-be61-546a55102633, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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:53,323 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 7aa714a2-9da3-4ee6-be61-546a55102633, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:56,266 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:56,304 - INFO - root.422366  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-11-19 11:20:56,305 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:20:56,306 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 7c7eae74-50d1-4b44-9f70-87ffc32fcbe0, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:20:56,307 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 7c7eae74-50d1-4b44-9f70-87ffc32fcbe0, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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:56,308 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 7c7eae74-50d1-4b44-9f70-87ffc32fcbe0, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:59,240 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:09,292 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:09,293 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, b7c22539-0b56-49b9-9511-142beaac435a, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:09,293 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, b7c22539-0b56-49b9-9511-142beaac435a, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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:09,295 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, b7c22539-0b56-49b9-9511-142beaac435a, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:13,102 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:13,150 - INFO - root.422366  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-11-19 11:21:13,151 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:13,152 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 15c5a6d6-4cd7-483b-8ed8-0c6c58b60368, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:13,153 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 15c5a6d6-4cd7-483b-8ed8-0c6c58b60368, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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:13,154 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 15c5a6d6-4cd7-483b-8ed8-0c6c58b60368, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:13,437 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:13,441 - INFO - ya.test.422366  - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_4_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 4])
2025-11-19 11:21:13,442 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:13,444 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 45dffd47-d77c-4c4c-a039-fefe83746b0e, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:13,445 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 45dffd47-d77c-4c4c-a039-fefe83746b0e, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_4_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 4)\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:13,446 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 45dffd47-d77c-4c4c-a039-fefe83746b0e, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:16,927 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:16,928 - INFO - __tests__.alter_compression.422366  - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_4_compression created
2025-11-19 11:21:16,928 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:16,929 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 5779388f-c443-444d-adad-dff398a01fc6, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:16,930 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 5779388f-c443-444d-adad-dff398a01fc6, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_4_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:16,931 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 5779388f-c443-444d-adad-dff398a01fc6, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:17,769 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:17,770 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:17,771 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 912bd031-cc23-4daa-9361-2071f811a31a, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:17,772 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 912bd031-cc23-4daa-9361-2071f811a31a, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:17,773 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 912bd031-cc23-4daa-9361-2071f811a31a, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:19,205 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:19,206 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:19,207 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, c94bc3c6-944c-4aea-9890-e175c09c485b, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:19,208 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, c94bc3c6-944c-4aea-9890-e175c09c485b, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:19,209 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, c94bc3c6-944c-4aea-9890-e175c09c485b, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:20,131 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:20,132 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:20,132 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 42ca28cc-7f14-44dc-9bca-43524967ba1b, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:20,133 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 42ca28cc-7f14-44dc-9bca-43524967ba1b, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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_4_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:20,135 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 42ca28cc-7f14-44dc-9bca-43524967ba1b, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:22,072 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:22,094 - INFO - __tests__.alter_compression.422366  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318960, 'BlobCount': 128}}
2025-11-19 11:21:22,094 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:22,095 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, a920809e-43a9-4483-91d6-3e09c7dae9d0, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:22,096 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, a920809e-43a9-4483-91d6-3e09c7dae9d0, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:22,098 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, a920809e-43a9-4483-91d6-3e09c7dae9d0, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:23,485 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:23,486 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:23,487 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, c224845d-497d-49b3-9ceb-fa49f112035d, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:23,487 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, c224845d-497d-49b3-9ceb-fa49f112035d, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:23,490 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, c224845d-497d-49b3-9ceb-fa49f112035d, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:23,795 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:23,795 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:23,796 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, f96e67f5-c66d-4bdc-9259-5ecff0fdff6d, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:23,797 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, f96e67f5-c66d-4bdc-9259-5ecff0fdff6d, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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_4_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:23,798 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, f96e67f5-c66d-4bdc-9259-5ecff0fdff6d, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:24,166 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:24,166 - INFO - __tests__.alter_compression.422366  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 638256, 'BlobCount': 256}}
2025-11-19 11:21:24,167 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:24,167 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, c7e950e9-8d23-4fb1-9b7f-1e8bb9ef2a20, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:24,168 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, c7e950e9-8d23-4fb1-9b7f-1e8bb9ef2a20, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:24,169 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, c7e950e9-8d23-4fb1-9b7f-1e8bb9ef2a20, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:25,260 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:25,261 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:25,262 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 093952b2-7809-427b-a28d-5bc6658ff614, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:25,263 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 093952b2-7809-427b-a28d-5bc6658ff614, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:25,264 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 093952b2-7809-427b-a28d-5bc6658ff614, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:25,545 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:25,546 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:25,547 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 5feefec3-5778-4765-a3e5-53d524b19474, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:25,547 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 5feefec3-5778-4765-a3e5-53d524b19474, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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_4_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:25,549 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 5feefec3-5778-4765-a3e5-53d524b19474, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:25,958 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:25,958 - INFO - __tests__.alter_compression.422366  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 957296, 'BlobCount': 384}}
2025-11-19 11:21:25,959 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:25,959 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, a0f99185-8046-48dc-a7a8-cd13686dd636, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:25,961 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, a0f99185-8046-48dc-a7a8-cd13686dd636, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:25,962 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, a0f99185-8046-48dc-a7a8-cd13686dd636, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:27,209 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:27,210 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:27,211 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 06a67c22-1cf1-4b8d-98f1-3789c597b87d, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:27,212 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 06a67c22-1cf1-4b8d-98f1-3789c597b87d, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:27,223 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 06a67c22-1cf1-4b8d-98f1-3789c597b87d, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:27,548 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:27,549 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:27,550 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, f3263d98-42af-4d6f-b18e-980899457c48, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:27,551 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, f3263d98-42af-4d6f-b18e-980899457c48, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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_4_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:27,556 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, f3263d98-42af-4d6f-b18e-980899457c48, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:28,042 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:28,043 - INFO - __tests__.alter_compression.422366  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1276656, 'BlobCount': 512}}
2025-11-19 11:21:28,044 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:28,044 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 4467309d-2156-4c85-a514-29b64fe18893, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:28,045 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 4467309d-2156-4c85-a514-29b64fe18893, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:28,048 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 4467309d-2156-4c85-a514-29b64fe18893, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:29,277 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:29,277 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:29,284 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, ebc74fa7-ca09-48d1-8742-0d5d96bc9072, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:29,285 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, ebc74fa7-ca09-48d1-8742-0d5d96bc9072, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:29,287 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, ebc74fa7-ca09-48d1-8742-0d5d96bc9072, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:29,559 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:29,560 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:29,561 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 30130a10-06fe-4355-9a99-6094b689c579, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:29,562 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 30130a10-06fe-4355-9a99-6094b689c579, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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_4_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,563 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 30130a10-06fe-4355-9a99-6094b689c579, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:30,116 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:30,117 - INFO - __tests__.alter_compression.422366  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1595616, 'BlobCount': 640}}
2025-11-19 11:21:30,118 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:30,119 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, bd04fc4d-8d24-4c41-aa82-ed9c54709676, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:30,119 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, bd04fc4d-8d24-4c41-aa82-ed9c54709676, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:30,125 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, bd04fc4d-8d24-4c41-aa82-ed9c54709676, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:31,520 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:31,521 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:31,522 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 201e6172-2e52-43ac-8278-6dafd6979ea5, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:31,523 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 201e6172-2e52-43ac-8278-6dafd6979ea5, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:31,526 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 201e6172-2e52-43ac-8278-6dafd6979ea5, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:31,804 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:31,805 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:31,806 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 2a765d43-ed14-468d-9a56-0cc34a2330ee, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:31,807 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 2a765d43-ed14-468d-9a56-0cc34a2330ee, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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_4_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:31,815 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 2a765d43-ed14-468d-9a56-0cc34a2330ee, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:32,445 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:32,446 - INFO - __tests__.alter_compression.422366  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1914800, 'BlobCount': 768}}
2025-11-19 11:21:32,447 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:32,447 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, b79fb69a-8198-47bc-ae2f-868ce2bc9a19, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:32,448 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, b79fb69a-8198-47bc-ae2f-868ce2bc9a19, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:32,457 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, b79fb69a-8198-47bc-ae2f-868ce2bc9a19, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:33,628 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:33,629 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:33,629 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 1588bf9f-5a4c-48cd-b193-3bd7c06c1194, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:33,630 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 1588bf9f-5a4c-48cd-b193-3bd7c06c1194, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:33,631 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 1588bf9f-5a4c-48cd-b193-3bd7c06c1194, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:33,905 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:33,906 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:33,906 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 49ea82b1-b281-458b-944e-c496734b8d2f, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:33,907 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 49ea82b1-b281-458b-944e-c496734b8d2f, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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_4_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:33,909 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 49ea82b1-b281-458b-944e-c496734b8d2f, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:34,531 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:34,532 - INFO - __tests__.alter_compression.422366  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2233936, 'BlobCount': 896}}
2025-11-19 11:21:34,532 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:34,534 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, d248f0f9-eeb1-4bb4-a7ec-0d6276b93dc4, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:34,535 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, d248f0f9-eeb1-4bb4-a7ec-0d6276b93dc4, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:34,536 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, d248f0f9-eeb1-4bb4-a7ec-0d6276b93dc4, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:35,848 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:35,849 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:35,850 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 54d071f5-ee03-444d-9ba7-6eb1e08b787e, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:35,851 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 54d071f5-ee03-444d-9ba7-6eb1e08b787e, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:35,852 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 54d071f5-ee03-444d-9ba7-6eb1e08b787e, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:36,177 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:36,178 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:36,179 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 96ab6f3e-281e-49e9-9ed1-f9105145612d, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:36,180 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 96ab6f3e-281e-49e9-9ed1-f9105145612d, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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_4_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:36,181 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 96ab6f3e-281e-49e9-9ed1-f9105145612d, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:36,848 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:36,849 - INFO - __tests__.alter_compression.422366  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2553424, 'BlobCount': 1024}}
2025-11-19 11:21:36,849 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:36,850 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 4e4e6018-5bc4-4348-a91e-e2082a377c67, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:36,851 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 4e4e6018-5bc4-4348-a91e-e2082a377c67, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:36,858 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 4e4e6018-5bc4-4348-a91e-e2082a377c67, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:38,082 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:38,082 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:38,083 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, d30ac7c6-4595-481a-a827-a972e6fc6ad4, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:38,084 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, d30ac7c6-4595-481a-a827-a972e6fc6ad4, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:38,096 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, d30ac7c6-4595-481a-a827-a972e6fc6ad4, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:38,337 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:38,338 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:38,338 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 456f49cf-2840-4c9a-9a53-57b2b2008ec6, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:38,339 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 456f49cf-2840-4c9a-9a53-57b2b2008ec6, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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_4_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:38,342 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 456f49cf-2840-4c9a-9a53-57b2b2008ec6, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:39,031 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:39,031 - INFO - __tests__.alter_compression.422366  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2872432, 'BlobCount': 1152}}
2025-11-19 11:21:39,032 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:39,033 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 29fb32b0-5578-443f-8185-b4d83d218b85, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:39,034 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 29fb32b0-5578-443f-8185-b4d83d218b85, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:39,035 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 29fb32b0-5578-443f-8185-b4d83d218b85, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:40,276 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:40,277 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:40,278 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 6eca0871-03e9-49a4-8d04-8b5a652f7623, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:40,278 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 6eca0871-03e9-49a4-8d04-8b5a652f7623, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:40,280 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 6eca0871-03e9-49a4-8d04-8b5a652f7623, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:40,584 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:40,585 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:40,586 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, b9dc07d3-4e62-49ce-b4e3-a44156bf862a, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:40,587 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, b9dc07d3-4e62-49ce-b4e3-a44156bf862a, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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_4_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:40,589 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, b9dc07d3-4e62-49ce-b4e3-a44156bf862a, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:41,228 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:41,229 - INFO - __tests__.alter_compression.422366  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3191936, 'BlobCount': 1280}}
2025-11-19 11:21:41,230 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:41,232 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 4c576c71-9653-496f-8fe4-b3ccbd10c71c, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:41,233 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 4c576c71-9653-496f-8fe4-b3ccbd10c71c, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_4_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:41,234 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 4c576c71-9653-496f-8fe4-b3ccbd10c71c, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:42,388 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:42,389 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:42,394 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, d33fbec6-aaa5-40eb-985f-aaa61b88f4b1, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:42,395 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, d33fbec6-aaa5-40eb-985f-aaa61b88f4b1, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:42,396 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, d33fbec6-aaa5-40eb-985f-aaa61b88f4b1, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:42,668 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:42,676 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:42,677 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 99c124a0-b066-4be3-93c5-8f54b32e0e9b, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:42,678 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 99c124a0-b066-4be3-93c5-8f54b32e0e9b, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:42,680 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 99c124a0-b066-4be3-93c5-8f54b32e0e9b, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:42,932 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:42,933 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:42,934 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, d380f694-2fbb-485a-88d9-505fa48dd351, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:42,935 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, d380f694-2fbb-485a-88d9-505fa48dd351, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:42,937 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, d380f694-2fbb-485a-88d9-505fa48dd351, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:46,809 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:48,727 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.422366  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-19 11:21:48,728 - DEBUG - ydb.connection.422366  - 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:48,738 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.422366  - context_resolve: Resolving endpoints for database /Root
2025-11-19 11:21:48,738 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ListEndpoints, 16cb22d9-1736-44ce-84b5-d8b8dfd540f5, localhost:1700): creating call state
2025-11-19 11:21:48,739 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ListEndpoints, 16cb22d9-1736-44ce-84b5-d8b8dfd540f5, localhost:1700): request = { database: "/Root" }
2025-11-19 11:21:48,743 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ListEndpoints, 16cb22d9-1736-44ce-84b5-d8b8dfd540f5, localhost:1700): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-alsqrntpxi.auto.internal" port: 1700 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:48,744 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.422366  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-alsqrntpxi.auto.internal:1700, location 1, ssl: False>]>
2025-11-19 11:21:48,745 - DEBUG - ydb.connection.422366  - close: Closing channel for endpoint localhost:1700
2025-11-19 11:21:56,877 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:21:56,878 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 3c0b3d44-0a56-42f0-a37f-640c505c05de, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:21:56,879 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 3c0b3d44-0a56-42f0-a37f-640c505c05de, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:56,880 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 3c0b3d44-0a56-42f0-a37f-640c505c05de, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:22:01,801 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:22:01,854 - INFO - root.422366  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_4_compression`, volumes `value` (8000000, 1595968)
2025-11-19 11:22:01,855 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:22:01,856 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 9fe05be5-e585-4fa7-bddf-b3cd7c3794ef, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:22:01,858 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 9fe05be5-e585-4fa7-bddf-b3cd7c3794ef, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:22:01,859 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 9fe05be5-e585-4fa7-bddf-b3cd7c3794ef, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:22:02,443 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:22:02,444 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:22:02,445 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 25ed5751-c874-4aeb-a5bd-4036b821973e, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:22:02,446 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 25ed5751-c874-4aeb-a5bd-4036b821973e, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:22:02,448 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 25ed5751-c874-4aeb-a5bd-4036b821973e, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:22:10,057 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:22:20,153 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:22:20,154 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 31dfc5e8-4595-4bc2-bb2d-a64377267bf0, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:22:20,155 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 31dfc5e8-4595-4bc2-bb2d-a64377267bf0, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:22:20,157 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 31dfc5e8-4595-4bc2-bb2d-a64377267bf0, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:22:24,727 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:22:34,749 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:22:34,750 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 2416009e-2ffc-4a3a-b641-2c3afd4020a1, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:22:34,751 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 2416009e-2ffc-4a3a-b641-2c3afd4020a1, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:22:34,761 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 2416009e-2ffc-4a3a-b641-2c3afd4020a1, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:22:36,098 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:22:46,181 - DEBUG - ydb.query.pool.422366  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:22:46,182 - DEBUG - ydb.connection.422366  - _prepare_call: RpcState(ExecuteQuery, 89f31d95-b62b-4d36-ab12-35639baae937, ghrun-alsqrntpxi.auto.internal:1700): creating call state
2025-11-19 11:22:46,183 - DEBUG - ydb.connection.422366  - _log_request: RpcState(ExecuteQuery, 89f31d95-b62b-4d36-ab12-35639baae937, ghrun-alsqrntpxi.auto.internal:1700): request = { session_id: "ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:22:46,185 - DEBUG - ydb.connection.422366  - _log_response: RpcState(ExecuteQuery, 89f31d95-b62b-4d36-ab12-35639baae937, ghrun-alsqrntpxi.auto.internal:1700): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:22:47,236 - DEBUG - ydb.query.pool.422366  - release: Session returned to queue: ydb://session/3?node_id=1&id=NWM1ZWU4MjAtMTA5OTZhM2ItMjMzMjJhNmMtODdiMWVlNmQ=
2025-11-19 11:22:47,241 - INFO - root.422366  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_4_compression`, volumes `value` (8000000, 1466456)
2025-11-19 11:22:47,242 - INFO - root.422366  - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_4_compression` 8092160 / 1466456: 5.518174428690666
2025-11-19 11:22:47,247 - INFO - ya.test.422366  - pytest_runtest_teardown: Test teardown
