2025-12-23 15:26:43,509 - INFO - ya.test.733815  - pytest_runtest_setup: ####################################################################################################
2025-12-23 15:26:43,509 - INFO - ya.test.733815  - pytest_runtest_setup: test_all_supported_compression[zstd_compression-COMPRESSION = "zstd"]
2025-12-23 15:26:43,510 - INFO - ya.test.733815  - pytest_runtest_setup: ####################################################################################################
2025-12-23 15:26:43,510 - INFO - ya.test.733815  - pytest_runtest_setup: Test setup
2025-12-23 15:26:43,513 - DEBUG - ya.test.733815  - _get_command_output_file: Command out will be placed to ydbd.out
2025-12-23 15:26:43,513 - DEBUG - ya.test.733815  - _get_command_output_file: Command err will be placed to ydbd.err
2025-12-23 15:26:43,514 - DEBUG - ya.test.733815  - execute: Executing '['/home/runner/.ya/build/build_root/p2vv/001f63/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-12-23 15:26:43,517 - DEBUG - ya.test.733815  - execute: Command pid: 736509
2025-12-23 15:26:44,464 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 736509) rc: 0
2025-12-23 15:26:44,464 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 736509) elapsed time (sec): 0.9455559253692627
2025-12-23 15:26:44,465 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 736509) idrss: 0
2025-12-23 15:26:44,471 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 736509) inblock: 0
2025-12-23 15:26:44,472 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 736509) isrss: 0
2025-12-23 15:26:44,472 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 736509) ixrss: 0
2025-12-23 15:26:44,473 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 736509) majflt: 0
2025-12-23 15:26:44,473 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 736509) maxrss: 483668
2025-12-23 15:26:44,473 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 736509) minflt: 45847
2025-12-23 15:26:44,473 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 736509) msgrcv: 0
2025-12-23 15:26:44,474 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 736509) msgsnd: 0
2025-12-23 15:26:44,474 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 736509) nivcsw: 227
2025-12-23 15:26:44,474 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 736509) nsignals: 0
2025-12-23 15:26:44,474 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 736509) nswap: 0
2025-12-23 15:26:44,475 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 736509) nvcsw: 14
2025-12-23 15:26:44,479 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 736509) oublock: 8
2025-12-23 15:26:44,480 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 736509) stime: 0.252004
2025-12-23 15:26:44,480 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 736509) utime: 0.5189889999999999
2025-12-23 15:26:44,480 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 736509) wtime: 0.949
2025-12-23 15:26:44,481 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 736509) output:
Git info:
    Commit: 3721e81110a4ca0f02ed59c4d99ef3713666bc76
    Branch: 
    Author: Alexey Efimov <xeno@prnwatch.com>
    Summary: Merge ce87dd182c77f9bcd7fcbbd7a5787626f73db5bf into 54d3846fcfd20f009eeeabbfe05c19f647cd92d0
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-hclevy2dda    Host information: 
        Linux ghrun-hclevy2dda 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

     
Build info:
    Compiler: /home/runner/.ya/tools/v4/10492077879/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/10492077879/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -DCATBOOST_OPENSOURCE=yes -fsanitize=address -Daddress_sanitizer_enabled -fno-omit-frame-pointer -fsanitize-blacklist=/home/runner/actions_runner/_work/ydb/ydb/build/sanitize-blacklist.txt -fno-sanitize-link-runtime -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -std=c++20 -Wimport-preprocessor-directive-pedantic -Woverloaded-virtual -Wno-ambiguous-reversed-operator -Wno-defaulted-function-deleted -Wno-deprecated-anon-enum-enum-conversion -Wno-deprecated-enum-enum-conversion -Wno-deprecated-enum-float-conversion -Wno-deprecated-volatile -Wno-pessimizing-move -Wno-undefined-var-template -nostdinc++ -DCATBOOST_OPENSOURCE=yes -nostdinc++

2025-12-23 15:26:44,481 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 736509) errors:

2025-12-23 15:26:44,482 - INFO - __tests__.base.733815  - _setup_ydb: Git info:
    Commit: 3721e81110a4ca0f02ed59c4d99ef3713666bc76
    Branch: 
    Author: Alexey Efimov <xeno@prnwatch.com>
    Summary: Merge ce87dd182c77f9bcd7fcbbd7a5787626f73db5bf into 54d3846fcfd20f009eeeabbfe05c19f647cd92d0
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-hclevy2dda    Host information: 
        Linux ghrun-hclevy2dda 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

     
Build info:
    Compiler: /home/runner/.ya/tools/v4/10492077879/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/10492077879/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -DCATBOOST_OPENSOURCE=yes -fsanitize=address -Daddress_sanitizer_enabled -fno-omit-frame-pointer -fsanitize-blacklist=/home/runner/actions_runner/_work/ydb/ydb/build/sanitize-blacklist.txt -fno-sanitize-link-runtime -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -std=c++20 -Wimport-preprocessor-directive-pedantic -Woverloaded-virtual -Wno-ambiguous-reversed-operator -Wno-defaulted-function-deleted -Wno-deprecated-anon-enum-enum-conversion -Wno-deprecated-enum-enum-conversion -Wno-deprecated-enum-float-conversion -Wno-deprecated-volatile -Wno-pessimizing-move -Wno-undefined-var-template -nostdinc++ -DCATBOOST_OPENSOURCE=yes -nostdinc++

2025-12-23 15:26:44,658 - DEBUG - ya.test.733815  - get_binary: Binary was found by /home/runner/.ya/build/build_root/p2vv/001f63/ydb/apps/ydbd/ydbd
2025-12-23 15:26:44,665 - DEBUG - library.python.filelock.733815  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/12511
2025-12-23 15:26:44,668 - DEBUG - ydb.tests.library.harness.kikimr_runner.733815  - start: Working directory: /home/runner/.ya/build/build_root/p2vv/001f63/r3tmp/kikimr_cluster_xknhjexh
2025-12-23 15:26:44,768 - DEBUG - ya.test.733815  - get_binary: Binary was found by /home/runner/.ya/build/build_root/p2vv/001f63/ydb/apps/ydbd/ydbd
2025-12-23 15:26:44,772 - DEBUG - library.python.filelock.733815  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/19447
2025-12-23 15:26:44,772 - DEBUG - library.python.filelock.733815  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/19448
2025-12-23 15:26:44,773 - DEBUG - library.python.filelock.733815  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/4655
2025-12-23 15:26:44,774 - DEBUG - library.python.filelock.733815  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/16456
2025-12-23 15:26:44,774 - DEBUG - library.python.filelock.733815  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/63569
2025-12-23 15:26:44,776 - INFO - ydb.tests.library.harness.kikimr_runner.733815  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/p2vv/001f63/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-23 15:26:44,776 - INFO - ydb.tests.library.harness.kikimr_runner.733815  - __make_run_command: Final command: /home/runner/.ya/build/build_root/p2vv/001f63/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/p2vv/001f63/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_d_h339z6.log --grpc-port=19448 --mon-port=4655 --ic-port=12511
2025-12-23 15:26:44,777 - DEBUG - ydb.tests.library.harness.kikimr_runner.733815  - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:19448/1, disk_size 68719476736
2025-12-23 15:26:44,778 - INFO - ydb.tests.library.harness.kikimr_runner.733815  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/p2vv/001f63/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-23 15:26:44,778 - INFO - ydb.tests.library.harness.kikimr_runner.733815  - __make_run_command: Final command: /home/runner/.ya/build/build_root/p2vv/001f63/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/p2vv/001f63/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_d_h339z6.log --grpc-port=19448 --mon-port=4655 --ic-port=12511
2025-12-23 15:26:44,780 - DEBUG - ya.test.733815  - execute: Executing '('/home/runner/.ya/build/build_root/p2vv/001f63/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/p2vv/001f63/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/p2vv/001f63/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_d_h339z6.log', '--grpc-port=19448', '--mon-port=4655', '--ic-port=12511')' in '/home/runner/.ya/build/build_root/p2vv/001f63/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-23 15:26:44,784 - DEBUG - ya.test.733815  - execute: Command pid: 737206
2025-12-23 15:26:44,785 - INFO - ydb.tests.library.harness.kikimr_runner.733815  - start: Started node localhost:19448/1
2025-12-23 15:26:44,786 - DEBUG - ya.test.733815  - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-12-23 15:26:44,794 - DEBUG - ya.test.733815  - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-12-23 15:26:44,794 - DEBUG - ya.test.733815  - execute: Executing '['/home/runner/.ya/build/build_root/p2vv/001f63/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-12-23 15:26:44,805 - DEBUG - ya.test.733815  - execute: Command pid: 737209
2025-12-23 15:26:45,883 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 737209) rc: 0
2025-12-23 15:26:45,884 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 737209) elapsed time (sec): 1.071199893951416
2025-12-23 15:26:45,884 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 737209) idrss: 0
2025-12-23 15:26:45,884 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 737209) inblock: 0
2025-12-23 15:26:45,885 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 737209) isrss: 0
2025-12-23 15:26:45,885 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 737209) ixrss: 0
2025-12-23 15:26:45,886 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 737209) majflt: 0
2025-12-23 15:26:45,886 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 737209) maxrss: 489788
2025-12-23 15:26:45,886 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 737209) minflt: 45874
2025-12-23 15:26:45,887 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 737209) msgrcv: 0
2025-12-23 15:26:45,887 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 737209) msgsnd: 0
2025-12-23 15:26:45,887 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 737209) nivcsw: 272
2025-12-23 15:26:45,888 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 737209) nsignals: 0
2025-12-23 15:26:45,888 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 737209) nswap: 0
2025-12-23 15:26:45,888 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 737209) nvcsw: 14
2025-12-23 15:26:45,889 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 737209) oublock: 8
2025-12-23 15:26:45,889 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 737209) stime: 0.200814
2025-12-23 15:26:45,889 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 737209) utime: 0.5980369999999999
2025-12-23 15:26:45,890 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 737209) wtime: 1.088
2025-12-23 15:26:45,890 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 737209) output:
Git info:
    Commit: 3721e81110a4ca0f02ed59c4d99ef3713666bc76
    Branch: 
    Author: Alexey Efimov <xeno@prnwatch.com>
    Summary: Merge ce87dd182c77f9bcd7fcbbd7a5787626f73db5bf into 54d3846fcfd20f009eeeabbfe05c19f647cd92d0
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-hclevy2dda    Host information: 
        Linux ghrun-hclevy2dda 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

     
Build info:
    Compiler: /home/runner/.ya/tools/v4/10492077879/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/10492077879/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -DCATBOOST_OPENSOURCE=yes -fsanitize=address -Daddress_sanitizer_enabled -fno-omit-frame-pointer -fsanitize-blacklist=/home/runner/actions_runner/_work/ydb/ydb/build/sanitize-blacklist.txt -fno-sanitize-link-runtime -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -std=c++20 -Wimport-preprocessor-directive-pedantic -Woverloaded-virtual -Wno-ambiguous-reversed-operator -Wno-defaulted-function-deleted -Wno-deprecated-anon-enum-enum-conversion -Wno-deprecated-enum-enum-conversion -Wno-deprecated-enum-float-conversion -Wno-deprecated-volatile -Wno-pessimizing-move -Wno-undefined-var-template -nostdinc++ -DCATBOOST_OPENSOURCE=yes -nostdinc++

2025-12-23 15:26:45,891 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 737209) errors:

2025-12-23 15:26:45,891 - INFO - ydb.tests.library.harness.kikimr_runner.733815  - start: Node 1 version:
Git info:
    Commit: 3721e81110a4ca0f02ed59c4d99ef3713666bc76
    Branch: 
    Author: Alexey Efimov <xeno@prnwatch.com>
    Summary: Merge ce87dd182c77f9bcd7fcbbd7a5787626f73db5bf into 54d3846fcfd20f009eeeabbfe05c19f647cd92d0
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-hclevy2dda    Host information: 
        Linux ghrun-hclevy2dda 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64
2025-12-23 15:26:51,289 - DEBUG - ya.test.733815  - get_binary: Binary was found by /home/runner/.ya/build/build_root/p2vv/001f63/ydb/apps/ydbd/ydbd
2025-12-23 15:26:51,289 - DEBUG - ydb.tests.library.harness.kikimr_runner.733815  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/p2vv/001f63/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:19448', '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: 12511\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-12-23 15:26:51,291 - DEBUG - ya.test.733815  - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-12-23 15:26:51,293 - DEBUG - ya.test.733815  - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-12-23 15:26:51,293 - DEBUG - ya.test.733815  - execute: Executing '['/home/runner/.ya/build/build_root/p2vv/001f63/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:19448', '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: 12511\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-12-23 15:26:51,300 - DEBUG - ya.test.733815  - execute: Command pid: 741295
2025-12-23 15:26:52,651 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 741295) rc: 0
2025-12-23 15:26:52,652 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 741295) elapsed time (sec): 1.3496129512786865
2025-12-23 15:26:52,652 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 741295) idrss: 0
2025-12-23 15:26:52,652 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 741295) inblock: 0
2025-12-23 15:26:52,652 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 741295) isrss: 0
2025-12-23 15:26:52,653 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 741295) ixrss: 0
2025-12-23 15:26:52,653 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 741295) majflt: 0
2025-12-23 15:26:52,653 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 741295) maxrss: 593720
2025-12-23 15:26:52,654 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 741295) minflt: 52358
2025-12-23 15:26:52,654 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 741295) msgrcv: 0
2025-12-23 15:26:52,654 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 741295) msgsnd: 0
2025-12-23 15:26:52,654 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 741295) nivcsw: 264
2025-12-23 15:26:52,655 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 741295) nsignals: 0
2025-12-23 15:26:52,678 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 741295) nswap: 0
2025-12-23 15:26:52,678 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 741295) nvcsw: 499
2025-12-23 15:26:52,678 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 741295) oublock: 8
2025-12-23 15:26:52,679 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 741295) stime: 0.31860299999999997
2025-12-23 15:26:52,679 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 741295) utime: 0.575434
2025-12-23 15:26:52,679 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 741295) wtime: 1.357
2025-12-23 15:26:52,680 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 741295) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-12-23 15:26:52,680 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 741295) errors:

2025-12-23 15:26:52,681 - DEBUG - ya.test.733815  - get_binary: Binary was found by /home/runner/.ya/build/build_root/p2vv/001f63/ydb/apps/ydbd/ydbd
2025-12-23 15:26:52,682 - DEBUG - ydb.tests.library.harness.kikimr_runner.733815  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/p2vv/001f63/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:19448', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']
2025-12-23 15:26:52,709 - DEBUG - ya.test.733815  - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-12-23 15:26:52,710 - DEBUG - ya.test.733815  - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-12-23 15:26:52,710 - DEBUG - ya.test.733815  - execute: Executing '['/home/runner/.ya/build/build_root/p2vv/001f63/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:19448', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']' in 'None' (waiting)
2025-12-23 15:26:52,722 - DEBUG - ya.test.733815  - execute: Command pid: 742691
2025-12-23 15:26:54,230 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 742691) rc: 0
2025-12-23 15:26:54,231 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 742691) elapsed time (sec): 1.507282018661499
2025-12-23 15:26:54,231 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 742691) idrss: 0
2025-12-23 15:26:54,231 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 742691) inblock: 0
2025-12-23 15:26:54,231 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 742691) isrss: 0
2025-12-23 15:26:54,231 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 742691) ixrss: 0
2025-12-23 15:26:54,232 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 742691) majflt: 0
2025-12-23 15:26:54,232 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 742691) maxrss: 594436
2025-12-23 15:26:54,232 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 742691) minflt: 52256
2025-12-23 15:26:54,232 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 742691) msgrcv: 0
2025-12-23 15:26:54,233 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 742691) msgsnd: 0
2025-12-23 15:26:54,233 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 742691) nivcsw: 272
2025-12-23 15:26:54,233 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 742691) nsignals: 0
2025-12-23 15:26:54,233 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 742691) nswap: 0
2025-12-23 15:26:54,234 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 742691) nvcsw: 578
2025-12-23 15:26:54,234 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 742691) oublock: 8
2025-12-23 15:26:54,234 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 742691) stime: 0.283444
2025-12-23 15:26:54,234 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 742691) utime: 0.548952
2025-12-23 15:26:54,235 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 742691) wtime: 1.519
2025-12-23 15:26:54,235 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 742691) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-12-23 15:26:54,236 - DEBUG - ya.test.733815  - _save_outputs: Command (pid 742691) errors:

2025-12-23 15:26:54,236 - INFO - ydb.tests.library.harness.kikimr_runner.733815  - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-12-23 15:26:54,376 - INFO - ydb.tests.library.harness.kikimr_runner.733815  - __run: Cluster started and initialized
2025-12-23 15:26:54,433 - DEBUG - ydb.connection.733815  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-23 15:26:54,446 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.733815  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-23 15:26:54,447 - DEBUG - ydb.connection.733815  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-23 15:26:54,504 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.733815  - context_resolve: Resolving endpoints for database /Root
2025-12-23 15:26:54,505 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ListEndpoints, ad40fd48-04fe-4fa5-b22d-b60a5e473c9a, localhost:19448): creating call state
2025-12-23 15:26:54,506 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ListEndpoints, ad40fd48-04fe-4fa5-b22d-b60a5e473c9a, localhost:19448): request = { database: "/Root" }
2025-12-23 15:26:54,514 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ListEndpoints, ad40fd48-04fe-4fa5-b22d-b60a5e473c9a, localhost:19448): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-hclevy2dda.auto.internal" port: 19448 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-12-23 15:26:54,515 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.733815  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-hclevy2dda.auto.internal:19448, location 1, ssl: False>]>
2025-12-23 15:26:54,516 - DEBUG - ydb.connection.733815  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-23 15:26:54,537 - DEBUG - ydb.connection.733815  - close: Closing channel for endpoint localhost:19448
2025-12-23 15:26:54,538 - DEBUG - ydb.query.pool.733815  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-23 15:26:54,539 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(CreateSession, 15a0f3a8-9942-4e4c-8cbe-d51c2aa23dc3, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:26:54,539 - DEBUG - ydb.connection.733815  - _log_request: RpcState(CreateSession, 15a0f3a8-9942-4e4c-8cbe-d51c2aa23dc3, ghrun-hclevy2dda.auto.internal:19448): request = {  }
2025-12-23 15:26:54,553 - DEBUG - ydb.connection.733815  - _log_response: RpcState(CreateSession, 15a0f3a8-9942-4e4c-8cbe-d51c2aa23dc3, ghrun-hclevy2dda.auto.internal:19448): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" node_id: 1 }
2025-12-23 15:26:54,563 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(AttachSession, 17d91e21-6a62-4fd2-bc23-bb3b4cb9b9f1, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:26:54,563 - DEBUG - ydb.connection.733815  - _log_request: RpcState(AttachSession, 17d91e21-6a62-4fd2-bc23-bb3b4cb9b9f1, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" }
2025-12-23 15:26:54,566 - DEBUG - ydb.connection.733815  - _log_response: RpcState(AttachSession, 17d91e21-6a62-4fd2-bc23-bb3b4cb9b9f1, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:26:54,573 - DEBUG - ydb.query.pool.733815  - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:26:54,574 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 988cb138-ad84-40b2-80ba-e246bd505aeb, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:26:54,575 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 988cb138-ad84-40b2-80ba-e246bd505aeb, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/off_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"off\")\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:26:54,578 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 988cb138-ad84-40b2-80ba-e246bd505aeb, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:26:59,107 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:26:59,107 - INFO - __tests__.alter_compression.733815  - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-12-23 15:26:59,108 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:26:59,113 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 94b12bf0-e1aa-4035-8b4a-6dd679f927f0, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:26:59,116 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 94b12bf0-e1aa-4035-8b4a-6dd679f927f0, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/off_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:26:59,118 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 94b12bf0-e1aa-4035-8b4a-6dd679f927f0, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:27:00,503 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:00,504 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:00,505 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 3cae846d-5d6d-4bd2-95b0-a4403d17e46e, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:27:00,506 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 3cae846d-5d6d-4bd2-95b0-a4403d17e46e, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 0;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:27:00,520 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 3cae846d-5d6d-4bd2-95b0-a4403d17e46e, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:27:02,052 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:02,052 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:02,053 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, bef0545a-b45f-450f-b2ae-3a4f01356871, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:27:02,054 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, bef0545a-b45f-450f-b2ae-3a4f01356871, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:27:02,056 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, bef0545a-b45f-450f-b2ae-3a4f01356871, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:27:03,262 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:03,263 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:03,265 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, daaf0356-a377-4669-a32b-b03d8aa1c351, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:27:03,266 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, daaf0356-a377-4669-a32b-b03d8aa1c351, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:27:03,268 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, daaf0356-a377-4669-a32b-b03d8aa1c351, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:27:05,113 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:05,114 - INFO - __tests__.alter_compression.733815  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 1618432, 'BlobCount': 128}}
2025-12-23 15:27:05,114 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:05,115 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, da7bdc94-1065-4abf-9097-0e74f219e323, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:27:05,116 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, da7bdc94-1065-4abf-9097-0e74f219e323, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 100000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:27:05,117 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, da7bdc94-1065-4abf-9097-0e74f219e323, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:27:06,244 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:06,244 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:06,245 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, d3f13554-6d93-4770-bedf-a9b15f6dd742, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:27:06,246 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, d3f13554-6d93-4770-bedf-a9b15f6dd742, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:27:06,251 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, d3f13554-6d93-4770-bedf-a9b15f6dd742, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:27:06,613 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:06,614 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:06,615 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, bc620569-f646-4cf6-bb47-9f4c69c662af, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:27:06,616 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, bc620569-f646-4cf6-bb47-9f4c69c662af, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:27:06,618 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, bc620569-f646-4cf6-bb47-9f4c69c662af, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:27:07,083 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:07,084 - INFO - __tests__.alter_compression.733815  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 3236864, 'BlobCount': 256}}
2025-12-23 15:27:07,084 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:07,085 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 64672266-a7e9-4d23-819e-3d1cce25729c, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:27:07,085 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 64672266-a7e9-4d23-819e-3d1cce25729c, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 200000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:27:07,087 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 64672266-a7e9-4d23-819e-3d1cce25729c, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:27:08,355 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:08,356 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:08,357 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 2299b6b1-284b-41fc-8feb-4a71be4dfc73, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:27:08,358 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 2299b6b1-284b-41fc-8feb-4a71be4dfc73, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:27:08,359 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 2299b6b1-284b-41fc-8feb-4a71be4dfc73, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:27:08,741 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:08,742 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:08,743 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 4eb9ce1f-a5c9-4846-bb9e-a45226f617a3, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:27:08,744 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 4eb9ce1f-a5c9-4846-bb9e-a45226f617a3, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:27:08,745 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 4eb9ce1f-a5c9-4846-bb9e-a45226f617a3, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:27:09,285 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:09,286 - INFO - __tests__.alter_compression.733815  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 4855296, 'BlobCount': 384}}
2025-12-23 15:27:09,287 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:09,287 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 4d271328-b519-487f-a482-8d469e3b317b, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:27:09,288 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 4d271328-b519-487f-a482-8d469e3b317b, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 300000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:27:09,299 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 4d271328-b519-487f-a482-8d469e3b317b, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:27:10,780 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:10,781 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:10,782 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, a911b498-b022-4a6e-94a8-e795367d6652, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:27:10,783 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, a911b498-b022-4a6e-94a8-e795367d6652, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:27:10,784 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, a911b498-b022-4a6e-94a8-e795367d6652, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:27:11,230 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:11,231 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:11,232 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, f656021f-8aea-4f0c-a65a-c93d97feb7db, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:27:11,233 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, f656021f-8aea-4f0c-a65a-c93d97feb7db, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:27:11,237 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, f656021f-8aea-4f0c-a65a-c93d97feb7db, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:27:12,001 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:12,002 - INFO - __tests__.alter_compression.733815  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 6473728, 'BlobCount': 512}}
2025-12-23 15:27:12,002 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:12,003 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, a2b4bc71-d75e-4e37-8272-913d433b5067, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:27:12,004 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, a2b4bc71-d75e-4e37-8272-913d433b5067, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 400000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:27:12,028 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, a2b4bc71-d75e-4e37-8272-913d433b5067, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:27:13,362 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:13,363 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:13,364 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 7fff56bb-e80d-40f5-8220-01b6f1bc47c8, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:27:13,365 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 7fff56bb-e80d-40f5-8220-01b6f1bc47c8, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:27:13,366 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 7fff56bb-e80d-40f5-8220-01b6f1bc47c8, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:27:13,852 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:13,853 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:13,853 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, c9a6dc69-27c6-4f96-a318-4fae6fd29c18, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:27:13,854 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, c9a6dc69-27c6-4f96-a318-4fae6fd29c18, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:27:13,856 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, c9a6dc69-27c6-4f96-a318-4fae6fd29c18, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:27:14,434 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:14,435 - INFO - __tests__.alter_compression.733815  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 8092160, 'BlobCount': 640}}
2025-12-23 15:27:14,435 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:14,436 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 0acb5ebc-913b-4f41-90a7-3be5f88595c7, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:27:14,436 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 0acb5ebc-913b-4f41-90a7-3be5f88595c7, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 500000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:27:14,438 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 0acb5ebc-913b-4f41-90a7-3be5f88595c7, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:27:15,780 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:15,781 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:15,782 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 28e24e57-5c2f-41f8-95b2-d8d98cd2d60b, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:27:15,783 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 28e24e57-5c2f-41f8-95b2-d8d98cd2d60b, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:27:15,784 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 28e24e57-5c2f-41f8-95b2-d8d98cd2d60b, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:27:16,250 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:16,251 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:16,251 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 5459ace2-eba7-4a1e-9771-1a502aa2f925, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:27:16,252 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 5459ace2-eba7-4a1e-9771-1a502aa2f925, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:27:16,255 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 5459ace2-eba7-4a1e-9771-1a502aa2f925, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:27:16,839 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:16,840 - INFO - __tests__.alter_compression.733815  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 9710592, 'BlobCount': 768}}
2025-12-23 15:27:16,841 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:16,841 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 571a25bc-c067-4820-8b4e-34bfc4b1a29d, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:27:16,842 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 571a25bc-c067-4820-8b4e-34bfc4b1a29d, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 600000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:27:16,855 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 571a25bc-c067-4820-8b4e-34bfc4b1a29d, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:27:18,256 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:18,257 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:18,257 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 80d3f263-eae1-4069-be7b-98bb98d86060, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:27:18,258 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 80d3f263-eae1-4069-be7b-98bb98d86060, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:27:18,265 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 80d3f263-eae1-4069-be7b-98bb98d86060, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:27:18,640 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:18,641 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:18,641 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, e48d32f5-26c1-4249-81d1-abcf2ca165b7, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:27:18,642 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, e48d32f5-26c1-4249-81d1-abcf2ca165b7, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:27:18,644 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, e48d32f5-26c1-4249-81d1-abcf2ca165b7, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:27:19,653 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:19,654 - INFO - __tests__.alter_compression.733815  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 11329024, 'BlobCount': 896}}
2025-12-23 15:27:19,654 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:19,655 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, e04ac693-a899-42b4-a888-bc68bed46006, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:27:19,656 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, e04ac693-a899-42b4-a888-bc68bed46006, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 700000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:27:19,658 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, e04ac693-a899-42b4-a888-bc68bed46006, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:27:20,819 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:20,819 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:20,821 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, c99deebd-1e03-4d96-805c-91c25f6d4fce, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:27:20,822 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, c99deebd-1e03-4d96-805c-91c25f6d4fce, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:27:20,823 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, c99deebd-1e03-4d96-805c-91c25f6d4fce, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:27:21,151 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:21,151 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:21,152 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, df9f62a3-3353-4bfe-98e8-9390996d1b44, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:27:21,158 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, df9f62a3-3353-4bfe-98e8-9390996d1b44, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:27:21,160 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, df9f62a3-3353-4bfe-98e8-9390996d1b44, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:27:22,092 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:22,093 - INFO - __tests__.alter_compression.733815  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 12947456, 'BlobCount': 1024}}
2025-12-23 15:27:22,094 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:22,094 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 07263a51-1969-46e7-8f58-ac5ec15975db, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:27:22,096 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 07263a51-1969-46e7-8f58-ac5ec15975db, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 800000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:27:22,097 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 07263a51-1969-46e7-8f58-ac5ec15975db, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:27:23,333 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:23,334 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:23,335 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 3d40994e-4b7a-4218-b7f7-57cc13b8df88, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:27:23,336 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 3d40994e-4b7a-4218-b7f7-57cc13b8df88, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:27:23,337 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 3d40994e-4b7a-4218-b7f7-57cc13b8df88, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:27:23,916 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:23,917 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:23,917 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, c743e9ae-26fb-415a-843a-663679f42bb9, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:27:23,918 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, c743e9ae-26fb-415a-843a-663679f42bb9, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:27:23,926 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, c743e9ae-26fb-415a-843a-663679f42bb9, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:27:24,850 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:24,850 - INFO - __tests__.alter_compression.733815  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 14565888, 'BlobCount': 1152}}
2025-12-23 15:27:24,851 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:24,852 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 30f7d676-f106-457b-92b7-4518e85c371d, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:27:24,853 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 30f7d676-f106-457b-92b7-4518e85c371d, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 900000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:27:24,866 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 30f7d676-f106-457b-92b7-4518e85c371d, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:27:26,117 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:26,118 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:26,119 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 75a7368d-31d1-4320-bf5d-b60ac6692da8, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:27:26,120 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 75a7368d-31d1-4320-bf5d-b60ac6692da8, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:27:26,121 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 75a7368d-31d1-4320-bf5d-b60ac6692da8, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:27:26,682 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:26,683 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:26,683 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, f06cf890-9182-4938-9894-a53c27a97513, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:27:26,684 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, f06cf890-9182-4938-9894-a53c27a97513, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:27:26,687 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, f06cf890-9182-4938-9894-a53c27a97513, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:27:27,615 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:27,616 - INFO - __tests__.alter_compression.733815  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 16184320, 'BlobCount': 1280}}
2025-12-23 15:27:27,616 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:27,617 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 4471f9ac-4887-4945-b389-57ab51501fa5, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:27:27,618 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 4471f9ac-4887-4945-b389-57ab51501fa5, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/off_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:27:27,625 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 4471f9ac-4887-4945-b389-57ab51501fa5, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:27:29,296 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:29,297 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:29,298 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, bc222dcf-80f8-4fd6-9723-78fe43730f48, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:27:29,299 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, bc222dcf-80f8-4fd6-9723-78fe43730f48, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:27:29,301 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, bc222dcf-80f8-4fd6-9723-78fe43730f48, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:27:29,664 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:29,665 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:29,666 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 2a9df334-6dd2-46c9-a104-31b99ed014e3, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:27:29,667 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 2a9df334-6dd2-46c9-a104-31b99ed014e3, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:27:29,668 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 2a9df334-6dd2-46c9-a104-31b99ed014e3, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:27:30,020 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:30,021 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:30,022 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 6c167bb6-1a4d-48ef-a4dc-8b2bfa547b5c, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:27:30,022 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 6c167bb6-1a4d-48ef-a4dc-8b2bfa547b5c, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:27:30,024 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 6c167bb6-1a4d-48ef-a4dc-8b2bfa547b5c, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:27:34,830 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:44,948 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:44,948 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 3fd1788b-8a67-4370-aa9d-d9eb93137ebf, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:27:44,949 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 3fd1788b-8a67-4370-aa9d-d9eb93137ebf, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:27:44,951 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 3fd1788b-8a67-4370-aa9d-d9eb93137ebf, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:27:49,359 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:49,415 - INFO - root.733815  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-12-23 15:27:49,416 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:27:49,417 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, f898b899-a3c2-43cd-968f-79699d4a486a, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:27:49,418 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, f898b899-a3c2-43cd-968f-79699d4a486a, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:27:49,419 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, f898b899-a3c2-43cd-968f-79699d4a486a, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:27:53,365 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:02,511 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.733815  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-23 15:28:02,512 - DEBUG - ydb.connection.733815  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-23 15:28:02,531 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.733815  - context_resolve: Resolving endpoints for database /Root
2025-12-23 15:28:02,532 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ListEndpoints, 055e0f11-8cd8-49e0-be8a-c5e788b3e3e9, localhost:19448): creating call state
2025-12-23 15:28:02,532 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ListEndpoints, 055e0f11-8cd8-49e0-be8a-c5e788b3e3e9, localhost:19448): request = { database: "/Root" }
2025-12-23 15:28:02,538 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ListEndpoints, 055e0f11-8cd8-49e0-be8a-c5e788b3e3e9, localhost:19448): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-hclevy2dda.auto.internal" port: 19448 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-12-23 15:28:02,539 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.733815  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-hclevy2dda.auto.internal:19448, location 1, ssl: False>]>
2025-12-23 15:28:02,540 - DEBUG - ydb.connection.733815  - close: Closing channel for endpoint localhost:19448
2025-12-23 15:28:03,408 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:03,409 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, e838d118-030f-49aa-9d4f-024a322df4f1, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:03,410 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, e838d118-030f-49aa-9d4f-024a322df4f1, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:28:03,413 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, e838d118-030f-49aa-9d4f-024a322df4f1, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:05,531 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:15,550 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:15,551 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 4db5cd31-436a-4ba3-935c-6efccdd912ce, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:15,552 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 4db5cd31-436a-4ba3-935c-6efccdd912ce, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:28:15,554 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 4db5cd31-436a-4ba3-935c-6efccdd912ce, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:16,665 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:26,670 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:26,671 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, a2dda3d6-e62c-46e8-a268-0f871218e5bd, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:26,672 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, a2dda3d6-e62c-46e8-a268-0f871218e5bd, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:28:26,673 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, a2dda3d6-e62c-46e8-a268-0f871218e5bd, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:27,299 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:27,303 - INFO - root.733815  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8009216)
2025-12-23 15:28:27,303 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:27,304 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 4404b07b-462e-4e29-a795-2f0816b7b0a3, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:27,305 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 4404b07b-462e-4e29-a795-2f0816b7b0a3, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:28:27,306 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 4404b07b-462e-4e29-a795-2f0816b7b0a3, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:27,553 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:27,556 - INFO - ya.test.733815  - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_compression-COMPRESSION = "zstd"])
2025-12-23 15:28:27,556 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:27,557 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, f5492fd9-ba0e-4961-b552-ecabf00d0280, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:27,558 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, f5492fd9-ba0e-4961-b552-ecabf00d0280, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:28:27,559 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, f5492fd9-ba0e-4961-b552-ecabf00d0280, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:30,229 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:30,230 - INFO - __tests__.alter_compression.733815  - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_compression created
2025-12-23 15:28:30,230 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:30,231 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, bc989eaf-e66b-4d48-b459-e1db2e57b016, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:30,232 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, bc989eaf-e66b-4d48-b459-e1db2e57b016, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:28:30,233 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, bc989eaf-e66b-4d48-b459-e1db2e57b016, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:31,091 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:31,092 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:31,093 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, e63cea32-e02e-462a-a0bb-2dc89916f5b0, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:31,093 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, e63cea32-e02e-462a-a0bb-2dc89916f5b0, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:28:31,094 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, e63cea32-e02e-462a-a0bb-2dc89916f5b0, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:32,595 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:32,596 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:32,597 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 4004f639-49ce-437e-afdf-24f71ce56487, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:32,598 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 4004f639-49ce-437e-afdf-24f71ce56487, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:28:32,600 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 4004f639-49ce-437e-afdf-24f71ce56487, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:33,424 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:33,424 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:33,425 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, e496d349-aa72-4319-9fe8-ca613733066a, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:33,426 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, e496d349-aa72-4319-9fe8-ca613733066a, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:28:33,428 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, e496d349-aa72-4319-9fe8-ca613733066a, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:35,061 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:35,062 - INFO - __tests__.alter_compression.733815  - 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-23 15:28:35,062 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:35,063 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 1313eff6-8fb1-4e8f-a03c-3d29e0e3a377, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:35,064 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 1313eff6-8fb1-4e8f-a03c-3d29e0e3a377, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:28:35,065 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 1313eff6-8fb1-4e8f-a03c-3d29e0e3a377, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:36,131 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:36,132 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:36,133 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 6274cc8c-540c-4114-9fac-50ff473d2f32, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:36,133 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 6274cc8c-540c-4114-9fac-50ff473d2f32, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:28:36,135 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 6274cc8c-540c-4114-9fac-50ff473d2f32, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:36,529 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:36,530 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:36,530 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 665ab3e5-e30b-403b-8d8e-37cef2af7d3f, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:36,531 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 665ab3e5-e30b-403b-8d8e-37cef2af7d3f, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:28:36,533 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 665ab3e5-e30b-403b-8d8e-37cef2af7d3f, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:36,965 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:36,966 - INFO - __tests__.alter_compression.733815  - 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-23 15:28:36,966 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:36,967 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 26b572b4-2a50-4c64-9b7e-a2752a3613ed, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:36,968 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 26b572b4-2a50-4c64-9b7e-a2752a3613ed, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:28:36,969 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 26b572b4-2a50-4c64-9b7e-a2752a3613ed, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:38,223 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:38,224 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:38,225 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, c0da877f-8c1b-498a-859e-cb0a0874ecec, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:38,225 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, c0da877f-8c1b-498a-859e-cb0a0874ecec, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:28:38,229 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, c0da877f-8c1b-498a-859e-cb0a0874ecec, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:38,538 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:38,539 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:38,539 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 69492aa9-384d-4402-a2c8-533bfff2e43a, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:38,540 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 69492aa9-384d-4402-a2c8-533bfff2e43a, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:28:38,542 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 69492aa9-384d-4402-a2c8-533bfff2e43a, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:38,972 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:38,973 - INFO - __tests__.alter_compression.733815  - 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-23 15:28:38,973 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:38,974 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 46b10c1a-f726-4802-a21d-0515317272f2, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:38,975 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 46b10c1a-f726-4802-a21d-0515317272f2, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:28:38,977 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 46b10c1a-f726-4802-a21d-0515317272f2, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:40,199 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:40,200 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:40,201 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, ec8bebf5-de26-4d8e-8c62-e0fba8d5e718, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:40,202 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, ec8bebf5-de26-4d8e-8c62-e0fba8d5e718, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:28:40,208 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, ec8bebf5-de26-4d8e-8c62-e0fba8d5e718, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:40,504 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:40,505 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:40,506 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 97aa473e-85c7-44b2-abca-f5e0e961947b, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:40,507 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 97aa473e-85c7-44b2-abca-f5e0e961947b, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:28:40,514 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 97aa473e-85c7-44b2-abca-f5e0e961947b, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:41,060 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:41,061 - INFO - __tests__.alter_compression.733815  - 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-23 15:28:41,061 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:41,062 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 73f67c47-7a9d-46de-86a4-746dfc35ef6a, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:41,063 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 73f67c47-7a9d-46de-86a4-746dfc35ef6a, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:28:41,064 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 73f67c47-7a9d-46de-86a4-746dfc35ef6a, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:42,170 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:42,171 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:42,172 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 8dbcd3c5-9273-4bca-a360-25dd7bcbc4aa, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:42,173 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 8dbcd3c5-9273-4bca-a360-25dd7bcbc4aa, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:28:42,175 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 8dbcd3c5-9273-4bca-a360-25dd7bcbc4aa, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:42,424 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:42,425 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:42,425 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, bc4fd23b-5310-4aed-81fe-a3c36e398e6c, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:42,426 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, bc4fd23b-5310-4aed-81fe-a3c36e398e6c, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:28:42,432 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, bc4fd23b-5310-4aed-81fe-a3c36e398e6c, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:42,983 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:42,984 - INFO - __tests__.alter_compression.733815  - 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-23 15:28:42,985 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:42,985 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 73cb1500-9e42-45ad-9e84-f1888fc661fd, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:42,987 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 73cb1500-9e42-45ad-9e84-f1888fc661fd, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:28:42,988 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 73cb1500-9e42-45ad-9e84-f1888fc661fd, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:44,147 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:44,148 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:44,148 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 728d71f6-d2ef-4ff6-889d-3306f3c7827e, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:44,149 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 728d71f6-d2ef-4ff6-889d-3306f3c7827e, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:28:44,151 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 728d71f6-d2ef-4ff6-889d-3306f3c7827e, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:44,380 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:44,381 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:44,382 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 220ccdec-f16f-4dd7-a0d0-64bf2c2d8103, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:44,383 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 220ccdec-f16f-4dd7-a0d0-64bf2c2d8103, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:28:44,385 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 220ccdec-f16f-4dd7-a0d0-64bf2c2d8103, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:45,034 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:45,035 - INFO - __tests__.alter_compression.733815  - 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-23 15:28:45,036 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:45,036 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, e809dfca-57b5-43e4-8f0e-193b6eb84811, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:45,037 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, e809dfca-57b5-43e4-8f0e-193b6eb84811, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:28:45,039 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, e809dfca-57b5-43e4-8f0e-193b6eb84811, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:46,160 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:46,161 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:46,162 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, f7e69f38-bf99-483d-b4f6-6096d2ee1528, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:46,163 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, f7e69f38-bf99-483d-b4f6-6096d2ee1528, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:28:46,164 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, f7e69f38-bf99-483d-b4f6-6096d2ee1528, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:46,467 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:46,468 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:46,469 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 678b2053-9ef4-4824-a6b8-e7e5d3ce252f, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:46,469 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 678b2053-9ef4-4824-a6b8-e7e5d3ce252f, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:28:46,471 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 678b2053-9ef4-4824-a6b8-e7e5d3ce252f, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:47,297 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:47,298 - INFO - __tests__.alter_compression.733815  - 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-23 15:28:47,298 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:47,299 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 0d62bc0f-a354-4d62-abcc-acbed2f0b7b2, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:47,303 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 0d62bc0f-a354-4d62-abcc-acbed2f0b7b2, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:28:47,305 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 0d62bc0f-a354-4d62-abcc-acbed2f0b7b2, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:48,680 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:48,687 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:48,688 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 06ba07f1-b1cf-4034-9bce-b2a7e0ebe7ad, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:48,689 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 06ba07f1-b1cf-4034-9bce-b2a7e0ebe7ad, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:28:48,690 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 06ba07f1-b1cf-4034-9bce-b2a7e0ebe7ad, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:48,996 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:48,997 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:49,008 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 92480a8e-e542-4d28-8634-971091b10acc, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:49,010 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 92480a8e-e542-4d28-8634-971091b10acc, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:28:49,012 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 92480a8e-e542-4d28-8634-971091b10acc, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:49,793 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:49,794 - INFO - __tests__.alter_compression.733815  - 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-23 15:28:49,794 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:49,795 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 3ddc9ede-02e7-4ea1-a0e1-91d5e6396b83, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:49,796 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 3ddc9ede-02e7-4ea1-a0e1-91d5e6396b83, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:28:49,798 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 3ddc9ede-02e7-4ea1-a0e1-91d5e6396b83, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:50,960 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:50,978 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:50,979 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, bb1abb1f-a33c-4216-8347-45841335e2df, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:50,992 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, bb1abb1f-a33c-4216-8347-45841335e2df, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:28:50,993 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, bb1abb1f-a33c-4216-8347-45841335e2df, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:51,349 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:51,350 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:51,350 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 9275c39a-8978-4b19-9aac-a4d54a1f9d4f, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:51,353 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 9275c39a-8978-4b19-9aac-a4d54a1f9d4f, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:28:51,364 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 9275c39a-8978-4b19-9aac-a4d54a1f9d4f, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:52,082 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:52,083 - INFO - __tests__.alter_compression.733815  - 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-23 15:28:52,083 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:52,084 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 238c461c-8519-4844-9e07-d9c7db9140a1, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:52,085 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 238c461c-8519-4844-9e07-d9c7db9140a1, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:28:52,087 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 238c461c-8519-4844-9e07-d9c7db9140a1, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:53,218 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:53,219 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:53,220 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 62aa0c66-6fa3-4946-baa3-377bb98335ef, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:53,221 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 62aa0c66-6fa3-4946-baa3-377bb98335ef, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:28:53,226 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 62aa0c66-6fa3-4946-baa3-377bb98335ef, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:53,668 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:53,668 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:53,669 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 9a9ab591-3896-4c63-ac3d-e944586151c1, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:53,670 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 9a9ab591-3896-4c63-ac3d-e944586151c1, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:28:53,671 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 9a9ab591-3896-4c63-ac3d-e944586151c1, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:54,367 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:54,368 - INFO - __tests__.alter_compression.733815  - 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-23 15:28:54,368 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:54,369 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 15dea451-247d-480f-b203-5127922b110d, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:54,369 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 15dea451-247d-480f-b203-5127922b110d, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:28:54,371 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 15dea451-247d-480f-b203-5127922b110d, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:55,426 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:55,427 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:55,428 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, a1a3e216-cc73-4ca5-8c61-af35aecd7d7d, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:55,436 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, a1a3e216-cc73-4ca5-8c61-af35aecd7d7d, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:28:55,437 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, a1a3e216-cc73-4ca5-8c61-af35aecd7d7d, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:55,739 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:55,741 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:55,784 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, c4fbe2c3-b2f7-4d78-ab01-e48efb39052c, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:55,803 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, c4fbe2c3-b2f7-4d78-ab01-e48efb39052c, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:28:55,805 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, c4fbe2c3-b2f7-4d78-ab01-e48efb39052c, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:56,066 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:56,083 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:28:56,095 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 17eca720-6c2f-4d8b-9017-c693021653ed, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:28:56,096 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 17eca720-6c2f-4d8b-9017-c693021653ed, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:28:56,108 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 17eca720-6c2f-4d8b-9017-c693021653ed, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:28:59,862 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:29:09,906 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:29:09,907 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, f223e041-1c3c-4344-920e-21278007646d, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:29:09,920 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, f223e041-1c3c-4344-920e-21278007646d, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:29:09,939 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, f223e041-1c3c-4344-920e-21278007646d, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:29:13,073 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:29:13,140 - INFO - root.733815  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_compression`, volumes `value` (8000000, 1596608)
2025-12-23 15:29:13,160 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:29:13,165 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 8e03f3ca-4ebb-456a-abd1-eee922e517ef, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:29:13,173 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 8e03f3ca-4ebb-456a-abd1-eee922e517ef, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:29:13,185 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 8e03f3ca-4ebb-456a-abd1-eee922e517ef, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:29:13,525 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:29:13,526 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:29:13,527 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, e048a028-51f2-4b0a-a90a-774f0cf427f5, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:29:13,528 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, e048a028-51f2-4b0a-a90a-774f0cf427f5, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:29:13,530 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, e048a028-51f2-4b0a-a90a-774f0cf427f5, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:29:16,610 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:29:26,651 - DEBUG - ydb.query.pool.733815  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:29:26,652 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(ExecuteQuery, 00b64d76-4d25-4acf-a9fd-8908f17d4463, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:29:26,653 - DEBUG - ydb.connection.733815  - _log_request: RpcState(ExecuteQuery, 00b64d76-4d25-4acf-a9fd-8908f17d4463, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" 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-23 15:29:26,657 - DEBUG - ydb.connection.733815  - _log_response: RpcState(ExecuteQuery, 00b64d76-4d25-4acf-a9fd-8908f17d4463, ghrun-hclevy2dda.auto.internal:19448): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:29:30,495 - DEBUG - ydb.query.pool.733815  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==
2025-12-23 15:29:30,553 - INFO - root.733815  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_compression`, volumes `value` (8000000, 1596608)
2025-12-23 15:29:30,553 - INFO - root.733815  - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_compression` 8092160 / 1596608: 5.0683448911692786
2025-12-23 15:29:30,555 - INFO - ya.test.733815  - pytest_runtest_teardown: Test teardown
2025-12-23 15:29:30,556 - DEBUG - ydb.connection.733815  - _prepare_call: RpcState(DeleteSession, a741b043-0205-404e-a860-7c7d71fff086, ghrun-hclevy2dda.auto.internal:19448): creating call state
2025-12-23 15:29:30,557 - DEBUG - ydb.connection.733815  - _log_request: RpcState(DeleteSession, a741b043-0205-404e-a860-7c7d71fff086, ghrun-hclevy2dda.auto.internal:19448): request = { session_id: "ydb://session/3?node_id=1&id=NDY4MTdjNjItMzE4ODBjZDItZWIyOGQzMzktNzE0OWUyZQ==" }
2025-12-23 15:29:30,562 - DEBUG - ydb.connection.733815  - _log_response: RpcState(DeleteSession, a741b043-0205-404e-a860-7c7d71fff086, ghrun-hclevy2dda.auto.internal:19448): response = { status: SUCCESS }
2025-12-23 15:29:30,563 - DEBUG - ydb.query.pool.733815  - stop: All session were deleted.
2025-12-23 15:29:30,564 - DEBUG - ydb.topic.733815  - close: Close topic client
2025-12-23 15:29:30,564 - DEBUG - ydb.topic.733815  - close: Topic client was closed
2025-12-23 15:29:30,564 - DEBUG - ydb.connection.733815  - close: Closing channel for endpoint localhost:19448
2025-12-23 15:29:30,565 - DEBUG - ydb.connection.733815  - _rpc_error_handler: RpcState(AttachSession, 17d91e21-6a62-4fd2-bc23-bb3b4cb9b9f1, ghrun-hclevy2dda.auto.internal:19448): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.CANCELLED
	details = "Locally cancelled by application!"
	debug_error_string = "None"
>
2025-12-23 15:29:30,567 - DEBUG - ydb.connection.733815  - close: Closing channel for endpoint ghrun-hclevy2dda.auto.internal:19448
2025-12-23 15:29:30,571 - INFO - ydb.pool.Discovery.733815  - run: Successfully terminated discovery process
2025-12-23 15:29:52,584 - INFO - ydb.tests.library.harness.kikimr_runner.733815  - stop: Stopped node localhost:19448/1
2025-12-23 15:29:52,615 - DEBUG - library.python.filelock.733815  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/63569
2025-12-23 15:29:52,616 - DEBUG - library.python.filelock.733815  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/16456
2025-12-23 15:29:52,616 - DEBUG - library.python.filelock.733815  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/4655
2025-12-23 15:29:52,616 - DEBUG - library.python.filelock.733815  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/19448
2025-12-23 15:29:52,616 - DEBUG - library.python.filelock.733815  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/12511
