2025-12-07 19:44:38,243 - INFO - ya.test.52198  - pytest_runtest_setup: ####################################################################################################
2025-12-07 19:44:38,244 - INFO - ya.test.52198  - pytest_runtest_setup: test_all_supported_compression[zstd_compression-COMPRESSION = "zstd"]
2025-12-07 19:44:38,244 - INFO - ya.test.52198  - pytest_runtest_setup: ####################################################################################################
2025-12-07 19:44:38,244 - INFO - ya.test.52198  - pytest_runtest_setup: Test setup
2025-12-07 19:44:38,247 - DEBUG - ya.test.52198  - _get_command_output_file: Command out will be placed to ydbd.out
2025-12-07 19:44:38,248 - DEBUG - ya.test.52198  - _get_command_output_file: Command err will be placed to ydbd.err
2025-12-07 19:44:38,248 - DEBUG - ya.test.52198  - execute: Executing '['/home/runner/.ya/build/build_root/nbq9/002178/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-12-07 19:44:38,251 - DEBUG - ya.test.52198  - execute: Command pid: 54462
2025-12-07 19:44:39,124 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54462) rc: 0
2025-12-07 19:44:39,124 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54462) elapsed time (sec): 0.8695359230041504
2025-12-07 19:44:39,125 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54462) idrss: 0
2025-12-07 19:44:39,125 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54462) inblock: 0
2025-12-07 19:44:39,125 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54462) isrss: 0
2025-12-07 19:44:39,126 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54462) ixrss: 0
2025-12-07 19:44:39,126 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54462) majflt: 0
2025-12-07 19:44:39,126 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54462) maxrss: 486524
2025-12-07 19:44:39,127 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54462) minflt: 45735
2025-12-07 19:44:39,127 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54462) msgrcv: 0
2025-12-07 19:44:39,127 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54462) msgsnd: 0
2025-12-07 19:44:39,127 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54462) nivcsw: 154
2025-12-07 19:44:39,128 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54462) nsignals: 0
2025-12-07 19:44:39,128 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54462) nswap: 0
2025-12-07 19:44:39,128 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54462) nvcsw: 14
2025-12-07 19:44:39,128 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54462) oublock: 8
2025-12-07 19:44:39,129 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54462) stime: 0.189939
2025-12-07 19:44:39,129 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54462) utime: 0.515066
2025-12-07 19:44:39,129 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54462) wtime: 0.874
2025-12-07 19:44:39,129 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54462) output:
Git info:
    Commit: e83fd7e6e4205be8576c8746b2e97bc2aba35179
    Branch: 
    Author: Pavel Velikhov <pavel.velikhov@gmail.com>
    Summary: Merge bb726b0e809e5cee85d4dbb9c4701b21f4ec5dd1 into 9e8876b554304ab0d6f8d3f9510beeea45180cea
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-7gzmsyrbqy    Host information: 
        Linux ghrun-7gzmsyrbqy 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-07 19:44:39,138 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54462) errors:

2025-12-07 19:44:39,138 - INFO - __tests__.base.52198  - _setup_ydb: Git info:
    Commit: e83fd7e6e4205be8576c8746b2e97bc2aba35179
    Branch: 
    Author: Pavel Velikhov <pavel.velikhov@gmail.com>
    Summary: Merge bb726b0e809e5cee85d4dbb9c4701b21f4ec5dd1 into 9e8876b554304ab0d6f8d3f9510beeea45180cea
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-7gzmsyrbqy    Host information: 
        Linux ghrun-7gzmsyrbqy 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-07 19:44:39,380 - DEBUG - ya.test.52198  - get_binary: Binary was found by /home/runner/.ya/build/build_root/nbq9/002178/ydb/apps/ydbd/ydbd
2025-12-07 19:44:39,382 - DEBUG - library.python.filelock.52198  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/19849
2025-12-07 19:44:39,397 - DEBUG - ydb.tests.library.harness.kikimr_runner.52198  - start: Working directory: /home/runner/.ya/build/build_root/nbq9/002178/r3tmp/kikimr_cluster_djy3b5ar
2025-12-07 19:44:39,449 - DEBUG - ya.test.52198  - get_binary: Binary was found by /home/runner/.ya/build/build_root/nbq9/002178/ydb/apps/ydbd/ydbd
2025-12-07 19:44:39,450 - DEBUG - library.python.filelock.52198  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/25369
2025-12-07 19:44:39,450 - DEBUG - library.python.filelock.52198  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/23515
2025-12-07 19:44:39,451 - DEBUG - library.python.filelock.52198  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/18972
2025-12-07 19:44:39,452 - DEBUG - library.python.filelock.52198  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/63312
2025-12-07 19:44:39,453 - INFO - ydb.tests.library.harness.kikimr_runner.52198  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/nbq9/002178/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_compression-COMPRESSION.=.zstd/cluster/kikimr_configs"
2025-12-07 19:44:39,453 - INFO - ydb.tests.library.harness.kikimr_runner.52198  - __make_run_command: Final command: /home/runner/.ya/build/build_root/nbq9/002178/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/nbq9/002178/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_compression-COMPRESSION.=.zstd/cluster/node_1/logfile_mssx6n0s.log --grpc-port=25369 --mon-port=23515 --ic-port=19849
2025-12-07 19:44:39,454 - DEBUG - ydb.tests.library.harness.kikimr_runner.52198  - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:25369/1, disk_size 68719476736
2025-12-07 19:44:39,455 - INFO - ydb.tests.library.harness.kikimr_runner.52198  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/nbq9/002178/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_compression-COMPRESSION.=.zstd/cluster/kikimr_configs"
2025-12-07 19:44:39,455 - INFO - ydb.tests.library.harness.kikimr_runner.52198  - __make_run_command: Final command: /home/runner/.ya/build/build_root/nbq9/002178/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/nbq9/002178/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_compression-COMPRESSION.=.zstd/cluster/node_1/logfile_mssx6n0s.log --grpc-port=25369 --mon-port=23515 --ic-port=19849
2025-12-07 19:44:39,456 - DEBUG - ya.test.52198  - execute: Executing '('/home/runner/.ya/build/build_root/nbq9/002178/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/nbq9/002178/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_compression-COMPRESSION.=.zstd/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/nbq9/002178/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_compression-COMPRESSION.=.zstd/cluster/node_1/logfile_mssx6n0s.log', '--grpc-port=25369', '--mon-port=23515', '--ic-port=19849')' in '/home/runner/.ya/build/build_root/nbq9/002178/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_compression-COMPRESSION.=.zstd/cluster/node_1' (no wait)
2025-12-07 19:44:39,465 - DEBUG - ya.test.52198  - execute: Command pid: 54517
2025-12-07 19:44:39,466 - INFO - ydb.tests.library.harness.kikimr_runner.52198  - start: Started node localhost:25369/1
2025-12-07 19:44:39,468 - DEBUG - ya.test.52198  - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-12-07 19:44:39,470 - DEBUG - ya.test.52198  - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-12-07 19:44:39,470 - DEBUG - ya.test.52198  - execute: Executing '['/home/runner/.ya/build/build_root/nbq9/002178/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-12-07 19:44:39,488 - DEBUG - ya.test.52198  - execute: Command pid: 54518
2025-12-07 19:44:40,792 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54518) rc: 0
2025-12-07 19:44:40,792 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54518) elapsed time (sec): 1.3013594150543213
2025-12-07 19:44:40,793 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54518) idrss: 0
2025-12-07 19:44:40,793 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54518) inblock: 0
2025-12-07 19:44:40,793 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54518) isrss: 0
2025-12-07 19:44:40,793 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54518) ixrss: 0
2025-12-07 19:44:40,794 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54518) majflt: 0
2025-12-07 19:44:40,794 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54518) maxrss: 497460
2025-12-07 19:44:40,795 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54518) minflt: 45767
2025-12-07 19:44:40,795 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54518) msgrcv: 0
2025-12-07 19:44:40,795 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54518) msgsnd: 0
2025-12-07 19:44:40,796 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54518) nivcsw: 156
2025-12-07 19:44:40,796 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54518) nsignals: 0
2025-12-07 19:44:40,796 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54518) nswap: 0
2025-12-07 19:44:40,796 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54518) nvcsw: 14
2025-12-07 19:44:40,797 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54518) oublock: 8
2025-12-07 19:44:40,797 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54518) stime: 0.215212
2025-12-07 19:44:40,797 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54518) utime: 0.48658199999999996
2025-12-07 19:44:40,826 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54518) wtime: 1.32
2025-12-07 19:44:40,827 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54518) output:
Git info:
    Commit: e83fd7e6e4205be8576c8746b2e97bc2aba35179
    Branch: 
    Author: Pavel Velikhov <pavel.velikhov@gmail.com>
    Summary: Merge bb726b0e809e5cee85d4dbb9c4701b21f4ec5dd1 into 9e8876b554304ab0d6f8d3f9510beeea45180cea
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-7gzmsyrbqy    Host information: 
        Linux ghrun-7gzmsyrbqy 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-07 19:44:40,828 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 54518) errors:

2025-12-07 19:44:40,828 - INFO - ydb.tests.library.harness.kikimr_runner.52198  - start: Node 1 version:
Git info:
    Commit: e83fd7e6e4205be8576c8746b2e97bc2aba35179
    Branch: 
    Author: Pavel Velikhov <pavel.velikhov@gmail.com>
    Summary: Merge bb726b0e809e5cee85d4dbb9c4701b21f4ec5dd1 into 9e8876b554304ab0d6f8d3f9510beeea45180cea
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-7gzmsyrbqy    Host information: 
        Linux ghrun-7gzmsyrbqy 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64
2025-12-07 19:44:47,479 - DEBUG - ya.test.52198  - get_binary: Binary was found by /home/runner/.ya/build/build_root/nbq9/002178/ydb/apps/ydbd/ydbd
2025-12-07 19:44:47,480 - DEBUG - ydb.tests.library.harness.kikimr_runner.52198  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/nbq9/002178/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:25369', '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: 19849\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-12-07 19:44:47,481 - DEBUG - ya.test.52198  - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-12-07 19:44:47,487 - DEBUG - ya.test.52198  - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-12-07 19:44:47,487 - DEBUG - ya.test.52198  - execute: Executing '['/home/runner/.ya/build/build_root/nbq9/002178/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:25369', '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: 19849\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-12-07 19:44:47,499 - DEBUG - ya.test.52198  - execute: Command pid: 55880
2025-12-07 19:44:48,859 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 55880) rc: 0
2025-12-07 19:44:48,860 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 55880) elapsed time (sec): 1.3563055992126465
2025-12-07 19:44:48,860 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 55880) idrss: 0
2025-12-07 19:44:48,860 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 55880) inblock: 0
2025-12-07 19:44:48,861 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 55880) isrss: 0
2025-12-07 19:44:48,861 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 55880) ixrss: 0
2025-12-07 19:44:48,861 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 55880) majflt: 0
2025-12-07 19:44:48,861 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 55880) maxrss: 593940
2025-12-07 19:44:48,862 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 55880) minflt: 52073
2025-12-07 19:44:48,862 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 55880) msgrcv: 0
2025-12-07 19:44:48,863 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 55880) msgsnd: 0
2025-12-07 19:44:48,863 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 55880) nivcsw: 345
2025-12-07 19:44:48,863 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 55880) nsignals: 0
2025-12-07 19:44:48,864 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 55880) nswap: 0
2025-12-07 19:44:48,864 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 55880) nvcsw: 694
2025-12-07 19:44:48,864 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 55880) oublock: 8
2025-12-07 19:44:48,864 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 55880) stime: 0.296192
2025-12-07 19:44:48,865 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 55880) utime: 0.528895
2025-12-07 19:44:48,865 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 55880) wtime: 1.371
2025-12-07 19:44:48,865 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 55880) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-12-07 19:44:48,865 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 55880) errors:

2025-12-07 19:44:48,868 - DEBUG - ya.test.52198  - get_binary: Binary was found by /home/runner/.ya/build/build_root/nbq9/002178/ydb/apps/ydbd/ydbd
2025-12-07 19:44:48,868 - DEBUG - ydb.tests.library.harness.kikimr_runner.52198  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/nbq9/002178/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:25369', '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-07 19:44:48,869 - DEBUG - ya.test.52198  - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-12-07 19:44:48,870 - DEBUG - ya.test.52198  - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-12-07 19:44:48,871 - DEBUG - ya.test.52198  - execute: Executing '['/home/runner/.ya/build/build_root/nbq9/002178/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:25369', '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-07 19:44:48,883 - DEBUG - ya.test.52198  - execute: Command pid: 56234
2025-12-07 19:44:50,245 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 56234) rc: 0
2025-12-07 19:44:50,246 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 56234) elapsed time (sec): 1.3604011535644531
2025-12-07 19:44:50,246 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 56234) idrss: 0
2025-12-07 19:44:50,247 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 56234) inblock: 0
2025-12-07 19:44:50,247 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 56234) isrss: 0
2025-12-07 19:44:50,247 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 56234) ixrss: 0
2025-12-07 19:44:50,247 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 56234) majflt: 0
2025-12-07 19:44:50,248 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 56234) maxrss: 594516
2025-12-07 19:44:50,248 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 56234) minflt: 52323
2025-12-07 19:44:50,248 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 56234) msgrcv: 0
2025-12-07 19:44:50,248 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 56234) msgsnd: 0
2025-12-07 19:44:50,248 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 56234) nivcsw: 417
2025-12-07 19:44:50,249 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 56234) nsignals: 0
2025-12-07 19:44:50,249 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 56234) nswap: 0
2025-12-07 19:44:50,252 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 56234) nvcsw: 685
2025-12-07 19:44:50,252 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 56234) oublock: 8
2025-12-07 19:44:50,253 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 56234) stime: 0.25690399999999997
2025-12-07 19:44:50,253 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 56234) utime: 0.566472
2025-12-07 19:44:50,254 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 56234) wtime: 1.372
2025-12-07 19:44:50,254 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 56234) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-12-07 19:44:50,254 - DEBUG - ya.test.52198  - _save_outputs: Command (pid 56234) errors:

2025-12-07 19:44:50,255 - INFO - ydb.tests.library.harness.kikimr_runner.52198  - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-12-07 19:44:50,444 - INFO - ydb.tests.library.harness.kikimr_runner.52198  - __run: Cluster started and initialized
2025-12-07 19:44:50,523 - DEBUG - ydb.connection.52198  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-07 19:44:50,546 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.52198  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-07 19:44:50,547 - DEBUG - ydb.connection.52198  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-07 19:44:50,589 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.52198  - context_resolve: Resolving endpoints for database /Root
2025-12-07 19:44:50,590 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ListEndpoints, 03150eba-045d-4705-b581-cfc345ce1504, localhost:25369): creating call state
2025-12-07 19:44:50,591 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ListEndpoints, 03150eba-045d-4705-b581-cfc345ce1504, localhost:25369): request = { database: "/Root" }
2025-12-07 19:44:50,606 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ListEndpoints, 03150eba-045d-4705-b581-cfc345ce1504, localhost:25369): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-7gzmsyrbqy.auto.internal" port: 25369 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-07 19:44:50,616 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.52198  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-7gzmsyrbqy.auto.internal:25369, location 1, ssl: False>]>
2025-12-07 19:44:50,617 - DEBUG - ydb.connection.52198  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-07 19:44:50,671 - DEBUG - ydb.connection.52198  - close: Closing channel for endpoint localhost:25369
2025-12-07 19:44:50,672 - DEBUG - ydb.query.pool.52198  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-07 19:44:50,673 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(CreateSession, 8b77a78d-d5bc-4eba-96da-d23bf06cd4e0, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:44:50,674 - DEBUG - ydb.connection.52198  - _log_request: RpcState(CreateSession, 8b77a78d-d5bc-4eba-96da-d23bf06cd4e0, ghrun-7gzmsyrbqy.auto.internal:25369): request = {  }
2025-12-07 19:44:52,740 - DEBUG - ydb.connection.52198  - _log_response: RpcState(CreateSession, 8b77a78d-d5bc-4eba-96da-d23bf06cd4e0, ghrun-7gzmsyrbqy.auto.internal:25369): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" node_id: 1 }
2025-12-07 19:44:52,741 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(AttachSession, 0673a6fc-66e5-4c1b-bce1-b986a9ac58e7, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:44:52,742 - DEBUG - ydb.connection.52198  - _log_request: RpcState(AttachSession, 0673a6fc-66e5-4c1b-bce1-b986a9ac58e7, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" }
2025-12-07 19:44:52,758 - DEBUG - ydb.connection.52198  - _log_response: RpcState(AttachSession, 0673a6fc-66e5-4c1b-bce1-b986a9ac58e7, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:44:52,792 - DEBUG - ydb.query.pool.52198  - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:44:52,793 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 4113c54d-28f1-4666-8da9-93a2d300aca6, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:44:52,794 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 4113c54d-28f1-4666-8da9-93a2d300aca6, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:44:52,796 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 4113c54d-28f1-4666-8da9-93a2d300aca6, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:44:57,879 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:44:57,880 - INFO - __tests__.alter_compression.52198  - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-12-07 19:44:57,880 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:44:57,881 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 31f76ca8-3a67-416b-92f1-05a12a1eedde, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:44:57,883 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 31f76ca8-3a67-416b-92f1-05a12a1eedde, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:44:57,885 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 31f76ca8-3a67-416b-92f1-05a12a1eedde, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:44:59,605 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:44:59,606 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:44:59,607 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 8736abb6-f79f-493a-8786-e6522438f79b, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:44:59,609 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 8736abb6-f79f-493a-8786-e6522438f79b, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:44:59,637 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 8736abb6-f79f-493a-8786-e6522438f79b, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:45:01,839 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:01,840 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:01,840 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, a05d4916-a37a-497e-85db-b435619e82fe, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:45:01,841 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, a05d4916-a37a-497e-85db-b435619e82fe, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:45:01,843 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, a05d4916-a37a-497e-85db-b435619e82fe, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:45:03,821 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:03,822 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:03,822 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, fa60ddca-0feb-4b5e-b4e3-61fd42dcc572, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:45:03,823 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, fa60ddca-0feb-4b5e-b4e3-61fd42dcc572, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:45:03,825 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, fa60ddca-0feb-4b5e-b4e3-61fd42dcc572, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:45:07,422 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:07,423 - INFO - __tests__.alter_compression.52198  - 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-07 19:45:07,424 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:07,425 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 3b6985ee-5f3b-439c-af81-da79c3c69862, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:45:07,425 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 3b6985ee-5f3b-439c-af81-da79c3c69862, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:45:07,429 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 3b6985ee-5f3b-439c-af81-da79c3c69862, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:45:09,218 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:09,220 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:09,221 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 0f8a28b5-5c53-4553-a686-9b6bb7c9f0fb, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:45:09,222 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 0f8a28b5-5c53-4553-a686-9b6bb7c9f0fb, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:45:09,225 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 0f8a28b5-5c53-4553-a686-9b6bb7c9f0fb, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:45:09,586 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:09,587 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:09,588 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 397b8b62-f8cd-4f93-b5f8-3f1281bbbb5e, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:45:09,589 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 397b8b62-f8cd-4f93-b5f8-3f1281bbbb5e, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:45:09,590 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 397b8b62-f8cd-4f93-b5f8-3f1281bbbb5e, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:45:10,104 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:10,105 - INFO - __tests__.alter_compression.52198  - 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-07 19:45:10,105 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:10,106 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 6fb460d3-a55a-4f3e-9850-1984b67496b4, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:45:10,107 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 6fb460d3-a55a-4f3e-9850-1984b67496b4, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:45:10,109 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 6fb460d3-a55a-4f3e-9850-1984b67496b4, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:45:11,740 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:11,741 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:11,742 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 11a32ba1-a268-45a5-97b1-fc040f307126, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:45:11,743 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 11a32ba1-a268-45a5-97b1-fc040f307126, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:45:11,744 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 11a32ba1-a268-45a5-97b1-fc040f307126, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:45:12,592 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:12,593 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:12,593 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, dbb8fc32-91df-4927-9e74-0adce3868ad0, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:45:12,594 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, dbb8fc32-91df-4927-9e74-0adce3868ad0, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:45:12,614 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, dbb8fc32-91df-4927-9e74-0adce3868ad0, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:45:13,681 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:13,687 - INFO - __tests__.alter_compression.52198  - 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-07 19:45:13,687 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:13,688 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, dd733928-e5af-4ece-93b3-c7ba63e6f9a9, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:45:13,689 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, dd733928-e5af-4ece-93b3-c7ba63e6f9a9, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:45:13,699 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, dd733928-e5af-4ece-93b3-c7ba63e6f9a9, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:45:15,356 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:15,357 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:15,358 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 8c6ae701-49f4-439c-afdd-40f764493708, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:45:15,359 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 8c6ae701-49f4-439c-afdd-40f764493708, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:45:15,374 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 8c6ae701-49f4-439c-afdd-40f764493708, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:45:16,231 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:16,232 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:16,233 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, ae5d9d53-8b84-4a6c-978e-ddbb84f2884d, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:45:16,234 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, ae5d9d53-8b84-4a6c-978e-ddbb84f2884d, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:45:16,237 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, ae5d9d53-8b84-4a6c-978e-ddbb84f2884d, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:45:16,658 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:16,659 - INFO - __tests__.alter_compression.52198  - 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-07 19:45:16,660 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:16,660 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 48c4ae60-df19-47fb-81b4-1fb47c354ad5, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:45:16,661 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 48c4ae60-df19-47fb-81b4-1fb47c354ad5, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:45:16,662 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 48c4ae60-df19-47fb-81b4-1fb47c354ad5, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:45:17,767 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:17,768 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:17,769 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 05f972c1-6e38-4f97-804e-096075443e74, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:45:17,770 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 05f972c1-6e38-4f97-804e-096075443e74, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:45:17,771 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 05f972c1-6e38-4f97-804e-096075443e74, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:45:18,130 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:18,130 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:18,131 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 0037640d-5112-4524-a0b4-45e1fe289a0d, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:45:18,132 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 0037640d-5112-4524-a0b4-45e1fe289a0d, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:45:18,133 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 0037640d-5112-4524-a0b4-45e1fe289a0d, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:45:18,974 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:18,975 - INFO - __tests__.alter_compression.52198  - 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-07 19:45:18,975 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:18,976 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 70858821-e0f5-4d43-8278-3e2e302a1e6a, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:45:18,977 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 70858821-e0f5-4d43-8278-3e2e302a1e6a, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:45:18,998 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 70858821-e0f5-4d43-8278-3e2e302a1e6a, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:45:20,662 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:20,663 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:20,664 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 36207004-cd03-4ad6-8e50-c2611c027b3d, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:45:20,665 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 36207004-cd03-4ad6-8e50-c2611c027b3d, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:45:20,673 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 36207004-cd03-4ad6-8e50-c2611c027b3d, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:45:21,032 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:21,033 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:21,036 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, e2467b38-9587-48e1-9787-f9f448cbcb4c, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:45:21,037 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, e2467b38-9587-48e1-9787-f9f448cbcb4c, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:45:21,039 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, e2467b38-9587-48e1-9787-f9f448cbcb4c, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:45:22,288 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:22,289 - INFO - __tests__.alter_compression.52198  - 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-07 19:45:22,289 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:22,289 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 14a54e95-86d7-4aa0-9cb8-a9509d6f2079, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:45:22,290 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 14a54e95-86d7-4aa0-9cb8-a9509d6f2079, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:45:22,291 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 14a54e95-86d7-4aa0-9cb8-a9509d6f2079, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:45:23,751 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:23,752 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:23,753 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 8360bbaf-4535-4650-9c67-93aaeaefbba6, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:45:23,754 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 8360bbaf-4535-4650-9c67-93aaeaefbba6, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:45:23,755 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 8360bbaf-4535-4650-9c67-93aaeaefbba6, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:45:24,236 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:24,237 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:24,238 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 1fb00477-1ca8-472e-a2d5-58a035385d70, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:45:24,239 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 1fb00477-1ca8-472e-a2d5-58a035385d70, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:45:24,242 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 1fb00477-1ca8-472e-a2d5-58a035385d70, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:45:25,164 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:25,165 - INFO - __tests__.alter_compression.52198  - 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-07 19:45:25,166 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:25,166 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 4b9de14b-b76e-4226-a148-8a48c74d545e, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:45:25,167 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 4b9de14b-b76e-4226-a148-8a48c74d545e, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:45:25,182 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 4b9de14b-b76e-4226-a148-8a48c74d545e, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:45:27,339 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:27,340 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:27,341 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, c0bde7f2-72f5-4af7-862a-ec9e210c11c8, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:45:27,342 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, c0bde7f2-72f5-4af7-862a-ec9e210c11c8, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:45:27,343 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, c0bde7f2-72f5-4af7-862a-ec9e210c11c8, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:45:28,027 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:28,028 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:28,028 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 14a95bac-cba3-41e4-8290-172421864159, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:45:28,029 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 14a95bac-cba3-41e4-8290-172421864159, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:45:28,046 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 14a95bac-cba3-41e4-8290-172421864159, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:45:28,939 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:28,940 - INFO - __tests__.alter_compression.52198  - 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-07 19:45:28,940 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:28,941 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, b9be77d0-4acd-4c0e-a188-0f303289a460, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:45:28,942 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, b9be77d0-4acd-4c0e-a188-0f303289a460, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:45:28,943 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, b9be77d0-4acd-4c0e-a188-0f303289a460, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:45:30,453 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:30,454 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:30,455 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 723b953c-1bfc-4480-99f3-8cc99afededa, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:45:30,456 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 723b953c-1bfc-4480-99f3-8cc99afededa, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:45:30,458 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 723b953c-1bfc-4480-99f3-8cc99afededa, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:45:31,067 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:31,068 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:31,069 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, d413f987-5cbf-4499-87df-84a5c69459b4, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:45:31,074 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, d413f987-5cbf-4499-87df-84a5c69459b4, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:45:31,076 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, d413f987-5cbf-4499-87df-84a5c69459b4, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:45:31,956 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:31,957 - INFO - __tests__.alter_compression.52198  - 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-07 19:45:31,958 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:31,958 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 95526700-7c1d-4948-8d13-c0a2d415daa9, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:45:31,960 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 95526700-7c1d-4948-8d13-c0a2d415daa9, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:45:31,961 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 95526700-7c1d-4948-8d13-c0a2d415daa9, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:45:33,433 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:33,434 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:33,434 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, f0bc9a03-ca02-45d2-91ab-fc798f2ddf66, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:45:33,436 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, f0bc9a03-ca02-45d2-91ab-fc798f2ddf66, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:45:33,437 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, f0bc9a03-ca02-45d2-91ab-fc798f2ddf66, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:45:34,037 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:34,038 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:34,039 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 34f2943b-8b9e-4731-af3c-69d435e8ca8c, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:45:34,040 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 34f2943b-8b9e-4731-af3c-69d435e8ca8c, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:45:34,041 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 34f2943b-8b9e-4731-af3c-69d435e8ca8c, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:45:35,787 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:35,788 - INFO - __tests__.alter_compression.52198  - 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-07 19:45:35,788 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:35,789 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 96b20fda-4798-4123-96dc-bbbb9cf925d9, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:45:35,790 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 96b20fda-4798-4123-96dc-bbbb9cf925d9, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:45:35,802 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 96b20fda-4798-4123-96dc-bbbb9cf925d9, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:45:37,417 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:37,418 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:37,418 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 7fd2d2f7-f709-43ad-9977-f6a8ba7a45dd, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:45:37,419 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 7fd2d2f7-f709-43ad-9977-f6a8ba7a45dd, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:45:37,424 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 7fd2d2f7-f709-43ad-9977-f6a8ba7a45dd, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:45:37,802 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:37,803 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:37,803 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 2ab53720-d983-47be-9052-6ed03aa7ba40, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:45:37,804 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 2ab53720-d983-47be-9052-6ed03aa7ba40, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:45:37,806 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 2ab53720-d983-47be-9052-6ed03aa7ba40, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:45:38,186 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:38,187 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:38,188 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 3ab375fc-5e91-486e-a3ab-1c3d418d5db0, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:45:38,189 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 3ab375fc-5e91-486e-a3ab-1c3d418d5db0, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:45:38,191 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 3ab375fc-5e91-486e-a3ab-1c3d418d5db0, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:45:42,901 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:52,947 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:52,948 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 9302f1df-4e6a-4512-a0be-340deeca2bea, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:45:52,949 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 9302f1df-4e6a-4512-a0be-340deeca2bea, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:45:52,951 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 9302f1df-4e6a-4512-a0be-340deeca2bea, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:45:59,056 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:59,124 - INFO - root.52198  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-12-07 19:45:59,125 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:45:59,126 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, cfc673a0-08c9-4875-9267-7ea15c9368f5, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:45:59,175 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, cfc673a0-08c9-4875-9267-7ea15c9368f5, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:45:59,176 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, cfc673a0-08c9-4875-9267-7ea15c9368f5, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:46:00,951 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.52198  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-07 19:46:00,952 - DEBUG - ydb.connection.52198  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-07 19:46:00,996 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.52198  - context_resolve: Resolving endpoints for database /Root
2025-12-07 19:46:00,996 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ListEndpoints, 879841cf-1433-484b-8496-ae6e4d8a4f5c, localhost:25369): creating call state
2025-12-07 19:46:00,997 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ListEndpoints, 879841cf-1433-484b-8496-ae6e4d8a4f5c, localhost:25369): request = { database: "/Root" }
2025-12-07 19:46:01,104 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ListEndpoints, 879841cf-1433-484b-8496-ae6e4d8a4f5c, localhost:25369): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-7gzmsyrbqy.auto.internal" port: 25369 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-07 19:46:01,105 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.52198  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-7gzmsyrbqy.auto.internal:25369, location 1, ssl: False>]>
2025-12-07 19:46:01,105 - DEBUG - ydb.connection.52198  - close: Closing channel for endpoint localhost:25369
2025-12-07 19:46:03,331 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:13,372 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:13,373 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 669459c4-b003-4e02-b875-309d217c82a5, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:46:13,374 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 669459c4-b003-4e02-b875-309d217c82a5, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:46:13,375 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 669459c4-b003-4e02-b875-309d217c82a5, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:46:14,512 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:24,518 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:24,536 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 61f86563-c6f8-46e1-b06d-41b18a72b855, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:46:24,537 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 61f86563-c6f8-46e1-b06d-41b18a72b855, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:46:24,555 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 61f86563-c6f8-46e1-b06d-41b18a72b855, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:46:26,083 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:26,088 - INFO - root.52198  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8009216)
2025-12-07 19:46:26,099 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:26,100 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, c52a3c16-2045-4524-8919-332ed2d98278, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:46:26,100 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, c52a3c16-2045-4524-8919-332ed2d98278, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" 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-07 19:46:26,115 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, c52a3c16-2045-4524-8919-332ed2d98278, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:46:27,072 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:27,075 - INFO - ya.test.52198  - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_compression-COMPRESSION = "zstd"])
2025-12-07 19:46:27,076 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:27,077 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 64a20042-4368-401c-9e05-757cda049e85, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:46:27,078 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 64a20042-4368-401c-9e05-757cda049e85, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\")\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-07 19:46:27,080 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 64a20042-4368-401c-9e05-757cda049e85, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:46:33,886 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:33,887 - INFO - __tests__.alter_compression.52198  - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_compression created
2025-12-07 19:46:33,888 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:33,888 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, a6aea2b3-15e3-4b07-a90a-5fc42532dde8, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:46:33,889 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, a6aea2b3-15e3-4b07-a90a-5fc42532dde8, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:46:33,892 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, a6aea2b3-15e3-4b07-a90a-5fc42532dde8, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:46:35,170 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:35,171 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:35,172 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 3b32a8d4-a440-441d-aae1-c39114a507ca, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:46:35,173 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 3b32a8d4-a440-441d-aae1-c39114a507ca, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 0;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_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-07 19:46:35,174 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 3b32a8d4-a440-441d-aae1-c39114a507ca, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:46:38,018 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:38,019 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:38,020 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 37a5e571-1180-43f1-8307-e7ed382c3558, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:46:38,020 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 37a5e571-1180-43f1-8307-e7ed382c3558, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_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-07 19:46:38,022 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 37a5e571-1180-43f1-8307-e7ed382c3558, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:46:39,156 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:39,157 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:39,157 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 9cf3c5eb-b4a9-4613-891a-d2a0a8d2581a, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:46:39,159 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 9cf3c5eb-b4a9-4613-891a-d2a0a8d2581a, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_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-07 19:46:39,161 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 9cf3c5eb-b4a9-4613-891a-d2a0a8d2581a, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:46:42,316 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:42,317 - INFO - __tests__.alter_compression.52198  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318880, 'BlobCount': 128}}
2025-12-07 19:46:42,317 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:42,318 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 04a39a3e-fcef-43d2-84c4-02ff58d7561c, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:46:42,319 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 04a39a3e-fcef-43d2-84c4-02ff58d7561c, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 100000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_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-07 19:46:42,332 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 04a39a3e-fcef-43d2-84c4-02ff58d7561c, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:46:44,486 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:44,487 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:44,488 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 52275f51-1862-4089-bcef-1de9f93255c2, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:46:44,489 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 52275f51-1862-4089-bcef-1de9f93255c2, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_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-07 19:46:44,494 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 52275f51-1862-4089-bcef-1de9f93255c2, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:46:44,810 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:44,811 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:44,812 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 04e4ace5-0406-4898-beb3-7bd475cf5cbb, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:46:44,812 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 04e4ace5-0406-4898-beb3-7bd475cf5cbb, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_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-07 19:46:44,813 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 04e4ace5-0406-4898-beb3-7bd475cf5cbb, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:46:45,360 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:45,360 - INFO - __tests__.alter_compression.52198  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 638384, 'BlobCount': 256}}
2025-12-07 19:46:45,361 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:45,362 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 1c594bb3-5743-422e-bcbd-2198bef2ccb3, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:46:45,363 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 1c594bb3-5743-422e-bcbd-2198bef2ccb3, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 200000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_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-07 19:46:45,364 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 1c594bb3-5743-422e-bcbd-2198bef2ccb3, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:46:47,451 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:47,452 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:47,453 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 2408a110-8e75-4605-b665-e1a4bf8ecfe3, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:46:47,454 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 2408a110-8e75-4605-b665-e1a4bf8ecfe3, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_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-07 19:46:47,458 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 2408a110-8e75-4605-b665-e1a4bf8ecfe3, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:46:48,471 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:48,472 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:48,473 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, f62b9eb4-b761-47a7-91b7-3a158ab38afc, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:46:48,478 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, f62b9eb4-b761-47a7-91b7-3a158ab38afc, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_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-07 19:46:48,480 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, f62b9eb4-b761-47a7-91b7-3a158ab38afc, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:46:49,532 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:49,532 - INFO - __tests__.alter_compression.52198  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 957552, 'BlobCount': 384}}
2025-12-07 19:46:49,533 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:49,533 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, b717df17-f6d3-40ee-83f8-2b38011deb4d, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:46:49,534 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, b717df17-f6d3-40ee-83f8-2b38011deb4d, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 300000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_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-07 19:46:49,539 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, b717df17-f6d3-40ee-83f8-2b38011deb4d, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:46:51,102 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:51,103 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:51,104 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 66653ba6-943e-4bff-b06f-f15d7defcaec, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:46:51,105 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 66653ba6-943e-4bff-b06f-f15d7defcaec, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_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-07 19:46:51,108 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 66653ba6-943e-4bff-b06f-f15d7defcaec, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:46:51,677 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:51,678 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:51,679 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 59c325e5-85d1-4448-8f15-e457f2084c8b, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:46:51,679 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 59c325e5-85d1-4448-8f15-e457f2084c8b, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_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-07 19:46:51,696 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 59c325e5-85d1-4448-8f15-e457f2084c8b, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:46:52,935 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:52,935 - INFO - __tests__.alter_compression.52198  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1277056, 'BlobCount': 512}}
2025-12-07 19:46:52,936 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:52,936 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, a5b7ea10-db7c-4419-bd35-4af8f22228d8, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:46:52,937 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, a5b7ea10-db7c-4419-bd35-4af8f22228d8, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 400000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_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-07 19:46:52,953 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, a5b7ea10-db7c-4419-bd35-4af8f22228d8, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:46:56,066 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:56,067 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:56,068 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 14cce101-a9e3-4b7a-a178-2a2660adb705, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:46:56,068 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 14cce101-a9e3-4b7a-a178-2a2660adb705, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_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-07 19:46:56,070 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 14cce101-a9e3-4b7a-a178-2a2660adb705, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:46:56,875 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:56,876 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:56,877 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, a7493755-58ac-433d-83a3-824c716ba96c, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:46:56,882 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, a7493755-58ac-433d-83a3-824c716ba96c, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_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-07 19:46:56,884 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, a7493755-58ac-433d-83a3-824c716ba96c, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:46:57,734 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:57,735 - INFO - __tests__.alter_compression.52198  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1596256, 'BlobCount': 640}}
2025-12-07 19:46:57,736 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:57,736 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 9c9361e9-4cda-49bd-b42a-790df58b58a7, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:46:57,737 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 9c9361e9-4cda-49bd-b42a-790df58b58a7, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 500000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_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-07 19:46:57,755 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 9c9361e9-4cda-49bd-b42a-790df58b58a7, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:46:58,978 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:58,979 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:58,980 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, d96436bd-108e-4687-a5a6-1d41afee85d1, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:46:58,981 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, d96436bd-108e-4687-a5a6-1d41afee85d1, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_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-07 19:46:58,982 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, d96436bd-108e-4687-a5a6-1d41afee85d1, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:46:59,328 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:59,329 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:59,330 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, ed72cefb-1213-4c10-b85d-6c5603e7a80b, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:46:59,331 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, ed72cefb-1213-4c10-b85d-6c5603e7a80b, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_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-07 19:46:59,334 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, ed72cefb-1213-4c10-b85d-6c5603e7a80b, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:46:59,946 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:59,946 - INFO - __tests__.alter_compression.52198  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1915600, 'BlobCount': 768}}
2025-12-07 19:46:59,947 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:46:59,947 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, ec27b1b2-94b2-4757-9733-c97ee0e5e89d, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:46:59,948 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, ec27b1b2-94b2-4757-9733-c97ee0e5e89d, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 600000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_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-07 19:46:59,954 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, ec27b1b2-94b2-4757-9733-c97ee0e5e89d, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:47:01,563 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:47:01,564 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:47:01,564 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 5973bacb-fbea-44ff-b83e-a6f5526caaf0, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:47:01,565 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 5973bacb-fbea-44ff-b83e-a6f5526caaf0, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_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-07 19:47:01,572 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 5973bacb-fbea-44ff-b83e-a6f5526caaf0, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:47:02,320 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:47:02,320 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:47:02,321 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 25de0a58-0e4c-421e-9845-19d299e955bc, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:47:02,322 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 25de0a58-0e4c-421e-9845-19d299e955bc, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_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-07 19:47:02,324 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 25de0a58-0e4c-421e-9845-19d299e955bc, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:47:04,654 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:47:04,655 - INFO - __tests__.alter_compression.52198  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2234896, 'BlobCount': 896}}
2025-12-07 19:47:04,656 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:47:04,657 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 56435638-ac54-49b3-b8b0-5b8e863e2416, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:47:04,658 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 56435638-ac54-49b3-b8b0-5b8e863e2416, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 700000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_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-07 19:47:04,659 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 56435638-ac54-49b3-b8b0-5b8e863e2416, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:47:06,297 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:47:06,298 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:47:06,298 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, a677ae75-3fd8-49af-a3de-49490cbd6f7f, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:47:06,299 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, a677ae75-3fd8-49af-a3de-49490cbd6f7f, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_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-07 19:47:06,301 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, a677ae75-3fd8-49af-a3de-49490cbd6f7f, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:47:06,924 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:47:06,925 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:47:06,926 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 921799c0-ad37-4e29-90d5-5d69093acd33, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:47:06,927 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 921799c0-ad37-4e29-90d5-5d69093acd33, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_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-07 19:47:06,930 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 921799c0-ad37-4e29-90d5-5d69093acd33, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:47:07,584 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:47:07,585 - INFO - __tests__.alter_compression.52198  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2554464, 'BlobCount': 1024}}
2025-12-07 19:47:07,586 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:47:07,586 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 163d6abe-e919-41ff-a63e-06bc9db61db2, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:47:07,587 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 163d6abe-e919-41ff-a63e-06bc9db61db2, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 800000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_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-07 19:47:07,588 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 163d6abe-e919-41ff-a63e-06bc9db61db2, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:47:09,477 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:47:09,478 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:47:09,478 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 641b98ed-a87a-4c33-8017-1bab58856986, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:47:09,479 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 641b98ed-a87a-4c33-8017-1bab58856986, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_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-07 19:47:09,481 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 641b98ed-a87a-4c33-8017-1bab58856986, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:47:09,846 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:47:09,847 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:47:09,847 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, b0a25a51-926f-4915-b406-0a038b2a1e1f, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:47:09,848 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, b0a25a51-926f-4915-b406-0a038b2a1e1f, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_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-07 19:47:09,850 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, b0a25a51-926f-4915-b406-0a038b2a1e1f, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:47:12,361 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:47:12,362 - INFO - __tests__.alter_compression.52198  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2873568, 'BlobCount': 1152}}
2025-12-07 19:47:12,362 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:47:12,363 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 58b62dc2-c934-476f-89e9-6ad84b516072, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:47:12,364 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 58b62dc2-c934-476f-89e9-6ad84b516072, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 900000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_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-07 19:47:12,365 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 58b62dc2-c934-476f-89e9-6ad84b516072, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:47:14,979 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:47:14,980 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:47:14,981 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 26692140-d254-461b-8689-053875d5a374, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:47:14,982 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 26692140-d254-461b-8689-053875d5a374, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_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-07 19:47:14,987 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 26692140-d254-461b-8689-053875d5a374, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:47:16,183 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:47:16,184 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:47:16,184 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 298cba2a-71b3-4706-9ffc-aa949320e7fe, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:47:16,185 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 298cba2a-71b3-4706-9ffc-aa949320e7fe, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_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-07 19:47:16,190 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 298cba2a-71b3-4706-9ffc-aa949320e7fe, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:47:17,805 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:47:17,894 - INFO - __tests__.alter_compression.52198  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3193216, 'BlobCount': 1280}}
2025-12-07 19:47:18,084 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:47:18,291 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 871f2afb-e054-4d61-b6e6-e4e955d36de9, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:47:18,292 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 871f2afb-e054-4d61-b6e6-e4e955d36de9, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:47:18,293 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 871f2afb-e054-4d61-b6e6-e4e955d36de9, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:47:20,653 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:47:20,654 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:47:20,654 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 9c73a977-50ca-4c8c-988c-5e7fa17ed0a2, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:47:20,655 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 9c73a977-50ca-4c8c-988c-5e7fa17ed0a2, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_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-07 19:47:20,657 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 9c73a977-50ca-4c8c-988c-5e7fa17ed0a2, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:47:21,143 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:47:21,144 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:47:21,145 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 19515eeb-bcfd-4b0f-8f2b-78195b6568d1, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:47:21,146 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 19515eeb-bcfd-4b0f-8f2b-78195b6568d1, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_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-07 19:47:21,147 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 19515eeb-bcfd-4b0f-8f2b-78195b6568d1, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:47:22,203 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:47:22,204 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:47:22,205 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 850d34af-3f92-468d-9b88-cf5a1a8986d6, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:47:22,206 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 850d34af-3f92-468d-9b88-cf5a1a8986d6, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_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-07 19:47:22,213 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 850d34af-3f92-468d-9b88-cf5a1a8986d6, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:47:28,869 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:47:38,937 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:47:38,938 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, ef607528-3c35-4a9b-a3e4-d5c1e82e4467, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:47:38,939 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, ef607528-3c35-4a9b-a3e4-d5c1e82e4467, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_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-07 19:47:38,941 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, ef607528-3c35-4a9b-a3e4-d5c1e82e4467, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:47:41,117 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.52198  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-07 19:47:41,117 - DEBUG - ydb.connection.52198  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-07 19:47:41,130 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.52198  - context_resolve: Resolving endpoints for database /Root
2025-12-07 19:47:41,130 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ListEndpoints, f8476618-e850-472c-9f71-1d20a7fab624, localhost:25369): creating call state
2025-12-07 19:47:41,131 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ListEndpoints, f8476618-e850-472c-9f71-1d20a7fab624, localhost:25369): request = { database: "/Root" }
2025-12-07 19:47:41,136 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ListEndpoints, f8476618-e850-472c-9f71-1d20a7fab624, localhost:25369): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-7gzmsyrbqy.auto.internal" port: 25369 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-07 19:47:41,137 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.52198  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-7gzmsyrbqy.auto.internal:25369, location 1, ssl: False>]>
2025-12-07 19:47:41,138 - DEBUG - ydb.connection.52198  - close: Closing channel for endpoint localhost:25369
2025-12-07 19:47:41,365 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:47:51,378 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:47:51,380 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 890b5248-6466-4af6-9c20-59f5cce144ff, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:47:51,380 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 890b5248-6466-4af6-9c20-59f5cce144ff, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_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-07 19:47:51,384 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 890b5248-6466-4af6-9c20-59f5cce144ff, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:47:52,727 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:48:02,734 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:48:02,735 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, c7ff67fc-7f3f-4d3b-9b33-ea9c359a76bb, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:48:02,736 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, c7ff67fc-7f3f-4d3b-9b33-ea9c359a76bb, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_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-07 19:48:02,737 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, c7ff67fc-7f3f-4d3b-9b33-ea9c359a76bb, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:48:03,412 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:48:03,415 - INFO - root.52198  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_compression`, volumes `value` (8000000, 1465272)
2025-12-07 19:48:03,416 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:48:03,417 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 12c39d4d-d8d8-4464-9067-a075acaa9b0e, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:48:03,417 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 12c39d4d-d8d8-4464-9067-a075acaa9b0e, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_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-07 19:48:03,419 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 12c39d4d-d8d8-4464-9067-a075acaa9b0e, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:48:03,903 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:48:03,904 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:48:03,905 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, 8b4728fb-1304-422d-98af-c43bc4ddff39, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:48:03,906 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, 8b4728fb-1304-422d-98af-c43bc4ddff39, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_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-07 19:48:03,911 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, 8b4728fb-1304-422d-98af-c43bc4ddff39, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:48:04,806 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:48:14,813 - DEBUG - ydb.query.pool.52198  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:48:14,814 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(ExecuteQuery, df81ce9a-29b2-4c09-b956-ab1811c435c0, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:48:14,815 - DEBUG - ydb.connection.52198  - _log_request: RpcState(ExecuteQuery, df81ce9a-29b2-4c09-b956-ab1811c435c0, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_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-07 19:48:14,818 - DEBUG - ydb.connection.52198  - _log_response: RpcState(ExecuteQuery, df81ce9a-29b2-4c09-b956-ab1811c435c0, ghrun-7gzmsyrbqy.auto.internal:25369): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:48:15,884 - DEBUG - ydb.query.pool.52198  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=
2025-12-07 19:48:15,892 - INFO - root.52198  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_compression`, volumes `value` (8000000, 1465272)
2025-12-07 19:48:15,921 - INFO - root.52198  - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_compression` 8092160 / 1465272: 5.522633340430992
2025-12-07 19:48:15,934 - INFO - ya.test.52198  - pytest_runtest_teardown: Test teardown
2025-12-07 19:48:15,935 - DEBUG - ydb.connection.52198  - _prepare_call: RpcState(DeleteSession, 77596e15-10c6-445c-8552-74752740c013, ghrun-7gzmsyrbqy.auto.internal:25369): creating call state
2025-12-07 19:48:15,936 - DEBUG - ydb.connection.52198  - _log_request: RpcState(DeleteSession, 77596e15-10c6-445c-8552-74752740c013, ghrun-7gzmsyrbqy.auto.internal:25369): request = { session_id: "ydb://session/3?node_id=1&id=M2I1MmM2Y2UtZDE3NzAxYTMtNDdhM2Y4MjQtMjYwMjQ1OGM=" }
2025-12-07 19:48:15,944 - DEBUG - ydb.connection.52198  - _log_response: RpcState(DeleteSession, 77596e15-10c6-445c-8552-74752740c013, ghrun-7gzmsyrbqy.auto.internal:25369): response = { status: SUCCESS }
2025-12-07 19:48:15,945 - DEBUG - ydb.query.pool.52198  - stop: All session were deleted.
2025-12-07 19:48:15,945 - DEBUG - ydb.topic.52198  - close: Close topic client
2025-12-07 19:48:15,945 - DEBUG - ydb.topic.52198  - close: Topic client was closed
2025-12-07 19:48:15,946 - DEBUG - ydb.connection.52198  - close: Closing channel for endpoint localhost:25369
2025-12-07 19:48:15,950 - DEBUG - ydb.connection.52198  - close: Closing channel for endpoint ghrun-7gzmsyrbqy.auto.internal:25369
2025-12-07 19:48:15,952 - INFO - ydb.pool.Discovery.52198  - run: Successfully terminated discovery process
2025-12-07 19:48:32,974 - INFO - ydb.tests.library.harness.kikimr_runner.52198  - stop: Stopped node localhost:25369/1
2025-12-07 19:48:33,005 - DEBUG - library.python.filelock.52198  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/63312
2025-12-07 19:48:33,006 - DEBUG - library.python.filelock.52198  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/18972
2025-12-07 19:48:33,006 - DEBUG - library.python.filelock.52198  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/23515
2025-12-07 19:48:33,006 - DEBUG - library.python.filelock.52198  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/25369
2025-12-07 19:48:33,007 - DEBUG - library.python.filelock.52198  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/19849
