2025-11-06 10:13:35,553 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-06 10:13:35,554 - INFO - ya.test - pytest_runtest_setup: test_all_supported_compression[zstd_20_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 20]
2025-11-06 10:13:35,554 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-06 10:13:35,554 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-06 10:13:35,557 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-11-06 10:13:35,558 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-11-06 10:13:35,558 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/2dji/00462a/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-06 10:13:35,560 - DEBUG - ya.test - execute: Command pid: 484831
2025-11-06 10:13:36,387 - DEBUG - ya.test - _save_outputs: Command (pid 484831) rc: 0
2025-11-06 10:13:36,387 - DEBUG - ya.test - _save_outputs: Command (pid 484831) elapsed time (sec): 0.8255820274353027
2025-11-06 10:13:36,388 - DEBUG - ya.test - _save_outputs: Command (pid 484831) idrss: 0
2025-11-06 10:13:36,388 - DEBUG - ya.test - _save_outputs: Command (pid 484831) inblock: 0
2025-11-06 10:13:36,388 - DEBUG - ya.test - _save_outputs: Command (pid 484831) isrss: 0
2025-11-06 10:13:36,389 - DEBUG - ya.test - _save_outputs: Command (pid 484831) ixrss: 0
2025-11-06 10:13:36,389 - DEBUG - ya.test - _save_outputs: Command (pid 484831) majflt: 0
2025-11-06 10:13:36,389 - DEBUG - ya.test - _save_outputs: Command (pid 484831) maxrss: 494376
2025-11-06 10:13:36,390 - DEBUG - ya.test - _save_outputs: Command (pid 484831) minflt: 45432
2025-11-06 10:13:36,390 - DEBUG - ya.test - _save_outputs: Command (pid 484831) msgrcv: 0
2025-11-06 10:13:36,390 - DEBUG - ya.test - _save_outputs: Command (pid 484831) msgsnd: 0
2025-11-06 10:13:36,391 - DEBUG - ya.test - _save_outputs: Command (pid 484831) nivcsw: 107
2025-11-06 10:13:36,391 - DEBUG - ya.test - _save_outputs: Command (pid 484831) nsignals: 0
2025-11-06 10:13:36,391 - DEBUG - ya.test - _save_outputs: Command (pid 484831) nswap: 0
2025-11-06 10:13:36,391 - DEBUG - ya.test - _save_outputs: Command (pid 484831) nvcsw: 13
2025-11-06 10:13:36,392 - DEBUG - ya.test - _save_outputs: Command (pid 484831) oublock: 8
2025-11-06 10:13:36,392 - DEBUG - ya.test - _save_outputs: Command (pid 484831) stime: 0.241583
2025-11-06 10:13:36,392 - DEBUG - ya.test - _save_outputs: Command (pid 484831) utime: 0.460464
2025-11-06 10:13:36,393 - DEBUG - ya.test - _save_outputs: Command (pid 484831) wtime: 0.828
2025-11-06 10:13:36,393 - DEBUG - ya.test - _save_outputs: Command (pid 484831) output:
Git info:
    Commit: 609b3b9504bd064e40414654c1f6284791b6a66c
    Branch: 
    Author: Alek5andr-Kotov <akotov@ydb.tech>
    Summary: Merge 5af363c204fa18a6cbd8ab64fd547c3e99f1eee6 into 5ddc18e8b9ca9bdb9f539a0a3efaaf4e958f00d3

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-ew6xquenpy
    Host information: 
        Linux ghrun-ew6xquenpy 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

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

2025-11-06 10:13:36,393 - DEBUG - ya.test - _save_outputs: Command (pid 484831) errors:

2025-11-06 10:13:36,394 - INFO - __tests__.base - _setup_ydb: Git info:
    Commit: 609b3b9504bd064e40414654c1f6284791b6a66c
    Branch: 
    Author: Alek5andr-Kotov <akotov@ydb.tech>
    Summary: Merge 5af363c204fa18a6cbd8ab64fd547c3e99f1eee6 into 5ddc18e8b9ca9bdb9f539a0a3efaaf4e958f00d3

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-ew6xquenpy
    Host information: 
        Linux ghrun-ew6xquenpy 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

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

2025-11-06 10:13:36,523 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/2dji/00462a/ydb/apps/ydbd/ydbd
2025-11-06 10:13:36,525 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/9929
2025-11-06 10:13:36,527 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/2dji/00462a/r3tmp/kikimr_cluster_v1rtmhrn
2025-11-06 10:13:36,569 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/2dji/00462a/ydb/apps/ydbd/ydbd
2025-11-06 10:13:36,570 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/62684
2025-11-06 10:13:36,570 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/9507
2025-11-06 10:13:36,571 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/63460
2025-11-06 10:13:36,572 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/26301
2025-11-06 10:13:36,573 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/2dji/00462a/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk4/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_20_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.20/cluster/kikimr_configs"
2025-11-06 10:13:36,573 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/2dji/00462a/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/2dji/00462a/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk4/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_20_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.20/cluster/node_1/logfile_e2qbxxm1.log --grpc-port=62684 --mon-port=9507 --ic-port=9929
2025-11-06 10:13:36,574 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:62684/1, disk_size 68719476736
2025-11-06 10:13:36,575 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/2dji/00462a/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk4/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_20_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.20/cluster/kikimr_configs"
2025-11-06 10:13:36,575 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/2dji/00462a/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/2dji/00462a/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk4/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_20_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.20/cluster/node_1/logfile_e2qbxxm1.log --grpc-port=62684 --mon-port=9507 --ic-port=9929
2025-11-06 10:13:36,576 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/2dji/00462a/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/2dji/00462a/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk4/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_20_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.20/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/2dji/00462a/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk4/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_20_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.20/cluster/node_1/logfile_e2qbxxm1.log', '--grpc-port=62684', '--mon-port=9507', '--ic-port=9929')' in '/home/runner/.ya/build/build_root/2dji/00462a/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk4/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_20_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.20/cluster/node_1' (no wait)
2025-11-06 10:13:36,581 - DEBUG - ya.test - execute: Command pid: 485454
2025-11-06 10:13:36,582 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:62684/1
2025-11-06 10:13:36,584 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-11-06 10:13:36,585 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-11-06 10:13:36,585 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/2dji/00462a/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-06 10:13:36,595 - DEBUG - ya.test - execute: Command pid: 485455
2025-11-06 10:13:37,339 - DEBUG - ya.test - _save_outputs: Command (pid 485455) rc: 0
2025-11-06 10:13:37,340 - DEBUG - ya.test - _save_outputs: Command (pid 485455) elapsed time (sec): 0.7429120540618896
2025-11-06 10:13:37,340 - DEBUG - ya.test - _save_outputs: Command (pid 485455) idrss: 0
2025-11-06 10:13:37,340 - DEBUG - ya.test - _save_outputs: Command (pid 485455) inblock: 0
2025-11-06 10:13:37,341 - DEBUG - ya.test - _save_outputs: Command (pid 485455) isrss: 0
2025-11-06 10:13:37,341 - DEBUG - ya.test - _save_outputs: Command (pid 485455) ixrss: 0
2025-11-06 10:13:37,341 - DEBUG - ya.test - _save_outputs: Command (pid 485455) majflt: 0
2025-11-06 10:13:37,341 - DEBUG - ya.test - _save_outputs: Command (pid 485455) maxrss: 499040
2025-11-06 10:13:37,342 - DEBUG - ya.test - _save_outputs: Command (pid 485455) minflt: 45445
2025-11-06 10:13:37,342 - DEBUG - ya.test - _save_outputs: Command (pid 485455) msgrcv: 0
2025-11-06 10:13:37,342 - DEBUG - ya.test - _save_outputs: Command (pid 485455) msgsnd: 0
2025-11-06 10:13:37,343 - DEBUG - ya.test - _save_outputs: Command (pid 485455) nivcsw: 94
2025-11-06 10:13:37,343 - DEBUG - ya.test - _save_outputs: Command (pid 485455) nsignals: 0
2025-11-06 10:13:37,343 - DEBUG - ya.test - _save_outputs: Command (pid 485455) nswap: 0
2025-11-06 10:13:37,344 - DEBUG - ya.test - _save_outputs: Command (pid 485455) nvcsw: 15
2025-11-06 10:13:37,344 - DEBUG - ya.test - _save_outputs: Command (pid 485455) oublock: 8
2025-11-06 10:13:37,344 - DEBUG - ya.test - _save_outputs: Command (pid 485455) stime: 0.14332499999999998
2025-11-06 10:13:37,344 - DEBUG - ya.test - _save_outputs: Command (pid 485455) utime: 0.517466
2025-11-06 10:13:37,345 - DEBUG - ya.test - _save_outputs: Command (pid 485455) wtime: 0.753
2025-11-06 10:13:37,345 - DEBUG - ya.test - _save_outputs: Command (pid 485455) output:
Git info:
    Commit: 609b3b9504bd064e40414654c1f6284791b6a66c
    Branch: 
    Author: Alek5andr-Kotov <akotov@ydb.tech>
    Summary: Merge 5af363c204fa18a6cbd8ab64fd547c3e99f1eee6 into 5ddc18e8b9ca9bdb9f539a0a3efaaf4e958f00d3

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-ew6xquenpy
    Host information: 
        Linux ghrun-ew6xquenpy 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

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

2025-11-06 10:13:37,345 - DEBUG - ya.test - _save_outputs: Command (pid 485455) errors:

2025-11-06 10:13:37,346 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 609b3b9504bd064e40414654c1f6284791b6a66c
    Branch: 
    Author: Alek5andr-Kotov <akotov@ydb.tech>
    Summary: Merge 5af363c204fa18a6cbd8ab64fd547c3e99f1eee6 into 5ddc18e8b9ca9bdb9f539a0a3efaaf4e958f00d3
2025-11-06 10:13:42,516 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/2dji/00462a/ydb/apps/ydbd/ydbd
2025-11-06 10:13:42,517 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/2dji/00462a/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:62684', '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: 9929\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-06 10:13:42,518 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-11-06 10:13:42,519 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-11-06 10:13:42,520 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/2dji/00462a/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:62684', '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: 9929\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-06 10:13:42,521 - DEBUG - ya.test - execute: Command pid: 489006
2025-11-06 10:13:43,509 - DEBUG - ya.test - _save_outputs: Command (pid 489006) rc: 0
2025-11-06 10:13:43,509 - DEBUG - ya.test - _save_outputs: Command (pid 489006) elapsed time (sec): 0.9865624904632568
2025-11-06 10:13:43,510 - DEBUG - ya.test - _save_outputs: Command (pid 489006) idrss: 0
2025-11-06 10:13:43,510 - DEBUG - ya.test - _save_outputs: Command (pid 489006) inblock: 0
2025-11-06 10:13:43,510 - DEBUG - ya.test - _save_outputs: Command (pid 489006) isrss: 0
2025-11-06 10:13:43,511 - DEBUG - ya.test - _save_outputs: Command (pid 489006) ixrss: 0
2025-11-06 10:13:43,511 - DEBUG - ya.test - _save_outputs: Command (pid 489006) majflt: 0
2025-11-06 10:13:43,511 - DEBUG - ya.test - _save_outputs: Command (pid 489006) maxrss: 591016
2025-11-06 10:13:43,511 - DEBUG - ya.test - _save_outputs: Command (pid 489006) minflt: 51711
2025-11-06 10:13:43,512 - DEBUG - ya.test - _save_outputs: Command (pid 489006) msgrcv: 0
2025-11-06 10:13:43,512 - DEBUG - ya.test - _save_outputs: Command (pid 489006) msgsnd: 0
2025-11-06 10:13:43,512 - DEBUG - ya.test - _save_outputs: Command (pid 489006) nivcsw: 172
2025-11-06 10:13:43,512 - DEBUG - ya.test - _save_outputs: Command (pid 489006) nsignals: 0
2025-11-06 10:13:43,513 - DEBUG - ya.test - _save_outputs: Command (pid 489006) nswap: 0
2025-11-06 10:13:43,513 - DEBUG - ya.test - _save_outputs: Command (pid 489006) nvcsw: 554
2025-11-06 10:13:43,513 - DEBUG - ya.test - _save_outputs: Command (pid 489006) oublock: 8
2025-11-06 10:13:43,513 - DEBUG - ya.test - _save_outputs: Command (pid 489006) stime: 0.28482799999999997
2025-11-06 10:13:43,514 - DEBUG - ya.test - _save_outputs: Command (pid 489006) utime: 0.509599
2025-11-06 10:13:43,514 - DEBUG - ya.test - _save_outputs: Command (pid 489006) wtime: 0.988
2025-11-06 10:13:43,514 - DEBUG - ya.test - _save_outputs: Command (pid 489006) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-06 10:13:43,515 - DEBUG - ya.test - _save_outputs: Command (pid 489006) errors:

2025-11-06 10:13:43,517 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/2dji/00462a/ydb/apps/ydbd/ydbd
2025-11-06 10:13:43,517 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/2dji/00462a/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:62684', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']
2025-11-06 10:13:43,520 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-11-06 10:13:43,521 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-11-06 10:13:43,521 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/2dji/00462a/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:62684', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-06 10:13:43,523 - DEBUG - ya.test - execute: Command pid: 489594
2025-11-06 10:13:44,511 - DEBUG - ya.test - _save_outputs: Command (pid 489594) rc: 0
2025-11-06 10:13:44,512 - DEBUG - ya.test - _save_outputs: Command (pid 489594) elapsed time (sec): 0.9873111248016357
2025-11-06 10:13:44,512 - DEBUG - ya.test - _save_outputs: Command (pid 489594) idrss: 0
2025-11-06 10:13:44,512 - DEBUG - ya.test - _save_outputs: Command (pid 489594) inblock: 0
2025-11-06 10:13:44,513 - DEBUG - ya.test - _save_outputs: Command (pid 489594) isrss: 0
2025-11-06 10:13:44,513 - DEBUG - ya.test - _save_outputs: Command (pid 489594) ixrss: 0
2025-11-06 10:13:44,513 - DEBUG - ya.test - _save_outputs: Command (pid 489594) majflt: 0
2025-11-06 10:13:44,513 - DEBUG - ya.test - _save_outputs: Command (pid 489594) maxrss: 591016
2025-11-06 10:13:44,513 - DEBUG - ya.test - _save_outputs: Command (pid 489594) minflt: 51744
2025-11-06 10:13:44,513 - DEBUG - ya.test - _save_outputs: Command (pid 489594) msgrcv: 0
2025-11-06 10:13:44,514 - DEBUG - ya.test - _save_outputs: Command (pid 489594) msgsnd: 0
2025-11-06 10:13:44,514 - DEBUG - ya.test - _save_outputs: Command (pid 489594) nivcsw: 119
2025-11-06 10:13:44,514 - DEBUG - ya.test - _save_outputs: Command (pid 489594) nsignals: 0
2025-11-06 10:13:44,515 - DEBUG - ya.test - _save_outputs: Command (pid 489594) nswap: 0
2025-11-06 10:13:44,516 - DEBUG - ya.test - _save_outputs: Command (pid 489594) nvcsw: 505
2025-11-06 10:13:44,516 - DEBUG - ya.test - _save_outputs: Command (pid 489594) oublock: 8
2025-11-06 10:13:44,516 - DEBUG - ya.test - _save_outputs: Command (pid 489594) stime: 0.250321
2025-11-06 10:13:44,516 - DEBUG - ya.test - _save_outputs: Command (pid 489594) utime: 0.593637
2025-11-06 10:13:44,517 - DEBUG - ya.test - _save_outputs: Command (pid 489594) wtime: 0.989
2025-11-06 10:13:44,517 - DEBUG - ya.test - _save_outputs: Command (pid 489594) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-11-06 10:13:44,517 - DEBUG - ya.test - _save_outputs: Command (pid 489594) errors:

2025-11-06 10:13:44,518 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-06 10:13:44,656 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-11-06 10:13:44,700 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-06 10:13:44,711 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-06 10:13:44,712 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-06 10:13:44,761 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-06 10:13:44,762 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 4b76aa08-2eaf-4f27-ae7a-333286acfe9f, localhost:62684): creating call state
2025-11-06 10:13:44,763 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 4b76aa08-2eaf-4f27-ae7a-333286acfe9f, localhost:62684): request = { database: "/Root" }
2025-11-06 10:13:44,781 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 4b76aa08-2eaf-4f27-ae7a-333286acfe9f, localhost:62684): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-ew6xquenpy.auto.internal" port: 62684 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-11-06 10:13:44,782 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-ew6xquenpy.auto.internal:62684, location 1, ssl: False>]>
2025-11-06 10:13:44,786 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-06 10:13:44,825 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:62684
2025-11-06 10:13:44,827 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-06 10:13:44,828 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 1cdbea01-7b63-4c04-85c7-69ac16a2c3b3, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:13:44,829 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 1cdbea01-7b63-4c04-85c7-69ac16a2c3b3, ghrun-ew6xquenpy.auto.internal:62684): request = {  }
2025-11-06 10:13:44,843 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 1cdbea01-7b63-4c04-85c7-69ac16a2c3b3, ghrun-ew6xquenpy.auto.internal:62684): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" node_id: 1 }
2025-11-06 10:13:44,845 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, b8f16669-51b4-45f4-be40-4ac49249ba0b, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:13:44,845 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, b8f16669-51b4-45f4-be40-4ac49249ba0b, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" }
2025-11-06 10:13:44,853 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, b8f16669-51b4-45f4-be40-4ac49249ba0b, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:13:44,872 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:13:44,873 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ab2afdbe-01e3-4ac1-94d2-867cc4cac778, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:13:44,875 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ab2afdbe-01e3-4ac1-94d2-867cc4cac778, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/off_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"off\")\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:13:44,876 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ab2afdbe-01e3-4ac1-94d2-867cc4cac778, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:13:47,695 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:13:47,696 - INFO - __tests__.alter_compression - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-11-06 10:13:47,696 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:13:47,697 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 53451d9d-2eb4-42bb-b3da-7200e7067f9a, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:13:47,698 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 53451d9d-2eb4-42bb-b3da-7200e7067f9a, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/off_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:13:47,699 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 53451d9d-2eb4-42bb-b3da-7200e7067f9a, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:13:48,532 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:13:48,533 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:13:48,535 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d020918b-5bb6-409a-acdb-e208a021503d, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:13:48,536 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d020918b-5bb6-409a-acdb-e208a021503d, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 0;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:13:48,537 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d020918b-5bb6-409a-acdb-e208a021503d, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:13:49,633 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:13:49,634 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:13:49,635 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c782b79a-9fe4-4413-bbd3-f4819db9113b, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:13:49,635 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c782b79a-9fe4-4413-bbd3-f4819db9113b, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:13:49,637 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c782b79a-9fe4-4413-bbd3-f4819db9113b, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:13:50,551 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:13:50,552 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:13:50,553 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4b2645f2-9e79-448c-81a4-8a38cb77930e, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:13:50,554 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4b2645f2-9e79-448c-81a4-8a38cb77930e, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:13:50,555 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4b2645f2-9e79-448c-81a4-8a38cb77930e, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:13:51,963 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:13:51,964 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 1618432, 'BlobCount': 128}}
2025-11-06 10:13:51,964 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:13:51,965 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 131a8091-9794-4436-8cb6-8b691cf17061, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:13:51,966 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 131a8091-9794-4436-8cb6-8b691cf17061, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 100000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:13:51,968 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 131a8091-9794-4436-8cb6-8b691cf17061, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:13:52,911 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:13:52,911 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:13:52,912 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a9856ec1-db5e-49e6-95d3-78155c08c25b, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:13:52,913 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a9856ec1-db5e-49e6-95d3-78155c08c25b, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:13:52,916 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a9856ec1-db5e-49e6-95d3-78155c08c25b, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:13:53,154 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:13:53,155 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:13:53,156 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d368b0dd-46e9-4bda-914d-20e4ee246189, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:13:53,157 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d368b0dd-46e9-4bda-914d-20e4ee246189, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:13:53,160 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d368b0dd-46e9-4bda-914d-20e4ee246189, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:13:53,474 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:13:53,475 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 3236864, 'BlobCount': 256}}
2025-11-06 10:13:53,476 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:13:53,476 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, caf15801-279b-4fae-a12a-2885578dbff9, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:13:53,480 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, caf15801-279b-4fae-a12a-2885578dbff9, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 200000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:13:53,482 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, caf15801-279b-4fae-a12a-2885578dbff9, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:13:54,602 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:13:54,603 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:13:54,604 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e21d3219-95f9-499c-9ab0-d582112bc755, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:13:54,605 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e21d3219-95f9-499c-9ab0-d582112bc755, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:13:54,606 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e21d3219-95f9-499c-9ab0-d582112bc755, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:13:54,931 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:13:54,932 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:13:54,933 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9a415505-83e2-49e6-9dc2-a12229c3138c, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:13:54,934 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9a415505-83e2-49e6-9dc2-a12229c3138c, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:13:54,936 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9a415505-83e2-49e6-9dc2-a12229c3138c, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:13:55,288 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:13:55,294 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 4855296, 'BlobCount': 384}}
2025-11-06 10:13:55,294 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:13:55,295 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, acfa45c3-2ef4-48da-b810-2b2a045e06df, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:13:55,296 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, acfa45c3-2ef4-48da-b810-2b2a045e06df, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 300000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:13:55,297 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, acfa45c3-2ef4-48da-b810-2b2a045e06df, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:13:56,363 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:13:56,364 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:13:56,365 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8bb84ddc-1ca2-4b09-ac57-9f6f773e5084, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:13:56,366 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8bb84ddc-1ca2-4b09-ac57-9f6f773e5084, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:13:56,368 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8bb84ddc-1ca2-4b09-ac57-9f6f773e5084, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:13:56,770 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:13:56,773 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:13:56,788 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d8079afc-9a4a-4c69-86d4-d26f8928c10c, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:13:56,793 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d8079afc-9a4a-4c69-86d4-d26f8928c10c, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:13:56,795 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d8079afc-9a4a-4c69-86d4-d26f8928c10c, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:13:57,176 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:13:57,177 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 6473728, 'BlobCount': 512}}
2025-11-06 10:13:57,177 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:13:57,178 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 33a8c25b-8c66-4279-bd75-e1bc65b9effb, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:13:57,179 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 33a8c25b-8c66-4279-bd75-e1bc65b9effb, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 400000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:13:57,195 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 33a8c25b-8c66-4279-bd75-e1bc65b9effb, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:13:58,232 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:13:58,232 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:13:58,233 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 821ab8c7-7839-467d-b556-1e9c428c02b9, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:13:58,234 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 821ab8c7-7839-467d-b556-1e9c428c02b9, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:13:58,235 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 821ab8c7-7839-467d-b556-1e9c428c02b9, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:13:58,577 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:13:58,577 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:13:58,578 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, bac7e441-e89b-4e2c-b17a-06ea6ad72c10, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:13:58,579 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, bac7e441-e89b-4e2c-b17a-06ea6ad72c10, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:13:58,581 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, bac7e441-e89b-4e2c-b17a-06ea6ad72c10, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:13:59,102 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:13:59,103 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 8092160, 'BlobCount': 640}}
2025-11-06 10:13:59,104 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:13:59,104 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b63706b8-dc81-407d-b203-91002af19783, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:13:59,105 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b63706b8-dc81-407d-b203-91002af19783, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 500000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:13:59,107 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b63706b8-dc81-407d-b203-91002af19783, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:00,265 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:00,267 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:00,268 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 313a4ce6-2ba8-4972-8fd0-628f1e06cb94, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:14:00,269 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 313a4ce6-2ba8-4972-8fd0-628f1e06cb94, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:14:00,270 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 313a4ce6-2ba8-4972-8fd0-628f1e06cb94, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:00,632 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:00,633 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:00,634 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c092b2c5-6baf-461a-be3a-b81084737e8a, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:14:00,638 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c092b2c5-6baf-461a-be3a-b81084737e8a, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:14:00,639 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c092b2c5-6baf-461a-be3a-b81084737e8a, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:01,303 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:01,304 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 9710592, 'BlobCount': 768}}
2025-11-06 10:14:01,305 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:01,305 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e5d5bf34-9a7e-4ac6-ad24-28554805c444, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:14:01,306 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e5d5bf34-9a7e-4ac6-ad24-28554805c444, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 600000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:14:01,312 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e5d5bf34-9a7e-4ac6-ad24-28554805c444, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:02,892 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:02,893 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:02,893 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e50abc1c-5a2b-4a26-83ab-ef4e9e4bb676, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:14:02,894 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e50abc1c-5a2b-4a26-83ab-ef4e9e4bb676, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:14:02,896 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e50abc1c-5a2b-4a26-83ab-ef4e9e4bb676, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:03,400 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:03,404 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:03,405 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 848ad637-e8f9-415d-b8ba-8bfccc3a1e4a, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:14:03,406 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 848ad637-e8f9-415d-b8ba-8bfccc3a1e4a, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:14:03,409 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 848ad637-e8f9-415d-b8ba-8bfccc3a1e4a, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:04,147 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:04,148 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 11329024, 'BlobCount': 896}}
2025-11-06 10:14:04,148 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:04,149 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3ee04f4b-a1a0-47d2-bc50-1f634c6c8e2b, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:14:04,150 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3ee04f4b-a1a0-47d2-bc50-1f634c6c8e2b, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 700000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:14:04,151 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3ee04f4b-a1a0-47d2-bc50-1f634c6c8e2b, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:05,173 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:05,174 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:05,175 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d1d9a4c4-71f4-4e00-9ac8-c60d5d4e79aa, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:14:05,176 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d1d9a4c4-71f4-4e00-9ac8-c60d5d4e79aa, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:14:05,177 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d1d9a4c4-71f4-4e00-9ac8-c60d5d4e79aa, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:05,655 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:05,656 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:05,656 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 323fbe7d-4ad4-4a85-a6a0-036ba274a763, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:14:05,657 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 323fbe7d-4ad4-4a85-a6a0-036ba274a763, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:14:05,668 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 323fbe7d-4ad4-4a85-a6a0-036ba274a763, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:06,391 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:06,392 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 12947456, 'BlobCount': 1024}}
2025-11-06 10:14:06,393 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:06,407 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8165a6b5-bcc8-4f95-8cbd-d3ad1ae17a5d, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:14:06,408 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8165a6b5-bcc8-4f95-8cbd-d3ad1ae17a5d, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 800000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:14:06,411 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8165a6b5-bcc8-4f95-8cbd-d3ad1ae17a5d, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:07,523 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:07,524 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:07,525 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b4e6429d-5a1a-4c68-a61b-127fa1df562e, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:14:07,525 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b4e6429d-5a1a-4c68-a61b-127fa1df562e, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:14:07,527 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b4e6429d-5a1a-4c68-a61b-127fa1df562e, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:08,034 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:08,035 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:08,036 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3ee3dba7-2ee5-4fa4-90ff-00a4094355cb, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:14:08,037 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3ee3dba7-2ee5-4fa4-90ff-00a4094355cb, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:14:08,038 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3ee3dba7-2ee5-4fa4-90ff-00a4094355cb, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:08,812 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:08,813 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 14565888, 'BlobCount': 1152}}
2025-11-06 10:14:08,814 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:08,815 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f699150b-1859-4bc8-ade1-de4daf9c7d24, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:14:08,816 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f699150b-1859-4bc8-ade1-de4daf9c7d24, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 900000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:14:08,818 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f699150b-1859-4bc8-ade1-de4daf9c7d24, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:10,112 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:10,113 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:10,113 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d622f2df-c67a-4145-b7f7-8edc441aefb7, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:14:10,114 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d622f2df-c67a-4145-b7f7-8edc441aefb7, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:14:10,116 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d622f2df-c67a-4145-b7f7-8edc441aefb7, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:10,469 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:10,469 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:10,470 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 24e230f5-9670-493e-a407-cb842c120fc8, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:14:10,471 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 24e230f5-9670-493e-a407-cb842c120fc8, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:14:10,472 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 24e230f5-9670-493e-a407-cb842c120fc8, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:11,479 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:11,480 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 16184320, 'BlobCount': 1280}}
2025-11-06 10:14:11,480 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:11,481 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, eaf9629d-188c-4019-9501-3429e6f532c7, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:14:11,484 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, eaf9629d-188c-4019-9501-3429e6f532c7, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/off_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:14:11,486 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, eaf9629d-188c-4019-9501-3429e6f532c7, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:12,986 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:12,987 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:12,988 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, bfead9eb-688d-41f0-8675-9b5f1b215fb6, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:14:12,990 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, bfead9eb-688d-41f0-8675-9b5f1b215fb6, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:14:12,992 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, bfead9eb-688d-41f0-8675-9b5f1b215fb6, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:13,557 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:13,558 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:13,559 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, cfa17dd9-06a5-40c7-a2fd-013f844ccc3e, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:14:13,559 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, cfa17dd9-06a5-40c7-a2fd-013f844ccc3e, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:14:13,561 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, cfa17dd9-06a5-40c7-a2fd-013f844ccc3e, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:13,996 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:13,997 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:13,998 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 40f775f0-485d-4969-8bc5-24dc8ebdbf11, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:14:13,999 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 40f775f0-485d-4969-8bc5-24dc8ebdbf11, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:14:14,000 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 40f775f0-485d-4969-8bc5-24dc8ebdbf11, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:18,147 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:28,187 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:28,188 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8d11922f-f2c3-4161-ba2a-7fe46cf23664, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:14:28,189 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8d11922f-f2c3-4161-ba2a-7fe46cf23664, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:14:28,191 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8d11922f-f2c3-4161-ba2a-7fe46cf23664, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:32,216 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:32,256 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-11-06 10:14:32,257 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:32,258 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c4cb523c-311c-4ca1-9a84-433a98e6b48e, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:14:32,258 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c4cb523c-311c-4ca1-9a84-433a98e6b48e, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:14:32,260 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c4cb523c-311c-4ca1-9a84-433a98e6b48e, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:35,668 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:45,714 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:14:45,715 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8f0385e7-4ca6-479b-a7ef-21dcc216c5a3, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:14:45,716 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8f0385e7-4ca6-479b-a7ef-21dcc216c5a3, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:14:45,717 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8f0385e7-4ca6-479b-a7ef-21dcc216c5a3, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:50,174 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:00,235 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:00,236 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 06fc8f5b-8127-447c-b277-2f54a168110f, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:15:00,236 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 06fc8f5b-8127-447c-b277-2f54a168110f, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:00,238 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 06fc8f5b-8127-447c-b277-2f54a168110f, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:01,046 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:11,051 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:11,051 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0efb14f8-e147-40b7-b2ba-f587699eea40, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:15:11,052 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0efb14f8-e147-40b7-b2ba-f587699eea40, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:11,054 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0efb14f8-e147-40b7-b2ba-f587699eea40, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:11,852 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:11,856 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8009216)
2025-11-06 10:15:11,857 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:11,857 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 935501a7-cc19-4496-87da-03fa2eef7c8a, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:15:11,858 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 935501a7-cc19-4496-87da-03fa2eef7c8a, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:11,861 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 935501a7-cc19-4496-87da-03fa2eef7c8a, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:12,177 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:12,181 - INFO - ya.test - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_20_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 20])
2025-11-06 10:15:12,182 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:12,183 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 429d4a12-8cfc-4b15-85b7-0c0011f08dcb, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:15:12,184 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 429d4a12-8cfc-4b15-85b7-0c0011f08dcb, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_20_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 20)\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:12,185 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 429d4a12-8cfc-4b15-85b7-0c0011f08dcb, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:15,663 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:15,664 - INFO - __tests__.alter_compression - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_20_compression created
2025-11-06 10:15:15,664 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:15,665 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, aac94773-fdbc-46c0-af32-4618c91d92b7, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:15:15,666 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, aac94773-fdbc-46c0-af32-4618c91d92b7, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_20_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:15,667 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, aac94773-fdbc-46c0-af32-4618c91d92b7, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:16,571 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:16,572 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:16,573 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 38d1c999-992d-4a15-b1c9-1dc6f1391f24, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:15:16,576 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 38d1c999-992d-4a15-b1c9-1dc6f1391f24, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" 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_20_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:16,577 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 38d1c999-992d-4a15-b1c9-1dc6f1391f24, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:22,123 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:22,124 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:22,125 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7c44f39c-9531-49ed-b0ad-401f5a4ae5e4, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:15:22,126 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7c44f39c-9531-49ed-b0ad-401f5a4ae5e4, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:22,127 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7c44f39c-9531-49ed-b0ad-401f5a4ae5e4, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:23,165 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:23,166 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:23,167 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a2923b0b-62f8-4943-aff4-2aa31c7da240, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:15:23,168 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a2923b0b-62f8-4943-aff4-2aa31c7da240, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" 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_20_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:23,171 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a2923b0b-62f8-4943-aff4-2aa31c7da240, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:25,076 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:25,077 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_20_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318528, 'BlobCount': 128}}
2025-11-06 10:15:25,078 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:25,079 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f6a6afdf-a25a-42d7-90b9-ce12547b90a1, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:15:25,080 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f6a6afdf-a25a-42d7-90b9-ce12547b90a1, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" 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_20_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:25,081 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f6a6afdf-a25a-42d7-90b9-ce12547b90a1, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:25,187 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-06 10:15:25,188 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-06 10:15:25,217 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-06 10:15:25,218 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 15570f4f-ff7a-4f3f-8359-0443303d38bf, localhost:62684): creating call state
2025-11-06 10:15:25,219 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 15570f4f-ff7a-4f3f-8359-0443303d38bf, localhost:62684): request = { database: "/Root" }
2025-11-06 10:15:25,226 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 15570f4f-ff7a-4f3f-8359-0443303d38bf, localhost:62684): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-ew6xquenpy.auto.internal" port: 62684 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-11-06 10:15:25,227 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-ew6xquenpy.auto.internal:62684, location 1, ssl: False>]>
2025-11-06 10:15:25,228 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:62684
2025-11-06 10:15:30,136 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:30,137 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:30,138 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c0ae44fd-7a2e-41b7-86c5-940b41d95231, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:15:30,139 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c0ae44fd-7a2e-41b7-86c5-940b41d95231, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:30,141 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c0ae44fd-7a2e-41b7-86c5-940b41d95231, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:30,535 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:30,536 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:30,537 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0647b96c-4ed3-4b36-b3d0-7512381710f6, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:15:30,538 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0647b96c-4ed3-4b36-b3d0-7512381710f6, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" 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_20_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:30,548 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0647b96c-4ed3-4b36-b3d0-7512381710f6, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:31,034 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:31,035 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_20_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 637920, 'BlobCount': 256}}
2025-11-06 10:15:31,036 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:31,036 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b0367254-c0e3-4f1e-b8ab-e136586f9548, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:15:31,037 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b0367254-c0e3-4f1e-b8ab-e136586f9548, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" 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_20_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:31,039 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b0367254-c0e3-4f1e-b8ab-e136586f9548, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:35,694 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:35,695 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:35,695 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, fef091eb-38f5-4c90-b53b-d8751b1b1b3e, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:15:35,696 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, fef091eb-38f5-4c90-b53b-d8751b1b1b3e, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:35,697 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, fef091eb-38f5-4c90-b53b-d8751b1b1b3e, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:36,100 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:36,100 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:36,101 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4c5883e5-cb6e-4535-8ede-ffedaa813e1b, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:15:36,101 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4c5883e5-cb6e-4535-8ede-ffedaa813e1b, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" 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_20_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:36,103 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4c5883e5-cb6e-4535-8ede-ffedaa813e1b, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:36,624 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:36,625 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_20_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 956816, 'BlobCount': 384}}
2025-11-06 10:15:36,625 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:36,626 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9ba80fd9-203c-484a-b1f6-ef14c932a267, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:15:36,627 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9ba80fd9-203c-484a-b1f6-ef14c932a267, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" 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_20_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:36,628 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9ba80fd9-203c-484a-b1f6-ef14c932a267, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:41,155 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:41,156 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:41,157 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, caaaceb6-a1cd-427a-8296-b17c8071408d, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:15:41,158 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, caaaceb6-a1cd-427a-8296-b17c8071408d, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:41,160 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, caaaceb6-a1cd-427a-8296-b17c8071408d, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:41,427 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:41,428 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:41,429 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8490bccd-c1ac-4d48-b729-4e88a1f28e6d, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:15:41,430 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8490bccd-c1ac-4d48-b729-4e88a1f28e6d, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" 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_20_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:41,434 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8490bccd-c1ac-4d48-b729-4e88a1f28e6d, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:41,886 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:41,887 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_20_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1276240, 'BlobCount': 512}}
2025-11-06 10:15:41,887 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:41,888 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7862b355-160e-4938-997f-d8fb605a6504, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:15:41,889 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7862b355-160e-4938-997f-d8fb605a6504, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" 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_20_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:41,891 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7862b355-160e-4938-997f-d8fb605a6504, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:46,115 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:46,116 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:46,116 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e6f0a0da-c380-40b9-98c0-a3cd0240103c, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:15:46,117 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e6f0a0da-c380-40b9-98c0-a3cd0240103c, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:46,119 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e6f0a0da-c380-40b9-98c0-a3cd0240103c, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:46,491 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:46,492 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:46,493 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e43cc969-6d5d-4d65-a1b9-4d71bdd8d693, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:15:46,494 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e43cc969-6d5d-4d65-a1b9-4d71bdd8d693, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" 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_20_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:46,495 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e43cc969-6d5d-4d65-a1b9-4d71bdd8d693, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:46,986 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:46,987 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_20_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1595136, 'BlobCount': 640}}
2025-11-06 10:15:46,987 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:46,988 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b0eda089-a856-4c6e-bb84-86e9d45d9bd0, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:15:46,989 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b0eda089-a856-4c6e-bb84-86e9d45d9bd0, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" 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_20_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:46,991 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b0eda089-a856-4c6e-bb84-86e9d45d9bd0, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:51,676 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:51,677 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:51,677 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9fb9d3da-236e-473c-8f07-b17aa0bde331, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:15:51,678 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9fb9d3da-236e-473c-8f07-b17aa0bde331, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:51,680 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9fb9d3da-236e-473c-8f07-b17aa0bde331, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:52,011 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:52,012 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:52,013 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0b730494-01f7-4800-843f-1635b310f483, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:15:52,014 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0b730494-01f7-4800-843f-1635b310f483, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" 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_20_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:52,016 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0b730494-01f7-4800-843f-1635b310f483, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:52,571 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:52,572 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_20_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1914416, 'BlobCount': 768}}
2025-11-06 10:15:52,573 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:52,573 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9fb986b5-cce1-409f-88e8-b784ca3d0014, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:15:52,574 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9fb986b5-cce1-409f-88e8-b784ca3d0014, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" 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_20_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:52,576 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9fb986b5-cce1-409f-88e8-b784ca3d0014, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:56,660 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:56,660 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:56,661 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b7e6c83e-0eb0-4677-ae72-047a7d80fbfd, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:15:56,662 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b7e6c83e-0eb0-4677-ae72-047a7d80fbfd, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:56,663 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b7e6c83e-0eb0-4677-ae72-047a7d80fbfd, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:56,908 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:56,908 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:56,909 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 92c31461-58d0-471b-b389-bc11874dfd5c, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:15:56,909 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 92c31461-58d0-471b-b389-bc11874dfd5c, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" 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_20_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:56,911 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 92c31461-58d0-471b-b389-bc11874dfd5c, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:57,388 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:57,389 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_20_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2233456, 'BlobCount': 896}}
2025-11-06 10:15:57,389 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:15:57,390 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f84b37c4-d811-4bb1-be27-e8bc50d8b495, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:15:57,391 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f84b37c4-d811-4bb1-be27-e8bc50d8b495, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" 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_20_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:57,393 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f84b37c4-d811-4bb1-be27-e8bc50d8b495, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:16:02,115 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:16:02,118 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:16:02,119 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7d5e894d-2876-4741-95f6-afb8939a5b25, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:16:02,120 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7d5e894d-2876-4741-95f6-afb8939a5b25, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:16:02,121 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7d5e894d-2876-4741-95f6-afb8939a5b25, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:16:02,644 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:16:02,645 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:16:02,646 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ae3b4a22-de18-4da9-a1af-ac6226546584, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:16:02,647 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ae3b4a22-de18-4da9-a1af-ac6226546584, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" 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_20_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:16:02,648 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ae3b4a22-de18-4da9-a1af-ac6226546584, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:16:03,276 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:16:03,277 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_20_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2552960, 'BlobCount': 1024}}
2025-11-06 10:16:03,277 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:16:03,278 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 05d4bc13-951c-473c-b91c-f01cd872ffe9, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:16:03,283 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 05d4bc13-951c-473c-b91c-f01cd872ffe9, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" 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_20_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:16:03,285 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 05d4bc13-951c-473c-b91c-f01cd872ffe9, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:16:07,880 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:16:07,881 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:16:07,881 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0d4e9c74-a83f-4e8b-9ac1-0ab0606e49a1, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:16:07,882 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0d4e9c74-a83f-4e8b-9ac1-0ab0606e49a1, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:16:07,884 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0d4e9c74-a83f-4e8b-9ac1-0ab0606e49a1, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:16:08,189 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:16:08,190 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:16:08,191 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 22daa958-0692-450e-bad2-26d325518f51, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:16:08,192 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 22daa958-0692-450e-bad2-26d325518f51, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" 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_20_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:16:08,194 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 22daa958-0692-450e-bad2-26d325518f51, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:16:08,881 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:16:08,882 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_20_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2871840, 'BlobCount': 1152}}
2025-11-06 10:16:08,882 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:16:08,883 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b16b8390-0fd1-4cab-81ae-4ca14da74c68, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:16:08,884 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b16b8390-0fd1-4cab-81ae-4ca14da74c68, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" 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_20_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:16:08,888 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b16b8390-0fd1-4cab-81ae-4ca14da74c68, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:16:13,315 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:16:13,316 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:16:13,316 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c1d2dcad-3f6b-41a8-9f06-83382e1136c7, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:16:13,317 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c1d2dcad-3f6b-41a8-9f06-83382e1136c7, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:16:13,319 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c1d2dcad-3f6b-41a8-9f06-83382e1136c7, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:16:13,563 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:16:13,564 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:16:13,564 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 76a3525e-657d-4a9a-a71a-767db0f88148, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:16:13,565 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 76a3525e-657d-4a9a-a71a-767db0f88148, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" 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_20_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:16:13,567 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 76a3525e-657d-4a9a-a71a-767db0f88148, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:16:14,220 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:16:14,221 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_20_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3191408, 'BlobCount': 1280}}
2025-11-06 10:16:14,221 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:16:14,221 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ab25f468-ab04-4dea-bd5d-7e44bfa37eef, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:16:14,222 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ab25f468-ab04-4dea-bd5d-7e44bfa37eef, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_20_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:16:14,223 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ab25f468-ab04-4dea-bd5d-7e44bfa37eef, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:16:15,887 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:16:15,887 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:16:15,888 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 65b0b7bb-f90a-4705-9c3a-1659a18cb64a, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:16:15,889 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 65b0b7bb-f90a-4705-9c3a-1659a18cb64a, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:16:15,891 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 65b0b7bb-f90a-4705-9c3a-1659a18cb64a, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:16:16,394 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:16:16,395 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:16:16,396 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d84edb38-27c6-490b-ba2f-a934eae50f14, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:16:16,397 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d84edb38-27c6-490b-ba2f-a934eae50f14, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:16:16,399 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d84edb38-27c6-490b-ba2f-a934eae50f14, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:16:16,818 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:16:16,819 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:16:16,820 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 18266e02-3842-4689-997b-0e9665b5b814, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:16:16,821 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 18266e02-3842-4689-997b-0e9665b5b814, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_20_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:16:16,822 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 18266e02-3842-4689-997b-0e9665b5b814, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:16:20,726 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:16:30,755 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:16:30,756 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e6065707-d31e-46a5-925a-3ec3e6d89a3e, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:16:30,757 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e6065707-d31e-46a5-925a-3ec3e6d89a3e, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_20_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:16:30,758 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e6065707-d31e-46a5-925a-3ec3e6d89a3e, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:16:33,006 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:16:35,467 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-06 10:16:35,467 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-06 10:16:35,488 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-06 10:16:35,488 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 66204def-525f-44f4-881f-e6aa60f67e4b, localhost:62684): creating call state
2025-11-06 10:16:35,488 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 66204def-525f-44f4-881f-e6aa60f67e4b, localhost:62684): request = { database: "/Root" }
2025-11-06 10:16:35,496 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 66204def-525f-44f4-881f-e6aa60f67e4b, localhost:62684): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-ew6xquenpy.auto.internal" port: 62684 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-11-06 10:16:35,497 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-ew6xquenpy.auto.internal:62684, location 1, ssl: False>]>
2025-11-06 10:16:35,498 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:62684
2025-11-06 10:16:43,026 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:16:43,027 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, be84f50c-6a3d-42f7-ae65-eb66703f18ca, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:16:43,028 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, be84f50c-6a3d-42f7-ae65-eb66703f18ca, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_20_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:16:43,030 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, be84f50c-6a3d-42f7-ae65-eb66703f18ca, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:16:44,231 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:16:54,259 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:16:54,260 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e73e81f9-d9a2-4106-82f5-ac034cd41306, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:16:54,261 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e73e81f9-d9a2-4106-82f5-ac034cd41306, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_20_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:16:54,262 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e73e81f9-d9a2-4106-82f5-ac034cd41306, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:16:55,008 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:17:05,015 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:17:05,016 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9d0e38df-3152-4a2a-bba8-9aa829280027, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:17:05,016 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9d0e38df-3152-4a2a-bba8-9aa829280027, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_20_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:17:05,018 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9d0e38df-3152-4a2a-bba8-9aa829280027, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:17:05,829 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:17:05,833 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_20_compression`, volumes `value` (8000000, 1465928)
2025-11-06 10:17:05,834 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:17:05,834 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a666d2d9-b571-40f7-a773-ba1254997804, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:17:05,835 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a666d2d9-b571-40f7-a773-ba1254997804, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:17:05,838 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a666d2d9-b571-40f7-a773-ba1254997804, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:17:06,211 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:17:06,212 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:17:06,213 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4b0f4ce1-8a24-4e51-8502-f83a38fd8ddb, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:17:06,214 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4b0f4ce1-8a24-4e51-8502-f83a38fd8ddb, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_20_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:17:06,216 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4b0f4ce1-8a24-4e51-8502-f83a38fd8ddb, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:17:06,930 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:17:16,937 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:17:16,938 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2f8f395f-6600-41ff-b33b-85d36fc899c3, ghrun-ew6xquenpy.auto.internal:62684): creating call state
2025-11-06 10:17:16,938 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2f8f395f-6600-41ff-b33b-85d36fc899c3, ghrun-ew6xquenpy.auto.internal:62684): request = { session_id: "ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_20_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:17:16,940 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2f8f395f-6600-41ff-b33b-85d36fc899c3, ghrun-ew6xquenpy.auto.internal:62684): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:17:17,760 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2NkNGRmZGItODg4MjcxMjctMWY1YmZkMzMtNDVkMWZjOTU=
2025-11-06 10:17:17,764 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_20_compression`, volumes `value` (8000000, 1465928)
2025-11-06 10:17:17,765 - INFO - root - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_20_compression` 8092160 / 1465928: 5.520161972484324
2025-11-06 10:17:17,767 - INFO - ya.test - pytest_runtest_teardown: Test teardown
