2025-10-16 17:17:57,119 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-16 17:17:57,120 - INFO - ya.test - pytest_runtest_setup: test_all_supported_compression[zstd_6_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 6]
2025-10-16 17:17:57,121 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-16 17:17:57,121 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-10-16 17:17:57,124 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-10-16 17:17:57,125 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-10-16 17:17:57,125 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/b9t0/0016d5/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-10-16 17:17:57,138 - DEBUG - ya.test - execute: Command pid: 1012048
2025-10-16 17:17:58,101 - DEBUG - ya.test - _save_outputs: Command (pid 1012048) rc: 0
2025-10-16 17:17:58,101 - DEBUG - ya.test - _save_outputs: Command (pid 1012048) elapsed time (sec): 0.9613146781921387
2025-10-16 17:17:58,102 - DEBUG - ya.test - _save_outputs: Command (pid 1012048) idrss: 0
2025-10-16 17:17:58,102 - DEBUG - ya.test - _save_outputs: Command (pid 1012048) inblock: 0
2025-10-16 17:17:58,103 - DEBUG - ya.test - _save_outputs: Command (pid 1012048) isrss: 0
2025-10-16 17:17:58,103 - DEBUG - ya.test - _save_outputs: Command (pid 1012048) ixrss: 0
2025-10-16 17:17:58,103 - DEBUG - ya.test - _save_outputs: Command (pid 1012048) majflt: 0
2025-10-16 17:17:58,103 - DEBUG - ya.test - _save_outputs: Command (pid 1012048) maxrss: 485744
2025-10-16 17:17:58,104 - DEBUG - ya.test - _save_outputs: Command (pid 1012048) minflt: 45150
2025-10-16 17:17:58,104 - DEBUG - ya.test - _save_outputs: Command (pid 1012048) msgrcv: 0
2025-10-16 17:17:58,105 - DEBUG - ya.test - _save_outputs: Command (pid 1012048) msgsnd: 0
2025-10-16 17:17:58,106 - DEBUG - ya.test - _save_outputs: Command (pid 1012048) nivcsw: 208
2025-10-16 17:17:58,106 - DEBUG - ya.test - _save_outputs: Command (pid 1012048) nsignals: 0
2025-10-16 17:17:58,106 - DEBUG - ya.test - _save_outputs: Command (pid 1012048) nswap: 0
2025-10-16 17:17:58,107 - DEBUG - ya.test - _save_outputs: Command (pid 1012048) nvcsw: 14
2025-10-16 17:17:58,107 - DEBUG - ya.test - _save_outputs: Command (pid 1012048) oublock: 8
2025-10-16 17:17:58,107 - DEBUG - ya.test - _save_outputs: Command (pid 1012048) stime: 0.19738899999999998
2025-10-16 17:17:58,108 - DEBUG - ya.test - _save_outputs: Command (pid 1012048) utime: 0.549655
2025-10-16 17:17:58,108 - DEBUG - ya.test - _save_outputs: Command (pid 1012048) wtime: 0.975
2025-10-16 17:17:58,108 - DEBUG - ya.test - _save_outputs: Command (pid 1012048) output:
Git info:
    Commit: d615d0ffd6e2f23c896ca96121aca842413fb672
    Branch: 
    Author: Andrey Zaspa <zacpa@ya.ru>
    Summary: Merge 2f4fc663ace566d7ea72dd9c85ebd0092851e7e4 into 6819ac59eb1f43dd80b94010061f13b3ff17d91a

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-2kszfvc6cm
    Host information: 
        Linux ghrun-2kszfvc6cm 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/9944335923/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9944335923/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-10-16 17:17:58,126 - DEBUG - ya.test - _save_outputs: Command (pid 1012048) errors:

2025-10-16 17:17:58,127 - INFO - __tests__.base - _setup_ydb: Git info:
    Commit: d615d0ffd6e2f23c896ca96121aca842413fb672
    Branch: 
    Author: Andrey Zaspa <zacpa@ya.ru>
    Summary: Merge 2f4fc663ace566d7ea72dd9c85ebd0092851e7e4 into 6819ac59eb1f43dd80b94010061f13b3ff17d91a

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-2kszfvc6cm
    Host information: 
        Linux ghrun-2kszfvc6cm 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/9944335923/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9944335923/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-10-16 17:17:58,368 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/b9t0/0016d5/ydb/apps/ydbd/ydbd
2025-10-16 17:17:58,370 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/6051
2025-10-16 17:17:58,371 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/b9t0/0016d5/r3tmp/kikimr_cluster_z1xbmjxy
2025-10-16 17:17:58,421 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/b9t0/0016d5/ydb/apps/ydbd/ydbd
2025-10-16 17:17:58,422 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/17459
2025-10-16 17:17:58,423 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/61402
2025-10-16 17:17:58,427 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/11372
2025-10-16 17:17:58,428 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/64039
2025-10-16 17:17:58,429 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/b9t0/0016d5/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-10-16 17:17:58,429 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/b9t0/0016d5/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/b9t0/0016d5/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_99vwyfdz.log --grpc-port=17459 --mon-port=61402 --ic-port=6051
2025-10-16 17:17:58,430 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:17459/1, disk_size 68719476736
2025-10-16 17:17:58,430 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/b9t0/0016d5/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-10-16 17:17:58,431 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/b9t0/0016d5/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/b9t0/0016d5/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_99vwyfdz.log --grpc-port=17459 --mon-port=61402 --ic-port=6051
2025-10-16 17:17:58,432 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/b9t0/0016d5/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/b9t0/0016d5/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/b9t0/0016d5/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_99vwyfdz.log', '--grpc-port=17459', '--mon-port=61402', '--ic-port=6051')' in '/home/runner/.ya/build/build_root/b9t0/0016d5/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-10-16 17:17:58,449 - DEBUG - ya.test - execute: Command pid: 1012236
2025-10-16 17:17:58,450 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:17459/1
2025-10-16 17:17:58,451 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-10-16 17:17:58,452 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-10-16 17:17:58,454 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/b9t0/0016d5/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-10-16 17:17:58,463 - DEBUG - ya.test - execute: Command pid: 1012238
2025-10-16 17:17:59,509 - DEBUG - ya.test - _save_outputs: Command (pid 1012238) rc: 0
2025-10-16 17:17:59,509 - DEBUG - ya.test - _save_outputs: Command (pid 1012238) elapsed time (sec): 1.0452113151550293
2025-10-16 17:17:59,510 - DEBUG - ya.test - _save_outputs: Command (pid 1012238) idrss: 0
2025-10-16 17:17:59,510 - DEBUG - ya.test - _save_outputs: Command (pid 1012238) inblock: 0
2025-10-16 17:17:59,510 - DEBUG - ya.test - _save_outputs: Command (pid 1012238) isrss: 0
2025-10-16 17:17:59,511 - DEBUG - ya.test - _save_outputs: Command (pid 1012238) ixrss: 0
2025-10-16 17:17:59,511 - DEBUG - ya.test - _save_outputs: Command (pid 1012238) majflt: 0
2025-10-16 17:17:59,511 - DEBUG - ya.test - _save_outputs: Command (pid 1012238) maxrss: 492580
2025-10-16 17:17:59,512 - DEBUG - ya.test - _save_outputs: Command (pid 1012238) minflt: 45225
2025-10-16 17:17:59,512 - DEBUG - ya.test - _save_outputs: Command (pid 1012238) msgrcv: 0
2025-10-16 17:17:59,512 - DEBUG - ya.test - _save_outputs: Command (pid 1012238) msgsnd: 0
2025-10-16 17:17:59,513 - DEBUG - ya.test - _save_outputs: Command (pid 1012238) nivcsw: 156
2025-10-16 17:17:59,513 - DEBUG - ya.test - _save_outputs: Command (pid 1012238) nsignals: 0
2025-10-16 17:17:59,514 - DEBUG - ya.test - _save_outputs: Command (pid 1012238) nswap: 0
2025-10-16 17:17:59,514 - DEBUG - ya.test - _save_outputs: Command (pid 1012238) nvcsw: 14
2025-10-16 17:17:59,514 - DEBUG - ya.test - _save_outputs: Command (pid 1012238) oublock: 8
2025-10-16 17:17:59,515 - DEBUG - ya.test - _save_outputs: Command (pid 1012238) stime: 0.159577
2025-10-16 17:17:59,515 - DEBUG - ya.test - _save_outputs: Command (pid 1012238) utime: 0.607833
2025-10-16 17:17:59,516 - DEBUG - ya.test - _save_outputs: Command (pid 1012238) wtime: 1.054
2025-10-16 17:17:59,521 - DEBUG - ya.test - _save_outputs: Command (pid 1012238) output:
Git info:
    Commit: d615d0ffd6e2f23c896ca96121aca842413fb672
    Branch: 
    Author: Andrey Zaspa <zacpa@ya.ru>
    Summary: Merge 2f4fc663ace566d7ea72dd9c85ebd0092851e7e4 into 6819ac59eb1f43dd80b94010061f13b3ff17d91a

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-2kszfvc6cm
    Host information: 
        Linux ghrun-2kszfvc6cm 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/9944335923/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9944335923/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-10-16 17:17:59,521 - DEBUG - ya.test - _save_outputs: Command (pid 1012238) errors:

2025-10-16 17:17:59,522 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: d615d0ffd6e2f23c896ca96121aca842413fb672
    Branch: 
    Author: Andrey Zaspa <zacpa@ya.ru>
    Summary: Merge 2f4fc663ace566d7ea72dd9c85ebd0092851e7e4 into 6819ac59eb1f43dd80b94010061f13b3ff17d91a
2025-10-16 17:18:05,488 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/b9t0/0016d5/ydb/apps/ydbd/ydbd
2025-10-16 17:18:05,493 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/b9t0/0016d5/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:17459', '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: 6051\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-10-16 17:18:05,494 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-10-16 17:18:05,495 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-10-16 17:18:05,495 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/b9t0/0016d5/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:17459', '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: 6051\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-10-16 17:18:05,508 - DEBUG - ya.test - execute: Command pid: 1012941
2025-10-16 17:18:06,641 - DEBUG - ya.test - _save_outputs: Command (pid 1012941) rc: 0
2025-10-16 17:18:06,642 - DEBUG - ya.test - _save_outputs: Command (pid 1012941) elapsed time (sec): 1.1315596103668213
2025-10-16 17:18:06,642 - DEBUG - ya.test - _save_outputs: Command (pid 1012941) idrss: 0
2025-10-16 17:18:06,642 - DEBUG - ya.test - _save_outputs: Command (pid 1012941) inblock: 0
2025-10-16 17:18:06,643 - DEBUG - ya.test - _save_outputs: Command (pid 1012941) isrss: 0
2025-10-16 17:18:06,643 - DEBUG - ya.test - _save_outputs: Command (pid 1012941) ixrss: 0
2025-10-16 17:18:06,643 - DEBUG - ya.test - _save_outputs: Command (pid 1012941) majflt: 0
2025-10-16 17:18:06,643 - DEBUG - ya.test - _save_outputs: Command (pid 1012941) maxrss: 591356
2025-10-16 17:18:06,644 - DEBUG - ya.test - _save_outputs: Command (pid 1012941) minflt: 51389
2025-10-16 17:18:06,644 - DEBUG - ya.test - _save_outputs: Command (pid 1012941) msgrcv: 0
2025-10-16 17:18:06,653 - DEBUG - ya.test - _save_outputs: Command (pid 1012941) msgsnd: 0
2025-10-16 17:18:06,654 - DEBUG - ya.test - _save_outputs: Command (pid 1012941) nivcsw: 203
2025-10-16 17:18:06,654 - DEBUG - ya.test - _save_outputs: Command (pid 1012941) nsignals: 0
2025-10-16 17:18:06,654 - DEBUG - ya.test - _save_outputs: Command (pid 1012941) nswap: 0
2025-10-16 17:18:06,654 - DEBUG - ya.test - _save_outputs: Command (pid 1012941) nvcsw: 625
2025-10-16 17:18:06,655 - DEBUG - ya.test - _save_outputs: Command (pid 1012941) oublock: 8
2025-10-16 17:18:06,655 - DEBUG - ya.test - _save_outputs: Command (pid 1012941) stime: 0.242219
2025-10-16 17:18:06,655 - DEBUG - ya.test - _save_outputs: Command (pid 1012941) utime: 0.628891
2025-10-16 17:18:06,656 - DEBUG - ya.test - _save_outputs: Command (pid 1012941) wtime: 1.145
2025-10-16 17:18:06,656 - DEBUG - ya.test - _save_outputs: Command (pid 1012941) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-10-16 17:18:06,661 - DEBUG - ya.test - _save_outputs: Command (pid 1012941) errors:

2025-10-16 17:18:06,663 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/b9t0/0016d5/ydb/apps/ydbd/ydbd
2025-10-16 17:18:06,663 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/b9t0/0016d5/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:17459', '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-10-16 17:18:06,665 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-10-16 17:18:06,665 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-10-16 17:18:06,666 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/b9t0/0016d5/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:17459', '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-10-16 17:18:06,667 - DEBUG - ya.test - execute: Command pid: 1013145
2025-10-16 17:18:07,873 - DEBUG - ya.test - _save_outputs: Command (pid 1013145) rc: 0
2025-10-16 17:18:07,873 - DEBUG - ya.test - _save_outputs: Command (pid 1013145) elapsed time (sec): 1.204380989074707
2025-10-16 17:18:07,874 - DEBUG - ya.test - _save_outputs: Command (pid 1013145) idrss: 0
2025-10-16 17:18:07,874 - DEBUG - ya.test - _save_outputs: Command (pid 1013145) inblock: 0
2025-10-16 17:18:07,874 - DEBUG - ya.test - _save_outputs: Command (pid 1013145) isrss: 0
2025-10-16 17:18:07,875 - DEBUG - ya.test - _save_outputs: Command (pid 1013145) ixrss: 0
2025-10-16 17:18:07,875 - DEBUG - ya.test - _save_outputs: Command (pid 1013145) majflt: 0
2025-10-16 17:18:07,875 - DEBUG - ya.test - _save_outputs: Command (pid 1013145) maxrss: 591920
2025-10-16 17:18:07,875 - DEBUG - ya.test - _save_outputs: Command (pid 1013145) minflt: 51417
2025-10-16 17:18:07,876 - DEBUG - ya.test - _save_outputs: Command (pid 1013145) msgrcv: 0
2025-10-16 17:18:07,876 - DEBUG - ya.test - _save_outputs: Command (pid 1013145) msgsnd: 0
2025-10-16 17:18:07,877 - DEBUG - ya.test - _save_outputs: Command (pid 1013145) nivcsw: 260
2025-10-16 17:18:07,877 - DEBUG - ya.test - _save_outputs: Command (pid 1013145) nsignals: 0
2025-10-16 17:18:07,877 - DEBUG - ya.test - _save_outputs: Command (pid 1013145) nswap: 0
2025-10-16 17:18:07,878 - DEBUG - ya.test - _save_outputs: Command (pid 1013145) nvcsw: 847
2025-10-16 17:18:07,878 - DEBUG - ya.test - _save_outputs: Command (pid 1013145) oublock: 8
2025-10-16 17:18:07,878 - DEBUG - ya.test - _save_outputs: Command (pid 1013145) stime: 0.27080499999999996
2025-10-16 17:18:07,878 - DEBUG - ya.test - _save_outputs: Command (pid 1013145) utime: 0.5877049999999999
2025-10-16 17:18:07,879 - DEBUG - ya.test - _save_outputs: Command (pid 1013145) wtime: 1.206
2025-10-16 17:18:07,879 - DEBUG - ya.test - _save_outputs: Command (pid 1013145) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-10-16 17:18:07,879 - DEBUG - ya.test - _save_outputs: Command (pid 1013145) errors:

2025-10-16 17:18:07,880 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-10-16 17:18:08,117 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-10-16 17:18:08,162 - DEBUG - ydb.connection - 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-10-16 17:18:08,177 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-16 17:18:08,177 - DEBUG - ydb.connection - 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-10-16 17:18:08,227 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-10-16 17:18:08,228 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, e60945d5-c2ba-45fe-b3ee-7b6a7cae8388, localhost:17459): creating call state
2025-10-16 17:18:08,229 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, e60945d5-c2ba-45fe-b3ee-7b6a7cae8388, localhost:17459): request = { database: "/Root" }
2025-10-16 17:18:08,238 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, e60945d5-c2ba-45fe-b3ee-7b6a7cae8388, localhost:17459): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-2kszfvc6cm.auto.internal" port: 17459 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-10-16 17:18:08,240 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-2kszfvc6cm.auto.internal:17459, location 1, ssl: False>]>
2025-10-16 17:18:08,244 - DEBUG - ydb.connection - 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-10-16 17:18:08,272 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:17459
2025-10-16 17:18:08,277 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-10-16 17:18:08,278 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 1c737928-3d8d-477e-891c-8329abd5b3e1, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:08,279 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 1c737928-3d8d-477e-891c-8329abd5b3e1, ghrun-2kszfvc6cm.auto.internal:17459): request = {  }
2025-10-16 17:18:08,290 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 1c737928-3d8d-477e-891c-8329abd5b3e1, ghrun-2kszfvc6cm.auto.internal:17459): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" node_id: 1 }
2025-10-16 17:18:08,291 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, dfe7dd90-a9a6-4451-b0eb-d061dc522b9d, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:08,291 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, dfe7dd90-a9a6-4451-b0eb-d061dc522b9d, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" }
2025-10-16 17:18:08,297 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, dfe7dd90-a9a6-4451-b0eb-d061dc522b9d, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:08,325 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:08,326 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1760df2b-db73-4d44-b246-ee951d60090e, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:08,327 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1760df2b-db73-4d44-b246-ee951d60090e, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:08,329 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1760df2b-db73-4d44-b246-ee951d60090e, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:12,045 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:12,045 - INFO - __tests__.alter_compression - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-10-16 17:18:12,046 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:12,047 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a0495b94-ebc4-4d7f-b3ad-03d7e3af9b71, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:12,048 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a0495b94-ebc4-4d7f-b3ad-03d7e3af9b71, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:12,051 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a0495b94-ebc4-4d7f-b3ad-03d7e3af9b71, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:13,304 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:13,305 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:13,306 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a5d1918e-e760-447f-8530-8db6125d3ba4, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:13,307 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a5d1918e-e760-447f-8530-8db6125d3ba4, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:13,311 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a5d1918e-e760-447f-8530-8db6125d3ba4, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:14,465 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:14,466 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:14,467 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 20802e5d-9172-430e-80dc-7024f0415b15, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:14,467 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 20802e5d-9172-430e-80dc-7024f0415b15, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:14,469 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 20802e5d-9172-430e-80dc-7024f0415b15, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:15,445 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:15,446 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:15,447 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 737d5311-a7f7-4b78-b098-d618f7e3d20e, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:15,448 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 737d5311-a7f7-4b78-b098-d618f7e3d20e, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:15,450 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 737d5311-a7f7-4b78-b098-d618f7e3d20e, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:17,081 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:17,081 - INFO - __tests__.alter_compression - 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-10-16 17:18:17,082 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:17,082 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 275b5fb3-7886-4cf8-8c2e-e0504ad84e39, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:17,083 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 275b5fb3-7886-4cf8-8c2e-e0504ad84e39, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:17,084 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 275b5fb3-7886-4cf8-8c2e-e0504ad84e39, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:18,188 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:18,189 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:18,190 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a753b458-fed1-4fa2-ac6b-3727b1eea598, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:18,191 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a753b458-fed1-4fa2-ac6b-3727b1eea598, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:18,192 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a753b458-fed1-4fa2-ac6b-3727b1eea598, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:18,486 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:18,487 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:18,488 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, dc2f053e-54d6-4eae-bd38-723a22c8a212, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:18,488 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, dc2f053e-54d6-4eae-bd38-723a22c8a212, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:18,489 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, dc2f053e-54d6-4eae-bd38-723a22c8a212, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:18,959 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:18,959 - INFO - __tests__.alter_compression - 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-10-16 17:18:18,960 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:18,961 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b0d8d009-3a40-49c5-b15d-c213696de34c, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:18,961 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b0d8d009-3a40-49c5-b15d-c213696de34c, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:18,970 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b0d8d009-3a40-49c5-b15d-c213696de34c, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:20,231 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:20,232 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:20,233 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 93d0f004-09d1-42f9-89dc-f42e4b068476, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:20,234 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 93d0f004-09d1-42f9-89dc-f42e4b068476, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:20,235 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 93d0f004-09d1-42f9-89dc-f42e4b068476, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:20,521 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:20,522 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:20,523 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 330ab960-0e7c-4219-b1aa-005bfc6a5ad9, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:20,524 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 330ab960-0e7c-4219-b1aa-005bfc6a5ad9, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:20,526 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 330ab960-0e7c-4219-b1aa-005bfc6a5ad9, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:21,088 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:21,089 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 182}}, blobs: {'__DEFAULT': {'Portions': 182, 'BlobSize': 4858624, 'BlobCount': 384}}
2025-10-16 17:18:21,090 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:21,090 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4006ddca-b00d-4022-bcd2-a7e3d0d13589, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:21,091 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4006ddca-b00d-4022-bcd2-a7e3d0d13589, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:21,105 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4006ddca-b00d-4022-bcd2-a7e3d0d13589, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:22,140 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:22,141 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:22,141 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f160f5a7-8687-471b-8ec1-20724f461858, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:22,142 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f160f5a7-8687-471b-8ec1-20724f461858, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:22,144 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f160f5a7-8687-471b-8ec1-20724f461858, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:22,556 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:22,557 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:22,558 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9a2fca77-0a1f-4f6a-ae36-ffca8bb9dbc8, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:22,558 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9a2fca77-0a1f-4f6a-ae36-ffca8bb9dbc8, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:22,560 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9a2fca77-0a1f-4f6a-ae36-ffca8bb9dbc8, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:23,073 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:23,074 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 242}}, blobs: {'__DEFAULT': {'Portions': 242, 'BlobSize': 6477368, 'BlobCount': 508}}
2025-10-16 17:18:23,074 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:23,080 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4d1b1b41-dcc6-464c-bf73-9a77ca21d940, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:23,082 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4d1b1b41-dcc6-464c-bf73-9a77ca21d940, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:23,083 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4d1b1b41-dcc6-464c-bf73-9a77ca21d940, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:24,647 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:24,648 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:24,648 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, db62bdb9-f52c-4209-a6cc-cb7a10d71ce3, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:24,649 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, db62bdb9-f52c-4209-a6cc-cb7a10d71ce3, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:24,650 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, db62bdb9-f52c-4209-a6cc-cb7a10d71ce3, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:25,126 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:25,127 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:25,127 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b4d4244b-fc14-446d-a153-55bb934764fb, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:25,128 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b4d4244b-fc14-446d-a153-55bb934764fb, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:25,129 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b4d4244b-fc14-446d-a153-55bb934764fb, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:25,820 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:25,821 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 512498, 'Portions': 305}}, blobs: {'__DEFAULT': {'Portions': 297, 'BlobSize': 8095736, 'BlobCount': 624}}
2025-10-16 17:18:25,822 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:25,823 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, bee8eaba-ed3d-46a8-a8c6-7cc93c46d9bb, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:25,824 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, bee8eaba-ed3d-46a8-a8c6-7cc93c46d9bb, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:25,826 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, bee8eaba-ed3d-46a8-a8c6-7cc93c46d9bb, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:27,030 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:27,031 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:27,032 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0a1e0e59-5df0-402b-b2d8-070e3a21287d, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:27,033 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0a1e0e59-5df0-402b-b2d8-070e3a21287d, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:27,035 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0a1e0e59-5df0-402b-b2d8-070e3a21287d, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:27,278 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:27,279 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:27,280 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 03af4186-acbc-4d08-832e-8885123ede95, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:27,281 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 03af4186-acbc-4d08-832e-8885123ede95, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:27,288 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 03af4186-acbc-4d08-832e-8885123ede95, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:28,337 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:28,338 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 357}}, blobs: {'__DEFAULT': {'Portions': 357, 'BlobSize': 9713968, 'BlobCount': 746}}
2025-10-16 17:18:28,339 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:28,339 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c4d49b1f-1270-4d7c-bfc4-9f31da98e9a2, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:28,341 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c4d49b1f-1270-4d7c-bfc4-9f31da98e9a2, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:28,343 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c4d49b1f-1270-4d7c-bfc4-9f31da98e9a2, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:29,561 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:29,561 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:29,562 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5aa3d3c6-2ed4-404c-bbc6-1fcf7010633c, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:29,563 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5aa3d3c6-2ed4-404c-bbc6-1fcf7010633c, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:29,567 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5aa3d3c6-2ed4-404c-bbc6-1fcf7010633c, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:29,892 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:29,893 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:29,894 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 587f0520-674e-4ff4-9ef5-b279a2982219, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:29,895 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 587f0520-674e-4ff4-9ef5-b279a2982219, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:29,897 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 587f0520-674e-4ff4-9ef5-b279a2982219, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:30,669 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:30,670 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 709294, 'Portions': 407}}, blobs: {'__DEFAULT': {'Portions': 401, 'BlobSize': 11331032, 'BlobCount': 842}}
2025-10-16 17:18:30,671 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:30,672 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b1c387cb-65b1-43bb-a03d-b388d17b526f, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:30,673 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b1c387cb-65b1-43bb-a03d-b388d17b526f, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:30,675 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b1c387cb-65b1-43bb-a03d-b388d17b526f, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:31,721 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:31,722 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:31,723 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0e3be42f-28fd-40f3-967e-d38bed90a08e, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:31,724 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0e3be42f-28fd-40f3-967e-d38bed90a08e, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:31,726 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0e3be42f-28fd-40f3-967e-d38bed90a08e, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:32,089 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:32,090 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:32,090 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, cabc0705-7769-4776-b55d-397d00fe6324, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:32,091 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, cabc0705-7769-4776-b55d-397d00fe6324, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:32,094 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, cabc0705-7769-4776-b55d-397d00fe6324, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:32,897 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:32,897 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 465}}, blobs: {'__DEFAULT': {'Portions': 465, 'BlobSize': 12949464, 'BlobCount': 970}}
2025-10-16 17:18:32,898 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:32,899 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4afe2ed4-c022-4822-bdc0-53e34d98d0a0, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:32,900 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4afe2ed4-c022-4822-bdc0-53e34d98d0a0, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:32,901 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4afe2ed4-c022-4822-bdc0-53e34d98d0a0, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:34,282 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:34,282 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:34,283 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c54608d3-6747-4591-9d91-f33a2b841cb8, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:34,284 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c54608d3-6747-4591-9d91-f33a2b841cb8, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:34,285 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c54608d3-6747-4591-9d91-f33a2b841cb8, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:34,561 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:34,561 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:34,562 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 628189f3-868c-4146-91b4-a7c03a0f5b3b, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:34,563 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 628189f3-868c-4146-91b4-a7c03a0f5b3b, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:34,569 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 628189f3-868c-4146-91b4-a7c03a0f5b3b, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:35,273 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:35,274 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 912387, 'Portions': 523}}, blobs: {'__DEFAULT': {'Portions': 508, 'BlobSize': 14565816, 'BlobCount': 1062}}
2025-10-16 17:18:35,275 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:35,275 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6fee7794-feb4-4725-b135-8ea8c5d7c49f, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:35,285 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6fee7794-feb4-4725-b135-8ea8c5d7c49f, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:35,287 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6fee7794-feb4-4725-b135-8ea8c5d7c49f, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:36,648 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:36,648 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:36,649 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0a1873f5-4bf2-403e-b7fa-e525c5a2b743, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:36,650 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0a1873f5-4bf2-403e-b7fa-e525c5a2b743, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:36,659 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0a1873f5-4bf2-403e-b7fa-e525c5a2b743, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:37,050 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:37,050 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:37,051 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, cf929d2e-c82e-4888-a89b-e33a89631d48, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:37,052 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, cf929d2e-c82e-4888-a89b-e33a89631d48, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:37,054 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, cf929d2e-c82e-4888-a89b-e33a89631d48, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:37,803 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:37,804 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 1013852, 'Portions': 565}}, blobs: {'__DEFAULT': {'Portions': 548, 'BlobSize': 16181664, 'BlobCount': 1148}}
2025-10-16 17:18:37,804 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:37,805 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 09033b4a-2ee6-4dbc-8ea2-8f81f59b3bf0, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:37,805 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 09033b4a-2ee6-4dbc-8ea2-8f81f59b3bf0, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:37,807 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 09033b4a-2ee6-4dbc-8ea2-8f81f59b3bf0, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:39,178 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:39,179 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:39,180 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, bc8955ab-738a-4db1-981f-e652166a249c, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:39,181 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, bc8955ab-738a-4db1-981f-e652166a249c, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:39,187 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, bc8955ab-738a-4db1-981f-e652166a249c, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:39,514 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:39,515 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:39,516 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 21a5eeff-1d2c-4555-b5c8-9f051cc0e2da, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:39,517 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 21a5eeff-1d2c-4555-b5c8-9f051cc0e2da, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:39,518 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 21a5eeff-1d2c-4555-b5c8-9f051cc0e2da, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:39,876 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:39,877 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:39,878 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1faa9301-7d50-40d1-9b20-35fbb2d996e5, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:39,879 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1faa9301-7d50-40d1-9b20-35fbb2d996e5, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:39,881 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1faa9301-7d50-40d1-9b20-35fbb2d996e5, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:44,466 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:54,532 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:54,533 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 77f16b03-f36c-4fc2-a22a-4f67a809783f, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:54,534 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 77f16b03-f36c-4fc2-a22a-4f67a809783f, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:54,536 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 77f16b03-f36c-4fc2-a22a-4f67a809783f, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:58,988 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:59,043 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8078912)
2025-10-16 17:18:59,043 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:18:59,044 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7a1bc886-24c2-42f9-bfe3-74043330979f, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:18:59,045 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7a1bc886-24c2-42f9-bfe3-74043330979f, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:18:59,046 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7a1bc886-24c2-42f9-bfe3-74043330979f, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:19:04,160 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:19:14,207 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:19:14,209 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5656980f-776c-4bc4-9a47-234c9510010f, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:19:14,210 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5656980f-776c-4bc4-9a47-234c9510010f, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:19:14,215 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5656980f-776c-4bc4-9a47-234c9510010f, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:19:17,938 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:19:27,965 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:19:27,966 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 43ee73d5-43cf-4522-88a1-0cd4b169d29f, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:19:27,966 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 43ee73d5-43cf-4522-88a1-0cd4b169d29f, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:19:27,968 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 43ee73d5-43cf-4522-88a1-0cd4b169d29f, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:19:29,783 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:19:39,804 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:19:39,805 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a6402a0b-ceeb-4623-9c28-c0382b1de841, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:19:39,806 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a6402a0b-ceeb-4623-9c28-c0382b1de841, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:19:39,807 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a6402a0b-ceeb-4623-9c28-c0382b1de841, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:19:42,253 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:19:42,268 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8030960)
2025-10-16 17:19:42,269 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:19:42,269 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0429d4c2-0f55-44ca-a498-5923f0523239, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:19:42,270 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0429d4c2-0f55-44ca-a498-5923f0523239, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:19:42,272 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0429d4c2-0f55-44ca-a498-5923f0523239, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:19:42,641 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:19:42,653 - INFO - ya.test - 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-10-16 17:19:42,654 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:19:42,655 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, dc093027-0585-4121-93f0-3f6592d9b1d3, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:19:42,656 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, dc093027-0585-4121-93f0-3f6592d9b1d3, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:19:42,672 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, dc093027-0585-4121-93f0-3f6592d9b1d3, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:19:47,749 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:19:47,749 - INFO - __tests__.alter_compression - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_6_compression created
2025-10-16 17:19:47,750 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:19:47,750 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 74f62836-1837-4aa9-9cc3-002efc7adfcc, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:19:47,751 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 74f62836-1837-4aa9-9cc3-002efc7adfcc, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:19:47,753 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 74f62836-1837-4aa9-9cc3-002efc7adfcc, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:19:48,590 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-16 17:19:48,590 - DEBUG - ydb.connection - 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-10-16 17:19:48,614 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-10-16 17:19:48,614 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 695fb4c8-e896-403c-8a18-c1118105569e, localhost:17459): creating call state
2025-10-16 17:19:48,615 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 695fb4c8-e896-403c-8a18-c1118105569e, localhost:17459): request = { database: "/Root" }
2025-10-16 17:19:48,622 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 695fb4c8-e896-403c-8a18-c1118105569e, localhost:17459): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-2kszfvc6cm.auto.internal" port: 17459 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-10-16 17:19:48,623 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-2kszfvc6cm.auto.internal:17459, location 1, ssl: False>]>
2025-10-16 17:19:48,624 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:17459
2025-10-16 17:19:49,042 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:19:49,043 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:19:49,043 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 818daff0-f18e-4504-84c4-293245f0fda6, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:19:49,044 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 818daff0-f18e-4504-84c4-293245f0fda6, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:19:49,047 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 818daff0-f18e-4504-84c4-293245f0fda6, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:19:51,058 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:19:51,059 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:19:51,059 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a903a94b-16fc-4ed1-9314-c84ac317b8f4, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:19:51,060 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a903a94b-16fc-4ed1-9314-c84ac317b8f4, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:19:51,062 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a903a94b-16fc-4ed1-9314-c84ac317b8f4, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:19:52,339 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:19:52,340 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:19:52,341 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 23abc66a-5bc2-402f-a701-2d2cc609b2cc, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:19:52,342 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 23abc66a-5bc2-402f-a701-2d2cc609b2cc, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:19:52,345 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 23abc66a-5bc2-402f-a701-2d2cc609b2cc, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:19:54,544 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:19:54,546 - INFO - __tests__.alter_compression - 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-10-16 17:19:54,546 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:19:54,547 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ce8b865e-0512-46ef-8957-c83c7f8589bb, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:19:54,549 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ce8b865e-0512-46ef-8957-c83c7f8589bb, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:19:54,550 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ce8b865e-0512-46ef-8957-c83c7f8589bb, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:19:56,347 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:19:56,348 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:19:56,348 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ff941e54-a113-429a-837e-1c0978caf594, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:19:56,349 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ff941e54-a113-429a-837e-1c0978caf594, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:19:56,351 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ff941e54-a113-429a-837e-1c0978caf594, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:19:56,799 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:19:56,800 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:19:56,801 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2b5ce1ab-9d78-4d36-b684-8114101ef3d3, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:19:56,802 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2b5ce1ab-9d78-4d36-b684-8114101ef3d3, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:19:56,803 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2b5ce1ab-9d78-4d36-b684-8114101ef3d3, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:19:57,283 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:19:57,284 - INFO - __tests__.alter_compression - 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-10-16 17:19:57,285 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:19:57,285 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 590e1bf2-dea9-4a9f-8cae-4e6cca6767ac, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:19:57,286 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 590e1bf2-dea9-4a9f-8cae-4e6cca6767ac, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:19:57,290 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 590e1bf2-dea9-4a9f-8cae-4e6cca6767ac, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:19:59,273 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:19:59,274 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:19:59,274 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e310ebb8-cee3-47f1-a5f9-bd958646a3d0, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:19:59,275 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e310ebb8-cee3-47f1-a5f9-bd958646a3d0, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:19:59,277 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e310ebb8-cee3-47f1-a5f9-bd958646a3d0, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:19:59,806 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:19:59,807 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:19:59,807 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 01e599e9-4174-4380-8e16-46c40ca866f3, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:19:59,808 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 01e599e9-4174-4380-8e16-46c40ca866f3, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:19:59,810 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 01e599e9-4174-4380-8e16-46c40ca866f3, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:20:00,617 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:00,619 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 184}}, blobs: {'__DEFAULT': {'Portions': 184, 'BlobSize': 957792, 'BlobCount': 384}}
2025-10-16 17:20:00,619 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:00,620 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 90f8db7d-b411-4101-88fc-d0d40e550552, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:20:00,623 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 90f8db7d-b411-4101-88fc-d0d40e550552, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:20:00,625 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 90f8db7d-b411-4101-88fc-d0d40e550552, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:20:02,790 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:02,791 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:02,792 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 066ee093-2e08-41c7-bb2f-fa60b72f3622, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:20:02,793 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 066ee093-2e08-41c7-bb2f-fa60b72f3622, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:20:02,797 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 066ee093-2e08-41c7-bb2f-fa60b72f3622, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:20:03,141 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:03,142 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:03,143 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0061af85-0829-4b1b-aa63-3c957ab50671, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:20:03,144 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0061af85-0829-4b1b-aa63-3c957ab50671, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:20:03,162 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0061af85-0829-4b1b-aa63-3c957ab50671, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:20:03,766 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:03,767 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 404685, 'Portions': 243}}, blobs: {'__DEFAULT': {'Portions': 240, 'BlobSize': 1276512, 'BlobCount': 504}}
2025-10-16 17:20:03,768 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:03,768 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 39c91e0c-99c0-434a-9b29-3be81597681d, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:20:03,769 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 39c91e0c-99c0-434a-9b29-3be81597681d, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:20:03,777 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 39c91e0c-99c0-434a-9b29-3be81597681d, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:20:05,395 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:05,396 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:05,397 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 66dbefd0-f33f-4c66-8e7e-9c2adf07c047, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:20:05,398 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 66dbefd0-f33f-4c66-8e7e-9c2adf07c047, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:20:05,400 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 66dbefd0-f33f-4c66-8e7e-9c2adf07c047, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:20:05,753 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:05,755 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:05,755 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b784bc24-2120-4bcd-9d13-4968cdb9d63e, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:20:05,757 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b784bc24-2120-4bcd-9d13-4968cdb9d63e, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:20:05,758 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b784bc24-2120-4bcd-9d13-4968cdb9d63e, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:20:06,482 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:06,483 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 298}}, blobs: {'__DEFAULT': {'Portions': 298, 'BlobSize': 1594480, 'BlobCount': 624}}
2025-10-16 17:20:06,483 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:06,484 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, bf0288f9-218e-4386-a462-81d93aee093e, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:20:06,486 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, bf0288f9-218e-4386-a462-81d93aee093e, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:20:06,490 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, bf0288f9-218e-4386-a462-81d93aee093e, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:20:08,238 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:08,239 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:08,240 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b27e250e-5950-4d21-981f-ad77a6f54431, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:20:08,241 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b27e250e-5950-4d21-981f-ad77a6f54431, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:20:08,249 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b27e250e-5950-4d21-981f-ad77a6f54431, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:20:08,675 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:08,676 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:08,676 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ed4285d2-25cd-4fe1-a3a3-497c077416cd, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:20:08,677 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ed4285d2-25cd-4fe1-a3a3-497c077416cd, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:20:08,679 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ed4285d2-25cd-4fe1-a3a3-497c077416cd, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:20:09,611 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:09,611 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 354}}, blobs: {'__DEFAULT': {'Portions': 354, 'BlobSize': 1912016, 'BlobCount': 740}}
2025-10-16 17:20:09,612 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:09,613 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2cd06cd2-3736-44bb-b62d-a67eab5216dc, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:20:09,614 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2cd06cd2-3736-44bb-b62d-a67eab5216dc, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:20:09,617 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2cd06cd2-3736-44bb-b62d-a67eab5216dc, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:20:11,306 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:11,307 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:11,308 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, fa72f1f9-ea7c-43a3-99a3-fa4f1e10af80, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:20:11,308 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, fa72f1f9-ea7c-43a3-99a3-fa4f1e10af80, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:20:11,310 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, fa72f1f9-ea7c-43a3-99a3-fa4f1e10af80, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:20:12,188 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:12,189 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:12,190 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e56e72b6-18c9-4fb0-81aa-22c4296ff66d, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:20:12,191 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e56e72b6-18c9-4fb0-81aa-22c4296ff66d, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:20:12,193 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e56e72b6-18c9-4fb0-81aa-22c4296ff66d, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:20:13,201 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:13,202 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 413}}, blobs: {'__DEFAULT': {'Portions': 413, 'BlobSize': 2230024, 'BlobCount': 860}}
2025-10-16 17:20:13,203 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:13,204 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 404e2bbe-06c1-47e4-9719-986717d99abe, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:20:13,205 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 404e2bbe-06c1-47e4-9719-986717d99abe, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:20:13,207 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 404e2bbe-06c1-47e4-9719-986717d99abe, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:20:15,192 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:15,193 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:15,194 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e712ddf3-ebb3-4308-964e-cfd2ac6b5666, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:20:15,201 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e712ddf3-ebb3-4308-964e-cfd2ac6b5666, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:20:15,209 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e712ddf3-ebb3-4308-964e-cfd2ac6b5666, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:20:15,873 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:15,874 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:15,875 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, fdf5de41-e07b-4b30-80fd-4f649f6fad9b, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:20:15,876 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, fdf5de41-e07b-4b30-80fd-4f649f6fad9b, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:20:15,878 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, fdf5de41-e07b-4b30-80fd-4f649f6fad9b, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:20:17,217 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:17,218 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 477}}, blobs: {'__DEFAULT': {'Portions': 477, 'BlobSize': 2549512, 'BlobCount': 988}}
2025-10-16 17:20:17,219 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:17,219 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 633a8109-8d30-413f-aa7d-b67a4123ed56, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:20:17,225 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 633a8109-8d30-413f-aa7d-b67a4123ed56, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:20:17,227 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 633a8109-8d30-413f-aa7d-b67a4123ed56, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:20:19,171 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:19,172 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:19,173 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8464da9a-6ad0-4c19-b8b3-fea56ec9c222, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:20:19,174 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8464da9a-6ad0-4c19-b8b3-fea56ec9c222, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:20:19,176 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8464da9a-6ad0-4c19-b8b3-fea56ec9c222, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:20:19,734 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:19,735 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:19,736 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d0d9f321-083e-4e5a-bd5b-bc75219810b4, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:20:19,738 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d0d9f321-083e-4e5a-bd5b-bc75219810b4, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:20:19,739 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d0d9f321-083e-4e5a-bd5b-bc75219810b4, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:20:20,914 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:20,915 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 912491, 'Portions': 490}}, blobs: {'__DEFAULT': {'Portions': 469, 'BlobSize': 2888040, 'BlobCount': 996}}
2025-10-16 17:20:20,916 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:20,917 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, fccf3b8b-9fcb-43f9-b0d6-c1d13fdda3f4, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:20:20,918 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, fccf3b8b-9fcb-43f9-b0d6-c1d13fdda3f4, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:20:20,920 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, fccf3b8b-9fcb-43f9-b0d6-c1d13fdda3f4, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:20:22,751 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:22,752 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:22,753 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a8530090-5dfe-431e-89ea-6b6980d83860, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:20:22,754 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a8530090-5dfe-431e-89ea-6b6980d83860, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:20:22,764 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a8530090-5dfe-431e-89ea-6b6980d83860, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:20:23,172 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:23,173 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:23,173 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5c292d18-fba5-4327-9072-7e410b650b37, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:20:23,174 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5c292d18-fba5-4327-9072-7e410b650b37, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:20:23,175 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5c292d18-fba5-4327-9072-7e410b650b37, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:20:23,900 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:23,901 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 488}}, blobs: {'__DEFAULT': {'Portions': 488, 'BlobSize': 3158016, 'BlobCount': 1044}}
2025-10-16 17:20:23,902 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:23,903 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 85732574-9fb0-4eb8-99c7-2cd4de7bb583, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:20:23,904 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 85732574-9fb0-4eb8-99c7-2cd4de7bb583, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:20:23,906 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 85732574-9fb0-4eb8-99c7-2cd4de7bb583, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:20:25,629 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:25,629 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:25,630 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b2638df0-1a4c-4030-9e8b-f11e5a4c1e3e, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:20:25,632 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b2638df0-1a4c-4030-9e8b-f11e5a4c1e3e, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:20:25,634 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b2638df0-1a4c-4030-9e8b-f11e5a4c1e3e, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:20:26,006 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:26,007 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:26,008 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f035f357-49de-4a23-a826-80617c37f58f, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:20:26,009 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f035f357-49de-4a23-a826-80617c37f58f, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:20:26,011 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f035f357-49de-4a23-a826-80617c37f58f, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:20:26,530 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:26,532 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:26,536 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ca7528c1-69b5-4201-a16c-5499e5857d0e, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:20:26,537 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ca7528c1-69b5-4201-a16c-5499e5857d0e, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:20:26,539 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ca7528c1-69b5-4201-a16c-5499e5857d0e, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:20:31,005 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:41,039 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:41,040 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1b0bb2ae-4ee0-49d9-8418-48a862966541, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:20:41,041 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1b0bb2ae-4ee0-49d9-8418-48a862966541, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:20:41,042 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1b0bb2ae-4ee0-49d9-8418-48a862966541, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:20:45,327 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:45,400 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_6_compression`, volumes `value` (8000000, 1561512)
2025-10-16 17:20:45,401 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:45,402 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8c7fd0af-5514-40ae-a482-dc1f9fd96608, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:20:45,403 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8c7fd0af-5514-40ae-a482-dc1f9fd96608, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:20:45,406 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8c7fd0af-5514-40ae-a482-dc1f9fd96608, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:20:45,842 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:45,843 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:45,843 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8dfa83ee-7e2b-4481-a88d-f1cf257679ba, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:20:45,844 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8dfa83ee-7e2b-4481-a88d-f1cf257679ba, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:20:45,845 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8dfa83ee-7e2b-4481-a88d-f1cf257679ba, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:20:49,854 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:59,888 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:20:59,890 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6b8de03a-ad0f-490e-bbc1-00ae7d9c1670, ghrun-2kszfvc6cm.auto.internal:17459): creating call state
2025-10-16 17:20:59,891 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6b8de03a-ad0f-490e-bbc1-00ae7d9c1670, ghrun-2kszfvc6cm.auto.internal:17459): request = { session_id: "ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=" 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-10-16 17:20:59,892 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6b8de03a-ad0f-490e-bbc1-00ae7d9c1670, ghrun-2kszfvc6cm.auto.internal:17459): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:21:01,929 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDFiNGIzNGMtYjdiZWJiOWMtYzQyOTI5NzUtOTgzMTNhMDc=
2025-10-16 17:21:01,946 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_6_compression`, volumes `value` (8000000, 1504904)
2025-10-16 17:21:01,947 - INFO - root - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_6_compression` 8078912 / 1504904: 5.368390276057476
2025-10-16 17:21:01,949 - INFO - ya.test - pytest_runtest_teardown: Test teardown
