2025-12-23 15:36:51,213 - INFO - ya.test.668434  - pytest_runtest_setup: ####################################################################################################
2025-12-23 15:36:51,214 - INFO - ya.test.668434  - pytest_runtest_setup: test_all_supported_compression[lz4_compression-COMPRESSION = "lz4"]
2025-12-23 15:36:51,214 - INFO - ya.test.668434  - pytest_runtest_setup: ####################################################################################################
2025-12-23 15:36:51,214 - INFO - ya.test.668434  - pytest_runtest_setup: Test setup
2025-12-23 15:36:51,217 - DEBUG - ya.test.668434  - _get_command_output_file: Command out will be placed to ydbd.out
2025-12-23 15:36:51,218 - DEBUG - ya.test.668434  - _get_command_output_file: Command err will be placed to ydbd.err
2025-12-23 15:36:51,218 - DEBUG - ya.test.668434  - execute: Executing '['/home/runner/.ya/build/build_root/wyw9/0021a4/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-12-23 15:36:51,224 - DEBUG - ya.test.668434  - execute: Command pid: 673165
2025-12-23 15:36:52,248 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673165) rc: 0
2025-12-23 15:36:52,250 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673165) elapsed time (sec): 1.0228147506713867
2025-12-23 15:36:52,250 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673165) idrss: 0
2025-12-23 15:36:52,250 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673165) inblock: 0
2025-12-23 15:36:52,251 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673165) isrss: 0
2025-12-23 15:36:52,251 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673165) ixrss: 0
2025-12-23 15:36:52,251 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673165) majflt: 0
2025-12-23 15:36:52,251 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673165) maxrss: 495296
2025-12-23 15:36:52,252 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673165) minflt: 45846
2025-12-23 15:36:52,252 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673165) msgrcv: 0
2025-12-23 15:36:52,252 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673165) msgsnd: 0
2025-12-23 15:36:52,253 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673165) nivcsw: 176
2025-12-23 15:36:52,253 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673165) nsignals: 0
2025-12-23 15:36:52,254 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673165) nswap: 0
2025-12-23 15:36:52,254 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673165) nvcsw: 14
2025-12-23 15:36:52,255 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673165) oublock: 8
2025-12-23 15:36:52,255 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673165) stime: 0.19141
2025-12-23 15:36:52,255 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673165) utime: 0.51322
2025-12-23 15:36:52,256 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673165) wtime: 1.03
2025-12-23 15:36:52,256 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673165) output:
Git info:
    Commit: abc2d1f3c1b023db8ecb13b079f91fe24aeb8bee
    Branch: 
    Author: Alek5andr-Kotov <akotov@ydb.tech>
    Summary: Merge 8cd317bbcadd236db71e9829f8fc42e5bf5c2d0b into 54d3846fcfd20f009eeeabbfe05c19f647cd92d0
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-icmf7pzugu    Host information: 
        Linux ghrun-icmf7pzugu 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/10492077879/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/10492077879/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-12-23 15:36:52,257 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673165) errors:

2025-12-23 15:36:52,257 - INFO - __tests__.base.668434  - _setup_ydb: Git info:
    Commit: abc2d1f3c1b023db8ecb13b079f91fe24aeb8bee
    Branch: 
    Author: Alek5andr-Kotov <akotov@ydb.tech>
    Summary: Merge 8cd317bbcadd236db71e9829f8fc42e5bf5c2d0b into 54d3846fcfd20f009eeeabbfe05c19f647cd92d0
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-icmf7pzugu    Host information: 
        Linux ghrun-icmf7pzugu 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/10492077879/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/10492077879/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-12-23 15:36:52,388 - DEBUG - ya.test.668434  - get_binary: Binary was found by /home/runner/.ya/build/build_root/wyw9/0021a4/ydb/apps/ydbd/ydbd
2025-12-23 15:36:52,389 - DEBUG - library.python.filelock.668434  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/24455
2025-12-23 15:36:52,391 - DEBUG - ydb.tests.library.harness.kikimr_runner.668434  - start: Working directory: /home/runner/.ya/build/build_root/wyw9/0021a4/r3tmp/kikimr_cluster_go_1cg8k
2025-12-23 15:36:52,430 - DEBUG - ya.test.668434  - get_binary: Binary was found by /home/runner/.ya/build/build_root/wyw9/0021a4/ydb/apps/ydbd/ydbd
2025-12-23 15:36:52,431 - DEBUG - library.python.filelock.668434  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/4073
2025-12-23 15:36:52,432 - DEBUG - library.python.filelock.668434  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/62269
2025-12-23 15:36:52,433 - DEBUG - library.python.filelock.668434  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/14882
2025-12-23 15:36:52,433 - DEBUG - library.python.filelock.668434  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/27857
2025-12-23 15:36:52,434 - INFO - ydb.tests.library.harness.kikimr_runner.668434  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/wyw9/0021a4/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk0/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.lz4_compression-COMPRESSION.=.lz4/cluster/kikimr_configs"
2025-12-23 15:36:52,435 - INFO - ydb.tests.library.harness.kikimr_runner.668434  - __make_run_command: Final command: /home/runner/.ya/build/build_root/wyw9/0021a4/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/wyw9/0021a4/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk0/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.lz4_compression-COMPRESSION.=.lz4/cluster/node_1/logfile_nn4tm9dm.log --grpc-port=4073 --mon-port=62269 --ic-port=24455
2025-12-23 15:36:52,435 - DEBUG - ydb.tests.library.harness.kikimr_runner.668434  - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:4073/1, disk_size 68719476736
2025-12-23 15:36:52,437 - INFO - ydb.tests.library.harness.kikimr_runner.668434  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/wyw9/0021a4/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk0/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.lz4_compression-COMPRESSION.=.lz4/cluster/kikimr_configs"
2025-12-23 15:36:52,438 - INFO - ydb.tests.library.harness.kikimr_runner.668434  - __make_run_command: Final command: /home/runner/.ya/build/build_root/wyw9/0021a4/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/wyw9/0021a4/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk0/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.lz4_compression-COMPRESSION.=.lz4/cluster/node_1/logfile_nn4tm9dm.log --grpc-port=4073 --mon-port=62269 --ic-port=24455
2025-12-23 15:36:52,439 - DEBUG - ya.test.668434  - execute: Executing '('/home/runner/.ya/build/build_root/wyw9/0021a4/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/wyw9/0021a4/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk0/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.lz4_compression-COMPRESSION.=.lz4/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/wyw9/0021a4/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk0/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.lz4_compression-COMPRESSION.=.lz4/cluster/node_1/logfile_nn4tm9dm.log', '--grpc-port=4073', '--mon-port=62269', '--ic-port=24455')' in '/home/runner/.ya/build/build_root/wyw9/0021a4/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk0/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.lz4_compression-COMPRESSION.=.lz4/cluster/node_1' (no wait)
2025-12-23 15:36:52,442 - DEBUG - ya.test.668434  - execute: Command pid: 673635
2025-12-23 15:36:52,443 - INFO - ydb.tests.library.harness.kikimr_runner.668434  - start: Started node localhost:4073/1
2025-12-23 15:36:52,444 - DEBUG - ya.test.668434  - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-12-23 15:36:52,445 - DEBUG - ya.test.668434  - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-12-23 15:36:52,445 - DEBUG - ya.test.668434  - execute: Executing '['/home/runner/.ya/build/build_root/wyw9/0021a4/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-12-23 15:36:52,447 - DEBUG - ya.test.668434  - execute: Command pid: 673636
2025-12-23 15:36:53,326 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673636) rc: 0
2025-12-23 15:36:53,326 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673636) elapsed time (sec): 0.8780865669250488
2025-12-23 15:36:53,327 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673636) idrss: 0
2025-12-23 15:36:53,327 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673636) inblock: 0
2025-12-23 15:36:53,327 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673636) isrss: 0
2025-12-23 15:36:53,328 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673636) ixrss: 0
2025-12-23 15:36:53,328 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673636) majflt: 0
2025-12-23 15:36:53,328 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673636) maxrss: 504060
2025-12-23 15:36:53,329 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673636) minflt: 45765
2025-12-23 15:36:53,329 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673636) msgrcv: 0
2025-12-23 15:36:53,342 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673636) msgsnd: 0
2025-12-23 15:36:53,343 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673636) nivcsw: 183
2025-12-23 15:36:53,343 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673636) nsignals: 0
2025-12-23 15:36:53,343 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673636) nswap: 0
2025-12-23 15:36:53,343 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673636) nvcsw: 14
2025-12-23 15:36:53,344 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673636) oublock: 8
2025-12-23 15:36:53,344 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673636) stime: 0.206109
2025-12-23 15:36:53,345 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673636) utime: 0.527134
2025-12-23 15:36:53,345 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673636) wtime: 0.88
2025-12-23 15:36:53,345 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673636) output:
Git info:
    Commit: abc2d1f3c1b023db8ecb13b079f91fe24aeb8bee
    Branch: 
    Author: Alek5andr-Kotov <akotov@ydb.tech>
    Summary: Merge 8cd317bbcadd236db71e9829f8fc42e5bf5c2d0b into 54d3846fcfd20f009eeeabbfe05c19f647cd92d0
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-icmf7pzugu    Host information: 
        Linux ghrun-icmf7pzugu 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/10492077879/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/10492077879/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-12-23 15:36:53,346 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 673636) errors:

2025-12-23 15:36:53,346 - INFO - ydb.tests.library.harness.kikimr_runner.668434  - start: Node 1 version:
Git info:
    Commit: abc2d1f3c1b023db8ecb13b079f91fe24aeb8bee
    Branch: 
    Author: Alek5andr-Kotov <akotov@ydb.tech>
    Summary: Merge 8cd317bbcadd236db71e9829f8fc42e5bf5c2d0b into 54d3846fcfd20f009eeeabbfe05c19f647cd92d0
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-icmf7pzugu    Host information: 
        Linux ghrun-icmf7pzugu 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64
2025-12-23 15:36:58,384 - DEBUG - ya.test.668434  - get_binary: Binary was found by /home/runner/.ya/build/build_root/wyw9/0021a4/ydb/apps/ydbd/ydbd
2025-12-23 15:36:58,385 - DEBUG - ydb.tests.library.harness.kikimr_runner.668434  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/wyw9/0021a4/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:4073', '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: 24455\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-12-23 15:36:58,386 - DEBUG - ya.test.668434  - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-12-23 15:36:58,387 - DEBUG - ya.test.668434  - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-12-23 15:36:58,387 - DEBUG - ya.test.668434  - execute: Executing '['/home/runner/.ya/build/build_root/wyw9/0021a4/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:4073', '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: 24455\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-12-23 15:36:58,389 - DEBUG - ya.test.668434  - execute: Command pid: 677920
2025-12-23 15:36:59,263 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 677920) rc: 0
2025-12-23 15:36:59,263 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 677920) elapsed time (sec): 0.8731122016906738
2025-12-23 15:36:59,264 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 677920) idrss: 0
2025-12-23 15:36:59,264 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 677920) inblock: 0
2025-12-23 15:36:59,264 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 677920) isrss: 0
2025-12-23 15:36:59,264 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 677920) ixrss: 0
2025-12-23 15:36:59,265 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 677920) majflt: 0
2025-12-23 15:36:59,265 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 677920) maxrss: 606536
2025-12-23 15:36:59,265 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 677920) minflt: 52178
2025-12-23 15:36:59,265 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 677920) msgrcv: 0
2025-12-23 15:36:59,266 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 677920) msgsnd: 0
2025-12-23 15:36:59,266 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 677920) nivcsw: 157
2025-12-23 15:36:59,266 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 677920) nsignals: 0
2025-12-23 15:36:59,266 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 677920) nswap: 0
2025-12-23 15:36:59,267 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 677920) nvcsw: 852
2025-12-23 15:36:59,267 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 677920) oublock: 8
2025-12-23 15:36:59,267 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 677920) stime: 0.28488399999999997
2025-12-23 15:36:59,267 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 677920) utime: 0.5211
2025-12-23 15:36:59,268 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 677920) wtime: 0.875
2025-12-23 15:36:59,268 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 677920) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-12-23 15:36:59,268 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 677920) errors:

2025-12-23 15:36:59,270 - DEBUG - ya.test.668434  - get_binary: Binary was found by /home/runner/.ya/build/build_root/wyw9/0021a4/ydb/apps/ydbd/ydbd
2025-12-23 15:36:59,270 - DEBUG - ydb.tests.library.harness.kikimr_runner.668434  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/wyw9/0021a4/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:4073', '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-12-23 15:36:59,272 - DEBUG - ya.test.668434  - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-12-23 15:36:59,272 - DEBUG - ya.test.668434  - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-12-23 15:36:59,273 - DEBUG - ya.test.668434  - execute: Executing '['/home/runner/.ya/build/build_root/wyw9/0021a4/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:4073', '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-12-23 15:36:59,274 - DEBUG - ya.test.668434  - execute: Command pid: 678480
2025-12-23 15:37:00,138 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 678480) rc: 0
2025-12-23 15:37:00,139 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 678480) elapsed time (sec): 0.8627316951751709
2025-12-23 15:37:00,139 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 678480) idrss: 0
2025-12-23 15:37:00,139 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 678480) inblock: 0
2025-12-23 15:37:00,139 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 678480) isrss: 0
2025-12-23 15:37:00,140 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 678480) ixrss: 0
2025-12-23 15:37:00,140 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 678480) majflt: 0
2025-12-23 15:37:00,140 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 678480) maxrss: 606536
2025-12-23 15:37:00,141 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 678480) minflt: 52267
2025-12-23 15:37:00,141 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 678480) msgrcv: 0
2025-12-23 15:37:00,141 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 678480) msgsnd: 0
2025-12-23 15:37:00,141 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 678480) nivcsw: 152
2025-12-23 15:37:00,142 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 678480) nsignals: 0
2025-12-23 15:37:00,142 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 678480) nswap: 0
2025-12-23 15:37:00,142 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 678480) nvcsw: 691
2025-12-23 15:37:00,142 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 678480) oublock: 8
2025-12-23 15:37:00,143 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 678480) stime: 0.27397499999999997
2025-12-23 15:37:00,143 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 678480) utime: 0.477095
2025-12-23 15:37:00,143 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 678480) wtime: 0.864
2025-12-23 15:37:00,144 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 678480) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-12-23 15:37:00,145 - DEBUG - ya.test.668434  - _save_outputs: Command (pid 678480) errors:

2025-12-23 15:37:00,145 - INFO - ydb.tests.library.harness.kikimr_runner.668434  - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-12-23 15:37:00,269 - INFO - ydb.tests.library.harness.kikimr_runner.668434  - __run: Cluster started and initialized
2025-12-23 15:37:00,307 - DEBUG - ydb.connection.668434  - 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', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-23 15:37:00,311 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.668434  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-23 15:37:00,314 - DEBUG - ydb.connection.668434  - 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', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-23 15:37:00,330 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.668434  - context_resolve: Resolving endpoints for database /Root
2025-12-23 15:37:00,331 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ListEndpoints, 0092023e-546f-4fda-8bb5-647e0bdc5d66, localhost:4073): creating call state
2025-12-23 15:37:00,331 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ListEndpoints, 0092023e-546f-4fda-8bb5-647e0bdc5d66, localhost:4073): request = { database: "/Root" }
2025-12-23 15:37:00,339 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ListEndpoints, 0092023e-546f-4fda-8bb5-647e0bdc5d66, localhost:4073): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-icmf7pzugu.auto.internal" port: 4073 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-12-23 15:37:00,340 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.668434  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-icmf7pzugu.auto.internal:4073, location 1, ssl: False>]>
2025-12-23 15:37:00,342 - DEBUG - ydb.connection.668434  - 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', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-23 15:37:00,357 - DEBUG - ydb.connection.668434  - close: Closing channel for endpoint localhost:4073
2025-12-23 15:37:00,358 - DEBUG - ydb.query.pool.668434  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-23 15:37:00,367 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(CreateSession, 5f7ca61e-72e7-4ecd-bf63-5517da15d1f5, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:00,368 - DEBUG - ydb.connection.668434  - _log_request: RpcState(CreateSession, 5f7ca61e-72e7-4ecd-bf63-5517da15d1f5, ghrun-icmf7pzugu.auto.internal:4073): request = {  }
2025-12-23 15:37:00,377 - DEBUG - ydb.connection.668434  - _log_response: RpcState(CreateSession, 5f7ca61e-72e7-4ecd-bf63-5517da15d1f5, ghrun-icmf7pzugu.auto.internal:4073): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" node_id: 1 }
2025-12-23 15:37:00,378 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(AttachSession, c8f3451c-d128-48f5-8a43-98421f5b3db0, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:00,378 - DEBUG - ydb.connection.668434  - _log_request: RpcState(AttachSession, c8f3451c-d128-48f5-8a43-98421f5b3db0, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" }
2025-12-23 15:37:00,380 - DEBUG - ydb.connection.668434  - _log_response: RpcState(AttachSession, c8f3451c-d128-48f5-8a43-98421f5b3db0, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:00,382 - DEBUG - ydb.query.pool.668434  - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:00,385 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 9dec0355-7afe-4028-a866-9c813bba8630, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:00,387 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 9dec0355-7afe-4028-a866-9c813bba8630, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:00,388 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 9dec0355-7afe-4028-a866-9c813bba8630, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:02,811 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:02,811 - INFO - __tests__.alter_compression.668434  - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-12-23 15:37:02,812 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:02,813 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, deebff88-654b-476e-83c3-889385d37dc0, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:02,814 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, deebff88-654b-476e-83c3-889385d37dc0, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:02,815 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, deebff88-654b-476e-83c3-889385d37dc0, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:03,689 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:03,690 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:03,690 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, bc6a777b-dbce-480b-99a3-00ad0ac87439, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:03,691 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, bc6a777b-dbce-480b-99a3-00ad0ac87439, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:03,693 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, bc6a777b-dbce-480b-99a3-00ad0ac87439, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:04,713 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:04,714 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:04,714 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 94bb19b1-cf07-4716-81e7-6bb682f8ee68, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:04,715 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 94bb19b1-cf07-4716-81e7-6bb682f8ee68, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:04,716 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 94bb19b1-cf07-4716-81e7-6bb682f8ee68, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:05,473 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:05,473 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:05,474 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 7fc60250-cccd-4f76-9a76-631fcaa8f170, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:05,475 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 7fc60250-cccd-4f76-9a76-631fcaa8f170, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:05,477 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 7fc60250-cccd-4f76-9a76-631fcaa8f170, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:06,653 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:06,654 - INFO - __tests__.alter_compression.668434  - 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-12-23 15:37:06,654 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:06,655 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 2293c3f0-39d5-437b-9dc8-686ec3c598a4, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:06,659 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 2293c3f0-39d5-437b-9dc8-686ec3c598a4, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:06,660 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 2293c3f0-39d5-437b-9dc8-686ec3c598a4, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:07,496 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:07,497 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:07,498 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 87fa10d5-0d78-4c1c-acb7-0efdc4008f47, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:07,498 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 87fa10d5-0d78-4c1c-acb7-0efdc4008f47, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:07,500 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 87fa10d5-0d78-4c1c-acb7-0efdc4008f47, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:07,668 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:07,669 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:07,670 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, e337656d-b0c4-4689-b8e5-edd1c1dc0156, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:07,670 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, e337656d-b0c4-4689-b8e5-edd1c1dc0156, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:07,672 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, e337656d-b0c4-4689-b8e5-edd1c1dc0156, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:08,002 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:08,003 - INFO - __tests__.alter_compression.668434  - 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-12-23 15:37:08,003 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:08,004 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 1a733dd8-5447-4041-9c05-c33c69ffa7ad, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:08,005 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 1a733dd8-5447-4041-9c05-c33c69ffa7ad, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:08,006 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 1a733dd8-5447-4041-9c05-c33c69ffa7ad, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:08,800 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:08,801 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:08,802 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, bfab2108-32ac-49b1-b766-cd8be5291638, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:08,803 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, bfab2108-32ac-49b1-b766-cd8be5291638, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:08,808 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, bfab2108-32ac-49b1-b766-cd8be5291638, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:08,985 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:08,986 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:08,986 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, d4892dbe-ecde-46e1-8ebf-9efe4e8c66dc, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:08,987 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, d4892dbe-ecde-46e1-8ebf-9efe4e8c66dc, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:08,988 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, d4892dbe-ecde-46e1-8ebf-9efe4e8c66dc, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:09,285 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:09,286 - INFO - __tests__.alter_compression.668434  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 4855296, 'BlobCount': 384}}
2025-12-23 15:37:09,287 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:09,287 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, d46d181f-22dd-4a3e-b676-1746abba0f74, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:09,288 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, d46d181f-22dd-4a3e-b676-1746abba0f74, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:09,289 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, d46d181f-22dd-4a3e-b676-1746abba0f74, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:10,119 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:10,120 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:10,121 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 7c8e14af-025a-426e-b702-e3fb67eb4319, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:10,122 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 7c8e14af-025a-426e-b702-e3fb67eb4319, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:10,123 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 7c8e14af-025a-426e-b702-e3fb67eb4319, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:10,301 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:10,301 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:10,302 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, a465fa21-e79e-4f5c-8947-b2db1ca49263, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:10,303 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, a465fa21-e79e-4f5c-8947-b2db1ca49263, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:10,304 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, a465fa21-e79e-4f5c-8947-b2db1ca49263, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:10,583 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:10,583 - INFO - __tests__.alter_compression.668434  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 6473728, 'BlobCount': 512}}
2025-12-23 15:37:10,584 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:10,584 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 7eae3cef-d74a-4692-a748-da22ddd57db3, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:10,585 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 7eae3cef-d74a-4692-a748-da22ddd57db3, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:10,587 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 7eae3cef-d74a-4692-a748-da22ddd57db3, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:11,408 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:11,409 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:11,409 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, e46b06a9-a258-448f-b5f8-a26c08ee4265, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:11,410 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, e46b06a9-a258-448f-b5f8-a26c08ee4265, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:11,411 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, e46b06a9-a258-448f-b5f8-a26c08ee4265, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:11,619 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:11,619 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:11,620 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, c73fc926-2737-41f7-a611-ec4d8de49555, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:11,621 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, c73fc926-2737-41f7-a611-ec4d8de49555, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:11,622 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, c73fc926-2737-41f7-a611-ec4d8de49555, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:11,963 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:11,964 - INFO - __tests__.alter_compression.668434  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 8092160, 'BlobCount': 640}}
2025-12-23 15:37:11,965 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:11,965 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, cd0de594-cd41-4050-b2bb-e45db976cef8, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:11,966 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, cd0de594-cd41-4050-b2bb-e45db976cef8, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:11,967 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, cd0de594-cd41-4050-b2bb-e45db976cef8, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:12,758 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:12,759 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:12,760 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 3740a07a-84a1-40f1-848a-5048bc108957, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:12,761 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 3740a07a-84a1-40f1-848a-5048bc108957, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:12,762 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 3740a07a-84a1-40f1-848a-5048bc108957, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:13,092 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:13,092 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:13,093 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, e1789d9a-cf79-4841-b2b4-258930f8e0a8, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:13,094 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, e1789d9a-cf79-4841-b2b4-258930f8e0a8, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:13,096 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, e1789d9a-cf79-4841-b2b4-258930f8e0a8, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:13,508 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:13,509 - INFO - __tests__.alter_compression.668434  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 9710592, 'BlobCount': 768}}
2025-12-23 15:37:13,510 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:13,511 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, ebf1bab0-bcc2-4040-ab32-531f48f87afe, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:13,512 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, ebf1bab0-bcc2-4040-ab32-531f48f87afe, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:13,513 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, ebf1bab0-bcc2-4040-ab32-531f48f87afe, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:14,392 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:14,393 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:14,394 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 74e54d2e-1e18-4e42-b356-7200cbb49b76, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:14,395 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 74e54d2e-1e18-4e42-b356-7200cbb49b76, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:14,396 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 74e54d2e-1e18-4e42-b356-7200cbb49b76, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:14,582 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:14,582 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:14,583 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, b98472f3-978a-4eac-a656-d31ce8a4b5c3, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:14,584 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, b98472f3-978a-4eac-a656-d31ce8a4b5c3, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:14,585 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, b98472f3-978a-4eac-a656-d31ce8a4b5c3, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:15,036 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:15,037 - INFO - __tests__.alter_compression.668434  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 11329024, 'BlobCount': 896}}
2025-12-23 15:37:15,037 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:15,038 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, b6a02878-4bd6-4fdc-80ca-b989ab26d46b, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:15,038 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, b6a02878-4bd6-4fdc-80ca-b989ab26d46b, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:15,039 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, b6a02878-4bd6-4fdc-80ca-b989ab26d46b, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:16,008 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:16,009 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:16,010 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 5edd4c31-b0c9-47f0-8289-a7facdbedf73, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:16,011 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 5edd4c31-b0c9-47f0-8289-a7facdbedf73, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:16,012 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 5edd4c31-b0c9-47f0-8289-a7facdbedf73, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:16,194 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:16,194 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:16,195 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 66a1ca54-115e-4d9e-ba65-e1b4cfa693c9, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:16,196 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 66a1ca54-115e-4d9e-ba65-e1b4cfa693c9, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:16,197 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 66a1ca54-115e-4d9e-ba65-e1b4cfa693c9, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:16,693 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:16,696 - INFO - __tests__.alter_compression.668434  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 12947456, 'BlobCount': 1024}}
2025-12-23 15:37:16,696 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:16,697 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 5aba2a8d-3148-4447-b253-f43872cb0e4a, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:16,698 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 5aba2a8d-3148-4447-b253-f43872cb0e4a, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:16,699 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 5aba2a8d-3148-4447-b253-f43872cb0e4a, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:17,709 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:17,710 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:17,711 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, d0496c47-240e-466e-839f-943085cdf897, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:17,712 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, d0496c47-240e-466e-839f-943085cdf897, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:17,713 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, d0496c47-240e-466e-839f-943085cdf897, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:17,964 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:17,965 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:17,965 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 959a87e1-cedd-48f7-bda3-ec96b973d3b7, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:17,966 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 959a87e1-cedd-48f7-bda3-ec96b973d3b7, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:17,968 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 959a87e1-cedd-48f7-bda3-ec96b973d3b7, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:18,528 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:18,529 - INFO - __tests__.alter_compression.668434  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 14565888, 'BlobCount': 1152}}
2025-12-23 15:37:18,529 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:18,530 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, bfd1e790-5764-4b4e-8135-8ccf7a54a99f, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:18,531 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, bfd1e790-5764-4b4e-8135-8ccf7a54a99f, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:18,532 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, bfd1e790-5764-4b4e-8135-8ccf7a54a99f, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:19,652 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:19,653 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:19,653 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 86884270-48bf-4146-bf1d-8ca1f65a12de, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:19,654 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 86884270-48bf-4146-bf1d-8ca1f65a12de, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:19,656 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 86884270-48bf-4146-bf1d-8ca1f65a12de, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:19,973 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:19,973 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:19,974 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, b37ea219-9031-47e6-aea0-6b0a29193ba9, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:19,975 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, b37ea219-9031-47e6-aea0-6b0a29193ba9, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:19,976 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, b37ea219-9031-47e6-aea0-6b0a29193ba9, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:20,761 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:20,761 - INFO - __tests__.alter_compression.668434  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 16184320, 'BlobCount': 1280}}
2025-12-23 15:37:20,762 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:20,762 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 27b43093-f213-436a-8cd2-026227e479db, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:20,763 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 27b43093-f213-436a-8cd2-026227e479db, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:20,764 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 27b43093-f213-436a-8cd2-026227e479db, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:21,829 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:21,830 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:21,831 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, aa7aa873-7f34-421f-8bf3-a5beec2c514e, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:21,832 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, aa7aa873-7f34-421f-8bf3-a5beec2c514e, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:21,833 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, aa7aa873-7f34-421f-8bf3-a5beec2c514e, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:22,093 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:22,093 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:22,094 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 4e9f9c40-b6b2-4ce6-98c9-da6ef1693a4a, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:22,095 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 4e9f9c40-b6b2-4ce6-98c9-da6ef1693a4a, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:22,096 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 4e9f9c40-b6b2-4ce6-98c9-da6ef1693a4a, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:22,335 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:22,336 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:22,337 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, ea70ddaa-d71f-4741-a36e-86a6d7a457db, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:22,338 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, ea70ddaa-d71f-4741-a36e-86a6d7a457db, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:22,340 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, ea70ddaa-d71f-4741-a36e-86a6d7a457db, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:26,139 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:36,187 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:36,188 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, e20d6280-1302-425d-ab25-5325594b9910, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:36,189 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, e20d6280-1302-425d-ab25-5325594b9910, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:36,191 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, e20d6280-1302-425d-ab25-5325594b9910, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:39,025 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:39,061 - INFO - root.668434  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-12-23 15:37:39,061 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:39,062 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, e5e97f80-700b-4640-934d-f5a435d06488, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:39,063 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, e5e97f80-700b-4640-934d-f5a435d06488, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:39,064 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, e5e97f80-700b-4640-934d-f5a435d06488, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:42,098 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:52,144 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:52,145 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, e3ed3708-f1b8-4be3-baca-afa1a8ddb7c2, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:52,146 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, e3ed3708-f1b8-4be3-baca-afa1a8ddb7c2, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:52,148 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, e3ed3708-f1b8-4be3-baca-afa1a8ddb7c2, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:55,145 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:55,179 - INFO - root.668434  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-12-23 15:37:55,180 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:55,181 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, d5cb3fe0-bf77-4af9-a11a-7f3fb229163f, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:55,182 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, d5cb3fe0-bf77-4af9-a11a-7f3fb229163f, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:55,183 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, d5cb3fe0-bf77-4af9-a11a-7f3fb229163f, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:55,457 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:55,460 - INFO - ya.test.668434  - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[lz4_compression-COMPRESSION = "lz4"])
2025-12-23 15:37:55,461 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:55,461 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 92bcabaf-86a1-4c80-a336-9e74f9a8bd01, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:55,462 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 92bcabaf-86a1-4c80-a336-9e74f9a8bd01, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/lz4_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"lz4\")\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:55,465 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 92bcabaf-86a1-4c80-a336-9e74f9a8bd01, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:57,952 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:57,953 - INFO - __tests__.alter_compression.668434  - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/lz4_compression created
2025-12-23 15:37:57,954 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:57,954 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 4140a718-5656-4bd8-bdc7-9efaf1e1bfde, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:57,955 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 4140a718-5656-4bd8-bdc7-9efaf1e1bfde, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/lz4_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:57,961 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 4140a718-5656-4bd8-bdc7-9efaf1e1bfde, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:58,608 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:58,609 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:58,609 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 3269bd1b-570d-4ea2-bb19-379a2d412c9c, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:58,610 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 3269bd1b-570d-4ea2-bb19-379a2d412c9c, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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/lz4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:58,612 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 3269bd1b-570d-4ea2-bb19-379a2d412c9c, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:59,640 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:59,641 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:37:59,642 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 971bcc82-0d35-4cbe-834d-773cab232f7f, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:37:59,643 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 971bcc82-0d35-4cbe-834d-773cab232f7f, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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/lz4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:59,644 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 971bcc82-0d35-4cbe-834d-773cab232f7f, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:00,541 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:00,541 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:00,542 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 69edbf22-6a1f-4289-9b5a-11ba1c0743d2, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:38:00,543 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 69edbf22-6a1f-4289-9b5a-11ba1c0743d2, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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/lz4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:00,549 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 69edbf22-6a1f-4289-9b5a-11ba1c0743d2, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:00,720 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.668434  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-23 15:38:00,721 - DEBUG - ydb.connection.668434  - 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', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-23 15:38:00,769 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.668434  - context_resolve: Resolving endpoints for database /Root
2025-12-23 15:38:00,770 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ListEndpoints, 0612c5ee-0490-4c5f-a3f8-2b4fd14881d7, localhost:4073): creating call state
2025-12-23 15:38:00,770 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ListEndpoints, 0612c5ee-0490-4c5f-a3f8-2b4fd14881d7, localhost:4073): request = { database: "/Root" }
2025-12-23 15:38:00,775 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ListEndpoints, 0612c5ee-0490-4c5f-a3f8-2b4fd14881d7, localhost:4073): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-icmf7pzugu.auto.internal" port: 4073 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-12-23 15:38:00,776 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.668434  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-icmf7pzugu.auto.internal:4073, location 1, ssl: False>]>
2025-12-23 15:38:00,777 - DEBUG - ydb.connection.668434  - close: Closing channel for endpoint localhost:4073
2025-12-23 15:38:02,207 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:02,208 - INFO - __tests__.alter_compression.668434  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/lz4_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 872992, 'BlobCount': 128}}
2025-12-23 15:38:02,208 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:02,209 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, e9e3a596-80f5-414b-a32a-ef0d497393a2, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:38:02,210 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, e9e3a596-80f5-414b-a32a-ef0d497393a2, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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/lz4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:02,211 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, e9e3a596-80f5-414b-a32a-ef0d497393a2, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:03,245 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:03,246 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:03,247 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 0288bacc-4767-4be4-8681-ee53a2cd938a, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:38:03,248 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 0288bacc-4767-4be4-8681-ee53a2cd938a, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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/lz4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:03,250 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 0288bacc-4767-4be4-8681-ee53a2cd938a, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:03,492 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:03,493 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:03,493 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 8437dd50-de3e-457e-aa2e-7fa2e95501c4, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:38:03,494 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 8437dd50-de3e-457e-aa2e-7fa2e95501c4, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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/lz4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:03,495 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 8437dd50-de3e-457e-aa2e-7fa2e95501c4, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:03,965 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:03,966 - INFO - __tests__.alter_compression.668434  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/lz4_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 1747088, 'BlobCount': 256}}
2025-12-23 15:38:03,966 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:03,967 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 54552fb8-7356-448f-b51c-41b9217cd044, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:38:03,968 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 54552fb8-7356-448f-b51c-41b9217cd044, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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/lz4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:03,969 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 54552fb8-7356-448f-b51c-41b9217cd044, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:05,009 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:05,010 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:05,011 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 57b47c4f-f384-43b9-8240-087e89222f73, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:38:05,012 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 57b47c4f-f384-43b9-8240-087e89222f73, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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/lz4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:05,013 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 57b47c4f-f384-43b9-8240-087e89222f73, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:05,341 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:05,342 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:05,343 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 02706105-c9ae-467c-b03c-bcc375440b3f, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:38:05,344 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 02706105-c9ae-467c-b03c-bcc375440b3f, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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/lz4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:05,345 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 02706105-c9ae-467c-b03c-bcc375440b3f, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:05,800 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:05,801 - INFO - __tests__.alter_compression.668434  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/lz4_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 2620992, 'BlobCount': 384}}
2025-12-23 15:38:05,801 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:05,802 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 0102bb57-eaba-46e7-9f00-001329372aef, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:38:05,803 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 0102bb57-eaba-46e7-9f00-001329372aef, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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/lz4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:05,804 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 0102bb57-eaba-46e7-9f00-001329372aef, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:06,833 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:06,834 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:06,835 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 3875845c-e757-42b9-b856-b52d457a38c3, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:38:06,836 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 3875845c-e757-42b9-b856-b52d457a38c3, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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/lz4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:06,837 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 3875845c-e757-42b9-b856-b52d457a38c3, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:07,186 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:07,187 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:07,187 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, de3e027b-c5d9-40b0-a508-f88ccf071e17, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:38:07,189 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, de3e027b-c5d9-40b0-a508-f88ccf071e17, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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/lz4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:07,190 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, de3e027b-c5d9-40b0-a508-f88ccf071e17, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:07,816 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:07,817 - INFO - __tests__.alter_compression.668434  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/lz4_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 3495088, 'BlobCount': 512}}
2025-12-23 15:38:07,817 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:07,818 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, bbf827ec-ac27-48c3-8ef9-e2ae5941e385, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:38:07,819 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, bbf827ec-ac27-48c3-8ef9-e2ae5941e385, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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/lz4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:07,825 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, bbf827ec-ac27-48c3-8ef9-e2ae5941e385, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:08,825 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:08,826 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:08,826 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 0cfed957-d01d-4425-bbf7-a1afa853fefb, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:38:08,827 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 0cfed957-d01d-4425-bbf7-a1afa853fefb, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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/lz4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:08,830 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 0cfed957-d01d-4425-bbf7-a1afa853fefb, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:09,202 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:09,203 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:09,204 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 66dfd278-a621-4be9-85c0-7e39e62ca50c, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:38:09,205 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 66dfd278-a621-4be9-85c0-7e39e62ca50c, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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/lz4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:09,207 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 66dfd278-a621-4be9-85c0-7e39e62ca50c, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:09,869 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:09,869 - INFO - __tests__.alter_compression.668434  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/lz4_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 4368976, 'BlobCount': 640}}
2025-12-23 15:38:09,870 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:09,870 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, bf960f96-3f32-4edc-bd4e-510fcda46412, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:38:09,871 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, bf960f96-3f32-4edc-bd4e-510fcda46412, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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/lz4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:09,873 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, bf960f96-3f32-4edc-bd4e-510fcda46412, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:10,837 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:10,838 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:10,839 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, eb14362b-4f5a-4769-9cfb-4a2d84810729, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:38:10,840 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, eb14362b-4f5a-4769-9cfb-4a2d84810729, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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/lz4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:10,841 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, eb14362b-4f5a-4769-9cfb-4a2d84810729, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:11,103 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:11,104 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:11,105 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 770d2b5f-d833-4282-aa80-672258e58019, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:38:11,106 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 770d2b5f-d833-4282-aa80-672258e58019, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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/lz4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:11,108 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 770d2b5f-d833-4282-aa80-672258e58019, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:11,702 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:11,703 - INFO - __tests__.alter_compression.668434  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/lz4_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 5242960, 'BlobCount': 768}}
2025-12-23 15:38:11,703 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:11,704 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 4be6b55a-9f00-485d-b40f-295cfe228853, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:38:11,705 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 4be6b55a-9f00-485d-b40f-295cfe228853, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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/lz4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:11,712 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 4be6b55a-9f00-485d-b40f-295cfe228853, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:12,841 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:12,842 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:12,843 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 1cb4a3fc-77e8-4a2a-a9f0-017b21835ff6, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:38:12,844 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 1cb4a3fc-77e8-4a2a-a9f0-017b21835ff6, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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/lz4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:12,845 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 1cb4a3fc-77e8-4a2a-a9f0-017b21835ff6, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:13,101 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:13,102 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:13,102 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, f29ced2e-7613-4959-a48b-f35e73288120, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:38:13,103 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, f29ced2e-7613-4959-a48b-f35e73288120, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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/lz4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:13,104 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, f29ced2e-7613-4959-a48b-f35e73288120, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:13,701 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:13,702 - INFO - __tests__.alter_compression.668434  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/lz4_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 6117040, 'BlobCount': 896}}
2025-12-23 15:38:13,702 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:13,703 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 27111a6e-851f-4196-9c52-1aca7b4db453, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:38:13,704 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 27111a6e-851f-4196-9c52-1aca7b4db453, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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/lz4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:13,706 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 27111a6e-851f-4196-9c52-1aca7b4db453, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:14,848 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:14,849 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:14,850 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 40d86e8b-c161-4a2d-8e40-a848093497de, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:38:14,851 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 40d86e8b-c161-4a2d-8e40-a848093497de, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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/lz4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:14,852 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 40d86e8b-c161-4a2d-8e40-a848093497de, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:15,240 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:15,241 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:15,242 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 9a8bdfe0-67f8-4d6b-bad1-459f4e2927fc, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:38:15,243 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 9a8bdfe0-67f8-4d6b-bad1-459f4e2927fc, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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/lz4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:15,244 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 9a8bdfe0-67f8-4d6b-bad1-459f4e2927fc, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:16,001 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:16,001 - INFO - __tests__.alter_compression.668434  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/lz4_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 6991184, 'BlobCount': 1024}}
2025-12-23 15:38:16,002 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:16,002 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, dcdab2d5-ce09-48df-a1f2-243b15859f6e, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:38:16,003 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, dcdab2d5-ce09-48df-a1f2-243b15859f6e, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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/lz4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:16,004 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, dcdab2d5-ce09-48df-a1f2-243b15859f6e, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:17,254 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:17,255 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:17,255 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 687a1ae4-16f4-4a33-a05b-813cb1c2104c, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:38:17,256 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 687a1ae4-16f4-4a33-a05b-813cb1c2104c, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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/lz4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:17,258 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 687a1ae4-16f4-4a33-a05b-813cb1c2104c, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:17,565 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:17,566 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:17,567 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 48e4780b-8f90-41f1-89e6-7122ca3b8c97, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:38:17,568 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 48e4780b-8f90-41f1-89e6-7122ca3b8c97, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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/lz4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:17,569 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 48e4780b-8f90-41f1-89e6-7122ca3b8c97, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:18,233 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:18,233 - INFO - __tests__.alter_compression.668434  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/lz4_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 7865088, 'BlobCount': 1152}}
2025-12-23 15:38:18,234 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:18,234 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, c8f787db-6a06-4e77-b5a8-214c2d639729, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:38:18,235 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, c8f787db-6a06-4e77-b5a8-214c2d639729, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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/lz4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:18,237 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, c8f787db-6a06-4e77-b5a8-214c2d639729, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:19,154 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:19,154 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:19,155 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 87b139d4-14d8-40ea-85f7-cff3239e042d, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:38:19,156 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 87b139d4-14d8-40ea-85f7-cff3239e042d, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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/lz4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:19,157 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 87b139d4-14d8-40ea-85f7-cff3239e042d, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:19,390 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:19,391 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:19,391 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, b5329a4c-6f0e-48fa-aa04-a0709e0f784a, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:38:19,392 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, b5329a4c-6f0e-48fa-aa04-a0709e0f784a, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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/lz4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:19,394 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, b5329a4c-6f0e-48fa-aa04-a0709e0f784a, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:20,016 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:20,017 - INFO - __tests__.alter_compression.668434  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/lz4_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 8739264, 'BlobCount': 1280}}
2025-12-23 15:38:20,017 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:20,018 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 854f88e6-539e-4f49-b6db-4ba6623733a8, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:38:20,019 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 854f88e6-539e-4f49-b6db-4ba6623733a8, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/lz4_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:20,025 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 854f88e6-539e-4f49-b6db-4ba6623733a8, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:21,252 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:21,253 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:21,254 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, ac7fc928-ef11-40fb-845a-2c229acbb11b, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:38:21,255 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, ac7fc928-ef11-40fb-845a-2c229acbb11b, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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/lz4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:21,256 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, ac7fc928-ef11-40fb-845a-2c229acbb11b, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:21,616 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:21,617 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:21,618 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 075b8bea-5b26-4c9b-9731-c46d7278211f, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:38:21,619 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 075b8bea-5b26-4c9b-9731-c46d7278211f, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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/lz4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:21,620 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 075b8bea-5b26-4c9b-9731-c46d7278211f, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:21,896 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:21,897 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:21,898 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, d14e4eb0-f1d6-4aa4-a6e1-a4e2eb682404, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:38:21,899 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, d14e4eb0-f1d6-4aa4-a6e1-a4e2eb682404, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/lz4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:21,902 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, d14e4eb0-f1d6-4aa4-a6e1-a4e2eb682404, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:25,619 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:35,692 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:35,693 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, e2c1f0b9-ea98-48aa-bf2c-8751ee39bcfe, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:38:35,694 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, e2c1f0b9-ea98-48aa-bf2c-8751ee39bcfe, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/lz4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:35,695 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, e2c1f0b9-ea98-48aa-bf2c-8751ee39bcfe, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:38,639 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:38,685 - INFO - root.668434  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/lz4_compression`, volumes `value` (8000000, 4369632)
2025-12-23 15:38:38,686 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:38,687 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, e4f80b57-27e5-4d99-8833-d0d76cd46daa, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:38:38,688 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, e4f80b57-27e5-4d99-8833-d0d76cd46daa, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" 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/lz4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:38,692 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, e4f80b57-27e5-4d99-8833-d0d76cd46daa, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:38,953 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:38,953 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:38,954 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 447bb562-7a8e-4f0a-97f9-32b341a9f11f, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:38:38,955 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 447bb562-7a8e-4f0a-97f9-32b341a9f11f, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/lz4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:38,956 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 447bb562-7a8e-4f0a-97f9-32b341a9f11f, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:41,998 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:52,033 - DEBUG - ydb.query.pool.668434  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:52,034 - DEBUG - ydb.connection.668434  - _prepare_call: RpcState(ExecuteQuery, 578e7180-5e8f-4239-b430-3b82954d7439, ghrun-icmf7pzugu.auto.internal:4073): creating call state
2025-12-23 15:38:52,035 - DEBUG - ydb.connection.668434  - _log_request: RpcState(ExecuteQuery, 578e7180-5e8f-4239-b430-3b82954d7439, ghrun-icmf7pzugu.auto.internal:4073): request = { session_id: "ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/lz4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:52,036 - DEBUG - ydb.connection.668434  - _log_response: RpcState(ExecuteQuery, 578e7180-5e8f-4239-b430-3b82954d7439, ghrun-icmf7pzugu.auto.internal:4073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:54,760 - DEBUG - ydb.query.pool.668434  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2E4NWE2ZTgtYTcyMjIyNC03MTU3YjQ2MS03YmJkYzkyOA==
2025-12-23 15:38:54,797 - INFO - root.668434  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/lz4_compression`, volumes `value` (8000000, 4369632)
2025-12-23 15:38:54,797 - INFO - root.668434  - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/lz4_compression` 8092160 / 4369632: 1.8519088106275312
2025-12-23 15:38:54,800 - INFO - ya.test.668434  - pytest_runtest_teardown: Test teardown
