2025-11-19 11:20:16,502 - INFO - ya.test.425468  - pytest_runtest_setup: ####################################################################################################
2025-11-19 11:20:16,503 - INFO - ya.test.425468  - pytest_runtest_setup: test_all_supported_compression[zstd_6_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 6]
2025-11-19 11:20:16,503 - INFO - ya.test.425468  - pytest_runtest_setup: ####################################################################################################
2025-11-19 11:20:16,503 - INFO - ya.test.425468  - pytest_runtest_setup: Test setup
2025-11-19 11:20:16,506 - DEBUG - ya.test.425468  - _get_command_output_file: Command out will be placed to ydbd.out
2025-11-19 11:20:16,507 - DEBUG - ya.test.425468  - _get_command_output_file: Command err will be placed to ydbd.err
2025-11-19 11:20:16,507 - DEBUG - ya.test.425468  - execute: Executing '['/home/runner/.ya/build/build_root/pbux/00154a/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-19 11:20:16,518 - DEBUG - ya.test.425468  - execute: Command pid: 426012
2025-11-19 11:20:17,369 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426012) rc: 0
2025-11-19 11:20:17,369 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426012) elapsed time (sec): 0.8494045734405518
2025-11-19 11:20:17,370 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426012) idrss: 0
2025-11-19 11:20:17,370 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426012) inblock: 0
2025-11-19 11:20:17,370 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426012) isrss: 0
2025-11-19 11:20:17,371 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426012) ixrss: 0
2025-11-19 11:20:17,371 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426012) majflt: 0
2025-11-19 11:20:17,371 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426012) maxrss: 494864
2025-11-19 11:20:17,371 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426012) minflt: 45366
2025-11-19 11:20:17,373 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426012) msgrcv: 0
2025-11-19 11:20:17,373 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426012) msgsnd: 0
2025-11-19 11:20:17,374 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426012) nivcsw: 103
2025-11-19 11:20:17,374 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426012) nsignals: 0
2025-11-19 11:20:17,374 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426012) nswap: 0
2025-11-19 11:20:17,375 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426012) nvcsw: 14
2025-11-19 11:20:17,375 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426012) oublock: 8
2025-11-19 11:20:17,375 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426012) stime: 0.20050099999999998
2025-11-19 11:20:17,376 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426012) utime: 0.568858
2025-11-19 11:20:17,376 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426012) wtime: 0.861
2025-11-19 11:20:17,377 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426012) 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:17,378 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426012) errors:

2025-11-19 11:20:17,378 - INFO - __tests__.base.425468  - _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:17,510 - DEBUG - ya.test.425468  - get_binary: Binary was found by /home/runner/.ya/build/build_root/pbux/00154a/ydb/apps/ydbd/ydbd
2025-11-19 11:20:17,511 - DEBUG - library.python.filelock.425468  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/5972
2025-11-19 11:20:17,515 - DEBUG - ydb.tests.library.harness.kikimr_runner.425468  - start: Working directory: /home/runner/.ya/build/build_root/pbux/00154a/r3tmp/kikimr_cluster_engxnin7
2025-11-19 11:20:17,567 - DEBUG - ya.test.425468  - get_binary: Binary was found by /home/runner/.ya/build/build_root/pbux/00154a/ydb/apps/ydbd/ydbd
2025-11-19 11:20:17,568 - DEBUG - library.python.filelock.425468  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/12506
2025-11-19 11:20:17,569 - DEBUG - library.python.filelock.425468  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/7688
2025-11-19 11:20:17,570 - DEBUG - library.python.filelock.425468  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/29349
2025-11-19 11:20:17,570 - DEBUG - library.python.filelock.425468  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/9900
2025-11-19 11:20:17,571 - INFO - ydb.tests.library.harness.kikimr_runner.425468  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/pbux/00154a/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_6_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.6/cluster/kikimr_configs"
2025-11-19 11:20:17,572 - INFO - ydb.tests.library.harness.kikimr_runner.425468  - __make_run_command: Final command: /home/runner/.ya/build/build_root/pbux/00154a/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/00154a/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_6_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.6/cluster/node_1/logfile_vbx1r2h2.log --grpc-port=12506 --mon-port=7688 --ic-port=5972
2025-11-19 11:20:17,573 - DEBUG - ydb.tests.library.harness.kikimr_runner.425468  - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:12506/1, disk_size 68719476736
2025-11-19 11:20:17,574 - INFO - ydb.tests.library.harness.kikimr_runner.425468  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/pbux/00154a/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_6_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.6/cluster/kikimr_configs"
2025-11-19 11:20:17,574 - INFO - ydb.tests.library.harness.kikimr_runner.425468  - __make_run_command: Final command: /home/runner/.ya/build/build_root/pbux/00154a/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/00154a/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_6_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.6/cluster/node_1/logfile_vbx1r2h2.log --grpc-port=12506 --mon-port=7688 --ic-port=5972
2025-11-19 11:20:17,575 - DEBUG - ya.test.425468  - execute: Executing '('/home/runner/.ya/build/build_root/pbux/00154a/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/pbux/00154a/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_6_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.6/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/pbux/00154a/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_6_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.6/cluster/node_1/logfile_vbx1r2h2.log', '--grpc-port=12506', '--mon-port=7688', '--ic-port=5972')' in '/home/runner/.ya/build/build_root/pbux/00154a/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_6_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.6/cluster/node_1' (no wait)
2025-11-19 11:20:17,585 - DEBUG - ya.test.425468  - execute: Command pid: 426162
2025-11-19 11:20:17,586 - INFO - ydb.tests.library.harness.kikimr_runner.425468  - start: Started node localhost:12506/1
2025-11-19 11:20:17,587 - DEBUG - ya.test.425468  - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-11-19 11:20:17,589 - DEBUG - ya.test.425468  - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-11-19 11:20:17,589 - DEBUG - ya.test.425468  - execute: Executing '['/home/runner/.ya/build/build_root/pbux/00154a/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-19 11:20:17,612 - DEBUG - ya.test.425468  - execute: Command pid: 426170
2025-11-19 11:20:18,465 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426170) rc: 0
2025-11-19 11:20:18,466 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426170) elapsed time (sec): 0.8519682884216309
2025-11-19 11:20:18,466 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426170) idrss: 0
2025-11-19 11:20:18,466 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426170) inblock: 0
2025-11-19 11:20:18,467 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426170) isrss: 0
2025-11-19 11:20:18,467 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426170) ixrss: 0
2025-11-19 11:20:18,468 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426170) majflt: 0
2025-11-19 11:20:18,468 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426170) maxrss: 497512
2025-11-19 11:20:18,468 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426170) minflt: 45392
2025-11-19 11:20:18,469 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426170) msgrcv: 0
2025-11-19 11:20:18,469 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426170) msgsnd: 0
2025-11-19 11:20:18,469 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426170) nivcsw: 170
2025-11-19 11:20:18,470 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426170) nsignals: 0
2025-11-19 11:20:18,470 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426170) nswap: 0
2025-11-19 11:20:18,470 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426170) nvcsw: 14
2025-11-19 11:20:18,471 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426170) oublock: 8
2025-11-19 11:20:18,471 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426170) stime: 0.237534
2025-11-19 11:20:18,471 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426170) utime: 0.503541
2025-11-19 11:20:18,472 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426170) wtime: 0.875
2025-11-19 11:20:18,472 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426170) 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:18,473 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 426170) errors:

2025-11-19 11:20:18,473 - INFO - ydb.tests.library.harness.kikimr_runner.425468  - 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:23,929 - DEBUG - ya.test.425468  - get_binary: Binary was found by /home/runner/.ya/build/build_root/pbux/00154a/ydb/apps/ydbd/ydbd
2025-11-19 11:20:23,930 - DEBUG - ydb.tests.library.harness.kikimr_runner.425468  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/pbux/00154a/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:12506', '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: 5972\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-19 11:20:23,931 - DEBUG - ya.test.425468  - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-11-19 11:20:23,932 - DEBUG - ya.test.425468  - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-11-19 11:20:23,933 - DEBUG - ya.test.425468  - execute: Executing '['/home/runner/.ya/build/build_root/pbux/00154a/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:12506', '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: 5972\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-19 11:20:23,940 - DEBUG - ya.test.425468  - execute: Command pid: 427029
2025-11-19 11:20:25,225 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427029) rc: 0
2025-11-19 11:20:25,225 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427029) elapsed time (sec): 1.2834954261779785
2025-11-19 11:20:25,225 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427029) idrss: 0
2025-11-19 11:20:25,226 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427029) inblock: 0
2025-11-19 11:20:25,226 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427029) isrss: 0
2025-11-19 11:20:25,226 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427029) ixrss: 0
2025-11-19 11:20:25,227 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427029) majflt: 0
2025-11-19 11:20:25,227 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427029) maxrss: 596816
2025-11-19 11:20:25,227 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427029) minflt: 51665
2025-11-19 11:20:25,227 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427029) msgrcv: 0
2025-11-19 11:20:25,228 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427029) msgsnd: 0
2025-11-19 11:20:25,228 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427029) nivcsw: 238
2025-11-19 11:20:25,229 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427029) nsignals: 0
2025-11-19 11:20:25,229 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427029) nswap: 0
2025-11-19 11:20:25,230 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427029) nvcsw: 633
2025-11-19 11:20:25,230 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427029) oublock: 8
2025-11-19 11:20:25,230 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427029) stime: 0.314683
2025-11-19 11:20:25,230 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427029) utime: 0.569626
2025-11-19 11:20:25,231 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427029) wtime: 1.291
2025-11-19 11:20:25,231 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427029) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-19 11:20:25,231 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427029) errors:

2025-11-19 11:20:25,238 - DEBUG - ya.test.425468  - get_binary: Binary was found by /home/runner/.ya/build/build_root/pbux/00154a/ydb/apps/ydbd/ydbd
2025-11-19 11:20:25,238 - DEBUG - ydb.tests.library.harness.kikimr_runner.425468  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/pbux/00154a/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:12506', '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:25,240 - DEBUG - ya.test.425468  - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-11-19 11:20:25,247 - DEBUG - ya.test.425468  - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-11-19 11:20:25,248 - DEBUG - ya.test.425468  - execute: Executing '['/home/runner/.ya/build/build_root/pbux/00154a/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:12506', '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:25,255 - DEBUG - ya.test.425468  - execute: Command pid: 427350
2025-11-19 11:20:26,407 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427350) rc: 0
2025-11-19 11:20:26,408 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427350) elapsed time (sec): 1.1513237953186035
2025-11-19 11:20:26,408 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427350) idrss: 0
2025-11-19 11:20:26,409 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427350) inblock: 0
2025-11-19 11:20:26,409 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427350) isrss: 0
2025-11-19 11:20:26,409 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427350) ixrss: 0
2025-11-19 11:20:26,410 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427350) majflt: 0
2025-11-19 11:20:26,410 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427350) maxrss: 597028
2025-11-19 11:20:26,410 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427350) minflt: 51856
2025-11-19 11:20:26,410 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427350) msgrcv: 0
2025-11-19 11:20:26,411 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427350) msgsnd: 0
2025-11-19 11:20:26,411 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427350) nivcsw: 230
2025-11-19 11:20:26,411 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427350) nsignals: 0
2025-11-19 11:20:26,412 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427350) nswap: 0
2025-11-19 11:20:26,414 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427350) nvcsw: 684
2025-11-19 11:20:26,414 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427350) oublock: 8
2025-11-19 11:20:26,414 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427350) stime: 0.270274
2025-11-19 11:20:26,415 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427350) utime: 0.602456
2025-11-19 11:20:26,415 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427350) wtime: 1.158
2025-11-19 11:20:26,415 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427350) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-11-19 11:20:26,415 - DEBUG - ya.test.425468  - _save_outputs: Command (pid 427350) errors:

2025-11-19 11:20:26,416 - INFO - ydb.tests.library.harness.kikimr_runner.425468  - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-19 11:20:26,615 - INFO - ydb.tests.library.harness.kikimr_runner.425468  - __run: Cluster started and initialized
2025-11-19 11:20:26,645 - DEBUG - ydb.connection.425468  - 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:26,664 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.425468  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-19 11:20:26,665 - DEBUG - ydb.connection.425468  - 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:26,719 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.425468  - context_resolve: Resolving endpoints for database /Root
2025-11-19 11:20:26,720 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ListEndpoints, 01934d13-3adc-4595-abaa-207f27bd499e, localhost:12506): creating call state
2025-11-19 11:20:26,721 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ListEndpoints, 01934d13-3adc-4595-abaa-207f27bd499e, localhost:12506): request = { database: "/Root" }
2025-11-19 11:20:26,734 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ListEndpoints, 01934d13-3adc-4595-abaa-207f27bd499e, localhost:12506): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-alsqrntpxi.auto.internal" port: 12506 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:26,735 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.425468  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-alsqrntpxi.auto.internal:12506, location 1, ssl: False>]>
2025-11-19 11:20:26,736 - DEBUG - ydb.connection.425468  - 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:26,764 - DEBUG - ydb.connection.425468  - close: Closing channel for endpoint localhost:12506
2025-11-19 11:20:26,765 - DEBUG - ydb.query.pool.425468  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-19 11:20:26,767 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(CreateSession, c914f5fe-ae91-4712-b2c5-d29922a6d264, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:26,768 - DEBUG - ydb.connection.425468  - _log_request: RpcState(CreateSession, c914f5fe-ae91-4712-b2c5-d29922a6d264, ghrun-alsqrntpxi.auto.internal:12506): request = {  }
2025-11-19 11:20:26,776 - DEBUG - ydb.connection.425468  - _log_response: RpcState(CreateSession, c914f5fe-ae91-4712-b2c5-d29922a6d264, ghrun-alsqrntpxi.auto.internal:12506): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" node_id: 1 }
2025-11-19 11:20:26,777 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(AttachSession, 5883ba3d-180a-4443-87ef-476811c3eb56, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:26,778 - DEBUG - ydb.connection.425468  - _log_request: RpcState(AttachSession, 5883ba3d-180a-4443-87ef-476811c3eb56, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" }
2025-11-19 11:20:26,782 - DEBUG - ydb.connection.425468  - _log_response: RpcState(AttachSession, 5883ba3d-180a-4443-87ef-476811c3eb56, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:26,790 - DEBUG - ydb.query.pool.425468  - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:26,791 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, f6d0a832-81df-4eee-8569-b20b273669c1, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:26,792 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, f6d0a832-81df-4eee-8569-b20b273669c1, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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:26,794 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, f6d0a832-81df-4eee-8569-b20b273669c1, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:30,385 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:30,385 - INFO - __tests__.alter_compression.425468  - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-11-19 11:20:30,386 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:30,387 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, c0f37c3f-fe8b-4274-8ceb-bf9f3e1a85a0, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:30,388 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, c0f37c3f-fe8b-4274-8ceb-bf9f3e1a85a0, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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:30,395 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, c0f37c3f-fe8b-4274-8ceb-bf9f3e1a85a0, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:31,801 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:31,802 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:31,802 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 766234dd-ddf1-49d9-825b-fcf69f89313f, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:31,803 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 766234dd-ddf1-49d9-825b-fcf69f89313f, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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:31,805 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 766234dd-ddf1-49d9-825b-fcf69f89313f, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:33,104 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:33,105 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:33,106 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 63cf68ff-d682-4f22-8afd-0d648b389b4f, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:33,107 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 63cf68ff-d682-4f22-8afd-0d648b389b4f, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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,109 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 63cf68ff-d682-4f22-8afd-0d648b389b4f, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:34,096 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:34,097 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:34,098 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 47dbfde1-91d2-4e3e-8b0f-385d4da2f300, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:34,099 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 47dbfde1-91d2-4e3e-8b0f-385d4da2f300, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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:34,101 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 47dbfde1-91d2-4e3e-8b0f-385d4da2f300, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:35,656 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:35,657 - INFO - __tests__.alter_compression.425468  - 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:35,658 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:35,659 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, d4d6c9f4-9a0a-4892-9769-407f04c9858d, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:35,660 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, d4d6c9f4-9a0a-4892-9769-407f04c9858d, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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:35,662 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, d4d6c9f4-9a0a-4892-9769-407f04c9858d, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:36,624 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:36,625 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:36,626 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, d68df9d2-3eb4-4476-94ff-845b82f20098, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:36,626 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, d68df9d2-3eb4-4476-94ff-845b82f20098, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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:36,629 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, d68df9d2-3eb4-4476-94ff-845b82f20098, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:36,869 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:36,870 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:36,871 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 2dc6b0b1-bd51-4c4e-bf88-825b9504a028, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:36,872 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 2dc6b0b1-bd51-4c4e-bf88-825b9504a028, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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:36,874 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 2dc6b0b1-bd51-4c4e-bf88-825b9504a028, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:37,226 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:37,226 - INFO - __tests__.alter_compression.425468  - 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:37,227 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:37,228 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 5e8e4921-7053-4007-b5f4-6f4ea19a71ba, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:37,229 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 5e8e4921-7053-4007-b5f4-6f4ea19a71ba, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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:37,230 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 5e8e4921-7053-4007-b5f4-6f4ea19a71ba, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:38,236 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:38,237 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:38,238 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 1665703b-a842-4296-8282-f7ea47fb4cf0, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:38,239 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 1665703b-a842-4296-8282-f7ea47fb4cf0, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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:38,242 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 1665703b-a842-4296-8282-f7ea47fb4cf0, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:38,512 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:38,513 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:38,513 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 0d57545d-4e75-414a-b920-46338bf4a1cf, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:38,514 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 0d57545d-4e75-414a-b920-46338bf4a1cf, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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:38,515 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 0d57545d-4e75-414a-b920-46338bf4a1cf, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:38,892 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:38,893 - INFO - __tests__.alter_compression.425468  - 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:38,893 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:38,894 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 2f04e0cc-c6d4-42e0-96ce-b2e305bee12f, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:38,895 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 2f04e0cc-c6d4-42e0-96ce-b2e305bee12f, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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:38,896 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 2f04e0cc-c6d4-42e0-96ce-b2e305bee12f, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:39,742 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:39,743 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:39,744 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 41d8d278-bc53-4f75-9fd8-a48ea06b207b, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:39,745 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 41d8d278-bc53-4f75-9fd8-a48ea06b207b, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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,746 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 41d8d278-bc53-4f75-9fd8-a48ea06b207b, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:39,982 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:39,983 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:39,984 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 7a90f444-68d9-440f-8325-61a0af9a57c4, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:39,984 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 7a90f444-68d9-440f-8325-61a0af9a57c4, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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:39,985 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 7a90f444-68d9-440f-8325-61a0af9a57c4, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:40,314 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:40,314 - INFO - __tests__.alter_compression.425468  - 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:40,315 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:40,315 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, d1349669-14b6-4c70-a257-e4db53fca73f, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:40,317 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, d1349669-14b6-4c70-a257-e4db53fca73f, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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:40,318 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, d1349669-14b6-4c70-a257-e4db53fca73f, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:41,300 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:41,300 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:41,301 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 9ecc4597-b0b6-4b98-9b77-f31b0243c800, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:41,302 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 9ecc4597-b0b6-4b98-9b77-f31b0243c800, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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:41,303 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 9ecc4597-b0b6-4b98-9b77-f31b0243c800, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:41,507 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:41,507 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:41,508 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 2583604f-efed-49b8-8f92-409aeae32161, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:41,508 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 2583604f-efed-49b8-8f92-409aeae32161, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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:41,510 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 2583604f-efed-49b8-8f92-409aeae32161, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:41,867 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:41,868 - INFO - __tests__.alter_compression.425468  - 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:41,868 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:41,869 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 79e8391c-0a75-42d7-93be-44528a773b80, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:41,870 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 79e8391c-0a75-42d7-93be-44528a773b80, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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:41,871 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 79e8391c-0a75-42d7-93be-44528a773b80, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:42,692 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:42,693 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:42,693 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 745c6fd5-b2c5-4535-8bc9-ef45588b0e8b, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:42,694 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 745c6fd5-b2c5-4535-8bc9-ef45588b0e8b, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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:42,695 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 745c6fd5-b2c5-4535-8bc9-ef45588b0e8b, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:42,870 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:42,871 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:42,872 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, a41a7d50-c005-477d-b870-7d5e5d8fad75, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:42,873 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, a41a7d50-c005-477d-b870-7d5e5d8fad75, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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:42,874 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, a41a7d50-c005-477d-b870-7d5e5d8fad75, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:43,278 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:43,279 - INFO - __tests__.alter_compression.425468  - 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:43,280 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:43,280 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 9eb44510-c85f-499f-b8eb-f23f0e0bfc87, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:43,281 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 9eb44510-c85f-499f-b8eb-f23f0e0bfc87, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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:43,283 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 9eb44510-c85f-499f-b8eb-f23f0e0bfc87, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:44,131 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:44,132 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:44,133 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 12e672a0-4a3a-463f-8bc9-73beb432e4f3, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:44,133 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 12e672a0-4a3a-463f-8bc9-73beb432e4f3, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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:44,135 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 12e672a0-4a3a-463f-8bc9-73beb432e4f3, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:44,347 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:44,348 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:44,348 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, c220f650-1790-413b-9136-6e79ec1389c7, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:44,349 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, c220f650-1790-413b-9136-6e79ec1389c7, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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:44,350 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, c220f650-1790-413b-9136-6e79ec1389c7, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:44,815 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:44,816 - INFO - __tests__.alter_compression.425468  - 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:44,817 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:44,817 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 353d52a0-292b-46ce-9746-df659c334555, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:44,818 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 353d52a0-292b-46ce-9746-df659c334555, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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:44,820 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 353d52a0-292b-46ce-9746-df659c334555, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:45,849 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:45,850 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:45,850 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, d11f3aed-b90c-418f-8b24-8980d3a324bd, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:45,851 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, d11f3aed-b90c-418f-8b24-8980d3a324bd, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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:45,852 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, d11f3aed-b90c-418f-8b24-8980d3a324bd, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:46,052 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:46,053 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:46,054 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, ed6cb919-db43-4ae0-b65c-4e02cf6d2e7d, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:46,054 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, ed6cb919-db43-4ae0-b65c-4e02cf6d2e7d, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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:46,056 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, ed6cb919-db43-4ae0-b65c-4e02cf6d2e7d, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:46,569 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:46,570 - INFO - __tests__.alter_compression.425468  - 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:46,571 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:46,572 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 10c40baf-c32f-46fb-91b4-14053db6c5f0, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:46,573 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 10c40baf-c32f-46fb-91b4-14053db6c5f0, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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:46,575 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 10c40baf-c32f-46fb-91b4-14053db6c5f0, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:47,414 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:47,415 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:47,415 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 038fd171-b749-4cc1-81da-2403974f7259, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:47,416 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 038fd171-b749-4cc1-81da-2403974f7259, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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:47,417 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 038fd171-b749-4cc1-81da-2403974f7259, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:47,614 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:47,615 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:47,615 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, d10f4807-0fa1-4f74-8259-dd0fd71b77fa, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:47,616 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, d10f4807-0fa1-4f74-8259-dd0fd71b77fa, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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:47,618 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, d10f4807-0fa1-4f74-8259-dd0fd71b77fa, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:48,176 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:48,176 - INFO - __tests__.alter_compression.425468  - 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:48,177 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:48,177 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, da2d9ac7-24ff-41f1-976c-6b9fd025f607, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:48,179 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, da2d9ac7-24ff-41f1-976c-6b9fd025f607, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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:48,180 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, da2d9ac7-24ff-41f1-976c-6b9fd025f607, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:49,163 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:49,164 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:49,165 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, e4a9f9bb-8375-4b49-bf83-b39690a84176, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:49,166 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, e4a9f9bb-8375-4b49-bf83-b39690a84176, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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:49,167 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, e4a9f9bb-8375-4b49-bf83-b39690a84176, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:49,383 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:49,384 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:49,385 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, d54f01fe-9eee-4c9b-b1cb-8002191b02b6, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:49,386 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, d54f01fe-9eee-4c9b-b1cb-8002191b02b6, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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:49,388 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, d54f01fe-9eee-4c9b-b1cb-8002191b02b6, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:50,001 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:50,001 - INFO - __tests__.alter_compression.425468  - 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:50,002 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:50,003 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, b7beb31e-e5c9-439d-8735-75b5866d00e6, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:50,004 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, b7beb31e-e5c9-439d-8735-75b5866d00e6, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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:50,005 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, b7beb31e-e5c9-439d-8735-75b5866d00e6, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:51,050 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:51,051 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:51,052 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, e4f255ce-a058-437e-b88a-d19dcab2e171, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:51,053 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, e4f255ce-a058-437e-b88a-d19dcab2e171, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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:51,055 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, e4f255ce-a058-437e-b88a-d19dcab2e171, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:51,291 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:51,292 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:51,293 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, a6108114-f06f-42e9-b202-60ee6bbe3569, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:51,293 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, a6108114-f06f-42e9-b202-60ee6bbe3569, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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:51,294 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, a6108114-f06f-42e9-b202-60ee6bbe3569, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:51,540 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:51,541 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:20:51,542 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, c3b6fba9-e4b2-4c75-ba1b-ec9db2b0153f, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:20:51,543 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, c3b6fba9-e4b2-4c75-ba1b-ec9db2b0153f, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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:51,544 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, c3b6fba9-e4b2-4c75-ba1b-ec9db2b0153f, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:55,166 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:05,208 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:05,209 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 2d894e14-5e92-41a6-8530-1733fc10dcef, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:05,210 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 2d894e14-5e92-41a6-8530-1733fc10dcef, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:05,211 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 2d894e14-5e92-41a6-8530-1733fc10dcef, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:08,503 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:08,548 - INFO - root.425468  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-11-19 11:21:08,549 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:08,550 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, d2b9ba79-7399-407d-914c-881eb96948cb, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:08,551 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, d2b9ba79-7399-407d-914c-881eb96948cb, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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:08,552 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, d2b9ba79-7399-407d-914c-881eb96948cb, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:12,192 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:22,240 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:22,241 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, cffff183-85ee-4dfc-bb9b-d15ff768b250, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:22,242 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, cffff183-85ee-4dfc-bb9b-d15ff768b250, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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:22,243 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, cffff183-85ee-4dfc-bb9b-d15ff768b250, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:25,445 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:25,487 - INFO - root.425468  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-11-19 11:21:25,487 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:25,488 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 56e466fb-aeca-4b6b-a74a-83e3f85b212c, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:25,489 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 56e466fb-aeca-4b6b-a74a-83e3f85b212c, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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:25,491 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 56e466fb-aeca-4b6b-a74a-83e3f85b212c, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:25,834 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:25,837 - INFO - ya.test.425468  - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_6_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 6])
2025-11-19 11:21:25,838 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:25,838 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 472e40e5-29b9-4204-8a3f-5d40c2b3da71, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:25,839 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 472e40e5-29b9-4204-8a3f-5d40c2b3da71, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_6_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 6)\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:25,840 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 472e40e5-29b9-4204-8a3f-5d40c2b3da71, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:29,046 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:29,047 - INFO - __tests__.alter_compression.425468  - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_6_compression created
2025-11-19 11:21:29,047 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:29,048 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 097df35d-062d-4ab0-ad8e-86ce8ff8554b, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:29,050 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 097df35d-062d-4ab0-ad8e-86ce8ff8554b, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_6_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:29,051 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 097df35d-062d-4ab0-ad8e-86ce8ff8554b, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:30,472 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:30,478 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:30,479 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, be473ce3-8390-40ee-ad09-66448d154409, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:30,481 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, be473ce3-8390-40ee-ad09-66448d154409, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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_6_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:30,482 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, be473ce3-8390-40ee-ad09-66448d154409, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:32,072 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:32,074 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:32,075 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 98f573a6-1598-441c-86e7-01f2a96087e5, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:32,076 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 98f573a6-1598-441c-86e7-01f2a96087e5, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:32,077 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 98f573a6-1598-441c-86e7-01f2a96087e5, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:33,090 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:33,091 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:33,092 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 9c76e43b-3e98-46b6-a961-55c54c081e2b, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:33,093 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 9c76e43b-3e98-46b6-a961-55c54c081e2b, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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_6_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,095 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 9c76e43b-3e98-46b6-a961-55c54c081e2b, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:35,051 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:35,052 - INFO - __tests__.alter_compression.425468  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318016, 'BlobCount': 128}}
2025-11-19 11:21:35,052 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:35,053 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 35554e20-603d-42ba-b273-34a968b8c424, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:35,054 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 35554e20-603d-42ba-b273-34a968b8c424, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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_6_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:35,055 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 35554e20-603d-42ba-b273-34a968b8c424, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:36,608 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:36,616 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:36,628 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, f6a95814-7d9a-4be7-b218-34ad984c8435, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:36,629 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, f6a95814-7d9a-4be7-b218-34ad984c8435, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:36,631 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, f6a95814-7d9a-4be7-b218-34ad984c8435, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:37,019 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:37,020 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:37,021 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 4e1feeaa-dcdc-453b-ab99-0d07bbeafe21, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:37,022 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 4e1feeaa-dcdc-453b-ab99-0d07bbeafe21, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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_6_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:37,028 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 4e1feeaa-dcdc-453b-ab99-0d07bbeafe21, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:37,618 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:37,622 - INFO - __tests__.alter_compression.425468  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 637312, 'BlobCount': 256}}
2025-11-19 11:21:37,623 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:37,623 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, b1928511-2537-4b56-96e1-8454e6d4e57e, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:37,625 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, b1928511-2537-4b56-96e1-8454e6d4e57e, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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_6_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:37,629 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, b1928511-2537-4b56-96e1-8454e6d4e57e, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:38,945 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:38,946 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:38,947 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 64867bda-485a-44c8-a8aa-9a573d2a4139, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:38,948 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 64867bda-485a-44c8-a8aa-9a573d2a4139, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:38,949 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 64867bda-485a-44c8-a8aa-9a573d2a4139, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:39,202 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:39,203 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:39,203 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 703ac5b6-f88b-4642-bfbf-c990db72ffa6, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:39,204 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 703ac5b6-f88b-4642-bfbf-c990db72ffa6, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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_6_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:39,206 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 703ac5b6-f88b-4642-bfbf-c990db72ffa6, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:39,598 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:39,599 - INFO - __tests__.alter_compression.425468  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 956352, 'BlobCount': 384}}
2025-11-19 11:21:39,600 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:39,600 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 85d7e1d8-9bd6-4f60-bec9-d04be2e01883, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:39,602 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 85d7e1d8-9bd6-4f60-bec9-d04be2e01883, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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_6_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:39,606 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 85d7e1d8-9bd6-4f60-bec9-d04be2e01883, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:40,978 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:40,979 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:40,980 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 43a82f25-ee17-4bb8-a928-8bcdfbada806, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:40,982 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 43a82f25-ee17-4bb8-a928-8bcdfbada806, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:40,984 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 43a82f25-ee17-4bb8-a928-8bcdfbada806, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:41,249 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:41,250 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:41,251 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, a52fc9c9-3365-447d-ac1a-29e0ea6e2b56, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:41,252 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, a52fc9c9-3365-447d-ac1a-29e0ea6e2b56, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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_6_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:41,253 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, a52fc9c9-3365-447d-ac1a-29e0ea6e2b56, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:41,662 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:41,669 - INFO - __tests__.alter_compression.425468  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1275712, 'BlobCount': 512}}
2025-11-19 11:21:41,669 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:41,670 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 2038e16d-3cfb-4522-a230-17e2c2888604, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:41,671 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 2038e16d-3cfb-4522-a230-17e2c2888604, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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_6_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:41,673 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 2038e16d-3cfb-4522-a230-17e2c2888604, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:42,953 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:42,954 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:42,954 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 730fbfc7-6618-4769-9977-3eaed8dceceb, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:42,955 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 730fbfc7-6618-4769-9977-3eaed8dceceb, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:42,957 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 730fbfc7-6618-4769-9977-3eaed8dceceb, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:43,273 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:43,274 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:43,275 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 3efe3b69-539d-42f2-bb95-022e88616774, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:43,276 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 3efe3b69-539d-42f2-bb95-022e88616774, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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_6_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:43,277 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 3efe3b69-539d-42f2-bb95-022e88616774, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:43,720 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:43,721 - INFO - __tests__.alter_compression.425468  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1594672, 'BlobCount': 640}}
2025-11-19 11:21:43,721 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:43,722 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 2bba845e-216a-4cf4-95f9-99a7f479b757, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:43,723 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 2bba845e-216a-4cf4-95f9-99a7f479b757, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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_6_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:43,725 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 2bba845e-216a-4cf4-95f9-99a7f479b757, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:45,007 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:45,008 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:45,009 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 198f36dc-fade-4851-ba6a-e3a17c5313a4, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:45,010 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 198f36dc-fade-4851-ba6a-e3a17c5313a4, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:45,012 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 198f36dc-fade-4851-ba6a-e3a17c5313a4, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:45,285 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:45,286 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:45,287 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 99692f6e-4571-4af0-abfc-e42c562575da, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:45,288 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 99692f6e-4571-4af0-abfc-e42c562575da, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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_6_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:45,290 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 99692f6e-4571-4af0-abfc-e42c562575da, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:45,782 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:45,783 - INFO - __tests__.alter_compression.425468  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1913856, 'BlobCount': 768}}
2025-11-19 11:21:45,784 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:45,784 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, e4daee5c-2b8e-41c5-89f9-dfc7b2a3293a, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:45,785 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, e4daee5c-2b8e-41c5-89f9-dfc7b2a3293a, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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_6_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:45,786 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, e4daee5c-2b8e-41c5-89f9-dfc7b2a3293a, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:47,070 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:47,071 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:47,072 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 64bef47b-9931-4edf-91bf-99f53c913ddc, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:47,073 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 64bef47b-9931-4edf-91bf-99f53c913ddc, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:47,079 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 64bef47b-9931-4edf-91bf-99f53c913ddc, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:47,330 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:47,331 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:47,332 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 43f9f3ac-3302-4c57-b3b9-bfaf37cb7f3a, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:47,333 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 43f9f3ac-3302-4c57-b3b9-bfaf37cb7f3a, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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_6_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:47,334 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 43f9f3ac-3302-4c57-b3b9-bfaf37cb7f3a, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:47,897 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:47,898 - INFO - __tests__.alter_compression.425468  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2232992, 'BlobCount': 896}}
2025-11-19 11:21:47,898 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:47,899 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 59b50460-f5d0-473b-8d3e-0d2da6a7ef69, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:47,900 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 59b50460-f5d0-473b-8d3e-0d2da6a7ef69, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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_6_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:47,901 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 59b50460-f5d0-473b-8d3e-0d2da6a7ef69, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:49,091 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:49,091 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:49,092 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 10e801b0-17bc-4387-a533-26d25d7d868e, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:49,093 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 10e801b0-17bc-4387-a533-26d25d7d868e, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:49,095 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 10e801b0-17bc-4387-a533-26d25d7d868e, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:49,296 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:49,297 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:49,298 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 342749e6-d42f-45c2-819f-0e03a633517a, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:49,299 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 342749e6-d42f-45c2-819f-0e03a633517a, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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_6_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:49,301 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 342749e6-d42f-45c2-819f-0e03a633517a, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:49,827 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:49,828 - INFO - __tests__.alter_compression.425468  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2552480, 'BlobCount': 1024}}
2025-11-19 11:21:49,829 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:49,830 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 3a06425e-7f2b-4eaa-b254-f5b9aaf8faf8, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:49,831 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 3a06425e-7f2b-4eaa-b254-f5b9aaf8faf8, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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_6_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:49,832 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 3a06425e-7f2b-4eaa-b254-f5b9aaf8faf8, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:50,769 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:50,770 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:50,770 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 94bf49c1-94a3-4d9d-bd28-7882317a7a18, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:50,771 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 94bf49c1-94a3-4d9d-bd28-7882317a7a18, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:50,773 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 94bf49c1-94a3-4d9d-bd28-7882317a7a18, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:50,972 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:50,973 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:50,974 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 5dc654da-00a8-4a4c-8d8b-c6edfe8bed8a, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:50,975 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 5dc654da-00a8-4a4c-8d8b-c6edfe8bed8a, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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_6_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:50,976 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 5dc654da-00a8-4a4c-8d8b-c6edfe8bed8a, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:51,527 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:51,528 - INFO - __tests__.alter_compression.425468  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2871488, 'BlobCount': 1152}}
2025-11-19 11:21:51,529 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:51,530 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, ffaca9cf-de86-4b49-83a4-8c404d146aad, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:51,532 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, ffaca9cf-de86-4b49-83a4-8c404d146aad, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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_6_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:51,533 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, ffaca9cf-de86-4b49-83a4-8c404d146aad, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:52,737 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:52,738 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:52,738 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 2180d8ac-59f3-4f1f-8797-5ac30eea9a6e, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:52,739 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 2180d8ac-59f3-4f1f-8797-5ac30eea9a6e, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:52,741 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 2180d8ac-59f3-4f1f-8797-5ac30eea9a6e, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:52,978 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:52,979 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:52,980 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 1c96c30b-a16b-4694-b180-1438331ba0f0, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:52,981 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 1c96c30b-a16b-4694-b180-1438331ba0f0, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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_6_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:52,982 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 1c96c30b-a16b-4694-b180-1438331ba0f0, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:53,692 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.425468  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-19 11:21:53,693 - DEBUG - ydb.connection.425468  - 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:53,709 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.425468  - context_resolve: Resolving endpoints for database /Root
2025-11-19 11:21:53,710 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ListEndpoints, 3d5c418b-dbab-4705-9144-6a38b292d348, localhost:12506): creating call state
2025-11-19 11:21:53,711 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ListEndpoints, 3d5c418b-dbab-4705-9144-6a38b292d348, localhost:12506): request = { database: "/Root" }
2025-11-19 11:21:53,715 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ListEndpoints, 3d5c418b-dbab-4705-9144-6a38b292d348, localhost:12506): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-alsqrntpxi.auto.internal" port: 12506 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:53,716 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.425468  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-alsqrntpxi.auto.internal:12506, location 1, ssl: False>]>
2025-11-19 11:21:53,717 - DEBUG - ydb.connection.425468  - close: Closing channel for endpoint localhost:12506
2025-11-19 11:21:53,722 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:53,723 - INFO - __tests__.alter_compression.425468  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3190992, 'BlobCount': 1280}}
2025-11-19 11:21:53,723 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:53,724 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 79265609-d217-47f9-a28c-8c0f3f0104a4, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:53,725 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 79265609-d217-47f9-a28c-8c0f3f0104a4, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_6_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:53,726 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 79265609-d217-47f9-a28c-8c0f3f0104a4, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:54,866 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:54,867 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:54,868 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, bbf4ae56-cf38-455e-8584-04057c382e2a, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:54,869 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, bbf4ae56-cf38-455e-8584-04057c382e2a, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:54,872 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, bbf4ae56-cf38-455e-8584-04057c382e2a, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:55,221 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:55,222 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:55,223 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 0d272ece-e36b-453a-8aae-ce2b03bd854f, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:55,224 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 0d272ece-e36b-453a-8aae-ce2b03bd854f, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:55,225 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 0d272ece-e36b-453a-8aae-ce2b03bd854f, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:55,597 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:55,598 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:21:55,599 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, fee29aaa-686a-4651-af87-11deafc1e49b, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:21:55,600 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, fee29aaa-686a-4651-af87-11deafc1e49b, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_6_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:55,601 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, fee29aaa-686a-4651-af87-11deafc1e49b, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:22:01,846 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:22:11,937 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:22:11,938 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, c15c6e6e-ca05-4d42-b9fb-098926ea60c6, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:22:11,939 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, c15c6e6e-ca05-4d42-b9fb-098926ea60c6, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_6_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:22:11,940 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, c15c6e6e-ca05-4d42-b9fb-098926ea60c6, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:22:18,996 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:22:19,070 - INFO - root.425468  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_6_compression`, volumes `value` (8000000, 1595496)
2025-11-19 11:22:19,071 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:22:19,072 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, b4850bcf-8e06-4480-9704-a8ec582499c1, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:22:19,073 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, b4850bcf-8e06-4480-9704-a8ec582499c1, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:22:19,075 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, b4850bcf-8e06-4480-9704-a8ec582499c1, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:22:19,720 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:22:19,721 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:22:19,722 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, ce1272a6-e09a-4a1f-af7a-2820e1a7eff1, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:22:19,723 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, ce1272a6-e09a-4a1f-af7a-2820e1a7eff1, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_6_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:22:19,724 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, ce1272a6-e09a-4a1f-af7a-2820e1a7eff1, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:22:25,853 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:22:35,898 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:22:35,899 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, db222264-09dd-44d6-8121-2564ad8c80f0, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:22:35,900 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, db222264-09dd-44d6-8121-2564ad8c80f0, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_6_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:22:35,902 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, db222264-09dd-44d6-8121-2564ad8c80f0, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:22:39,258 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:22:49,349 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:22:49,350 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, 9354247b-6daf-459d-92db-753b284b8e4f, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:22:49,351 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, 9354247b-6daf-459d-92db-753b284b8e4f, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_6_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:22:49,353 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, 9354247b-6daf-459d-92db-753b284b8e4f, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:22:50,515 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:23:00,522 - DEBUG - ydb.query.pool.425468  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:23:00,523 - DEBUG - ydb.connection.425468  - _prepare_call: RpcState(ExecuteQuery, f58766e8-f4cc-4bd8-959b-6313e593e39c, ghrun-alsqrntpxi.auto.internal:12506): creating call state
2025-11-19 11:23:00,524 - DEBUG - ydb.connection.425468  - _log_request: RpcState(ExecuteQuery, f58766e8-f4cc-4bd8-959b-6313e593e39c, ghrun-alsqrntpxi.auto.internal:12506): request = { session_id: "ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_6_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:23:00,525 - DEBUG - ydb.connection.425468  - _log_response: RpcState(ExecuteQuery, f58766e8-f4cc-4bd8-959b-6313e593e39c, ghrun-alsqrntpxi.auto.internal:12506): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:23:02,404 - DEBUG - ydb.query.pool.425468  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDI5OGQzMmItYWNjYzQ3ZjMtYjEwYmFiMGMtMWIxNTAwYWM=
2025-11-19 11:23:02,410 - INFO - root.425468  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_6_compression`, volumes `value` (8000000, 1466256)
2025-11-19 11:23:02,411 - INFO - root.425468  - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_6_compression` 8092160 / 1466256: 5.518927117774795
2025-11-19 11:23:02,413 - INFO - ya.test.425468  - pytest_runtest_teardown: Test teardown
