2025-11-06 10:13:38,048 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-06 10:13:38,049 - INFO - ya.test - pytest_runtest_setup: test_all_supported_compression[zstd_4_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 4]
2025-11-06 10:13:38,050 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-06 10:13:38,051 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-06 10:13:38,053 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-11-06 10:13:38,054 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-11-06 10:13:38,054 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/2dji/004566/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-06 10:13:38,055 - DEBUG - ya.test - execute: Command pid: 486682
2025-11-06 10:13:38,855 - DEBUG - ya.test - _save_outputs: Command (pid 486682) rc: 0
2025-11-06 10:13:38,855 - DEBUG - ya.test - _save_outputs: Command (pid 486682) elapsed time (sec): 0.794257402420044
2025-11-06 10:13:38,855 - DEBUG - ya.test - _save_outputs: Command (pid 486682) idrss: 0
2025-11-06 10:13:38,856 - DEBUG - ya.test - _save_outputs: Command (pid 486682) inblock: 0
2025-11-06 10:13:38,856 - DEBUG - ya.test - _save_outputs: Command (pid 486682) isrss: 0
2025-11-06 10:13:38,856 - DEBUG - ya.test - _save_outputs: Command (pid 486682) ixrss: 0
2025-11-06 10:13:38,857 - DEBUG - ya.test - _save_outputs: Command (pid 486682) majflt: 0
2025-11-06 10:13:38,857 - DEBUG - ya.test - _save_outputs: Command (pid 486682) maxrss: 494856
2025-11-06 10:13:38,857 - DEBUG - ya.test - _save_outputs: Command (pid 486682) minflt: 45445
2025-11-06 10:13:38,857 - DEBUG - ya.test - _save_outputs: Command (pid 486682) msgrcv: 0
2025-11-06 10:13:38,857 - DEBUG - ya.test - _save_outputs: Command (pid 486682) msgsnd: 0
2025-11-06 10:13:38,858 - DEBUG - ya.test - _save_outputs: Command (pid 486682) nivcsw: 125
2025-11-06 10:13:38,858 - DEBUG - ya.test - _save_outputs: Command (pid 486682) nsignals: 0
2025-11-06 10:13:38,858 - DEBUG - ya.test - _save_outputs: Command (pid 486682) nswap: 0
2025-11-06 10:13:38,859 - DEBUG - ya.test - _save_outputs: Command (pid 486682) nvcsw: 15
2025-11-06 10:13:38,859 - DEBUG - ya.test - _save_outputs: Command (pid 486682) oublock: 8
2025-11-06 10:13:38,859 - DEBUG - ya.test - _save_outputs: Command (pid 486682) stime: 0.20468799999999998
2025-11-06 10:13:38,859 - DEBUG - ya.test - _save_outputs: Command (pid 486682) utime: 0.5167809999999999
2025-11-06 10:13:38,860 - DEBUG - ya.test - _save_outputs: Command (pid 486682) wtime: 0.796
2025-11-06 10:13:38,860 - DEBUG - ya.test - _save_outputs: Command (pid 486682) 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:38,860 - DEBUG - ya.test - _save_outputs: Command (pid 486682) errors:

2025-11-06 10:13:38,861 - 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:39,004 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/2dji/004566/ydb/apps/ydbd/ydbd
2025-11-06 10:13:39,006 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/15187
2025-11-06 10:13:39,013 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/2dji/004566/r3tmp/kikimr_cluster_vjloab3j
2025-11-06 10:13:39,081 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/2dji/004566/ydb/apps/ydbd/ydbd
2025-11-06 10:13:39,082 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/13552
2025-11-06 10:13:39,083 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/21844
2025-11-06 10:13:39,083 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/9450
2025-11-06 10:13:39,084 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/61365
2025-11-06 10:13:39,085 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/2dji/004566/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/kikimr_configs"
2025-11-06 10:13:39,085 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/2dji/004566/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/004566/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/node_1/logfile_0afuln4g.log --grpc-port=13552 --mon-port=21844 --ic-port=15187
2025-11-06 10:13:39,086 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:13552/1, disk_size 68719476736
2025-11-06 10:13:39,086 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/2dji/004566/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/kikimr_configs"
2025-11-06 10:13:39,086 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/2dji/004566/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/004566/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/node_1/logfile_0afuln4g.log --grpc-port=13552 --mon-port=21844 --ic-port=15187
2025-11-06 10:13:39,088 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/2dji/004566/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/2dji/004566/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/2dji/004566/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/node_1/logfile_0afuln4g.log', '--grpc-port=13552', '--mon-port=21844', '--ic-port=15187')' in '/home/runner/.ya/build/build_root/2dji/004566/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/node_1' (no wait)
2025-11-06 10:13:39,090 - DEBUG - ya.test - execute: Command pid: 487192
2025-11-06 10:13:39,091 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:13552/1
2025-11-06 10:13:39,092 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-11-06 10:13:39,093 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-11-06 10:13:39,093 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/2dji/004566/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-06 10:13:39,095 - DEBUG - ya.test - execute: Command pid: 487193
2025-11-06 10:13:39,871 - DEBUG - ya.test - _save_outputs: Command (pid 487193) rc: 0
2025-11-06 10:13:39,871 - DEBUG - ya.test - _save_outputs: Command (pid 487193) elapsed time (sec): 0.7689623832702637
2025-11-06 10:13:39,872 - DEBUG - ya.test - _save_outputs: Command (pid 487193) idrss: 0
2025-11-06 10:13:39,872 - DEBUG - ya.test - _save_outputs: Command (pid 487193) inblock: 0
2025-11-06 10:13:39,872 - DEBUG - ya.test - _save_outputs: Command (pid 487193) isrss: 0
2025-11-06 10:13:39,872 - DEBUG - ya.test - _save_outputs: Command (pid 487193) ixrss: 0
2025-11-06 10:13:39,873 - DEBUG - ya.test - _save_outputs: Command (pid 487193) majflt: 0
2025-11-06 10:13:39,873 - DEBUG - ya.test - _save_outputs: Command (pid 487193) maxrss: 503636
2025-11-06 10:13:39,873 - DEBUG - ya.test - _save_outputs: Command (pid 487193) minflt: 45344
2025-11-06 10:13:39,873 - DEBUG - ya.test - _save_outputs: Command (pid 487193) msgrcv: 0
2025-11-06 10:13:39,874 - DEBUG - ya.test - _save_outputs: Command (pid 487193) msgsnd: 0
2025-11-06 10:13:39,874 - DEBUG - ya.test - _save_outputs: Command (pid 487193) nivcsw: 108
2025-11-06 10:13:39,874 - DEBUG - ya.test - _save_outputs: Command (pid 487193) nsignals: 0
2025-11-06 10:13:39,879 - DEBUG - ya.test - _save_outputs: Command (pid 487193) nswap: 0
2025-11-06 10:13:39,879 - DEBUG - ya.test - _save_outputs: Command (pid 487193) nvcsw: 14
2025-11-06 10:13:39,879 - DEBUG - ya.test - _save_outputs: Command (pid 487193) oublock: 8
2025-11-06 10:13:39,880 - DEBUG - ya.test - _save_outputs: Command (pid 487193) stime: 0.195625
2025-11-06 10:13:39,880 - DEBUG - ya.test - _save_outputs: Command (pid 487193) utime: 0.45963699999999996
2025-11-06 10:13:39,880 - DEBUG - ya.test - _save_outputs: Command (pid 487193) wtime: 0.771
2025-11-06 10:13:39,880 - DEBUG - ya.test - _save_outputs: Command (pid 487193) 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:39,881 - DEBUG - ya.test - _save_outputs: Command (pid 487193) errors:

2025-11-06 10:13:39,881 - 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,157 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/2dji/004566/ydb/apps/ydbd/ydbd
2025-11-06 10:13:42,158 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/2dji/004566/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:13552', '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: 15187\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-06 10:13:42,159 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-11-06 10:13:42,160 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-11-06 10:13:42,161 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/2dji/004566/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:13552', '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: 15187\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-06 10:13:42,162 - DEBUG - ya.test - execute: Command pid: 488857
2025-11-06 10:13:43,216 - DEBUG - ya.test - _save_outputs: Command (pid 488857) rc: 0
2025-11-06 10:13:43,216 - DEBUG - ya.test - _save_outputs: Command (pid 488857) elapsed time (sec): 1.0525691509246826
2025-11-06 10:13:43,216 - DEBUG - ya.test - _save_outputs: Command (pid 488857) idrss: 0
2025-11-06 10:13:43,217 - DEBUG - ya.test - _save_outputs: Command (pid 488857) inblock: 0
2025-11-06 10:13:43,217 - DEBUG - ya.test - _save_outputs: Command (pid 488857) isrss: 0
2025-11-06 10:13:43,217 - DEBUG - ya.test - _save_outputs: Command (pid 488857) ixrss: 0
2025-11-06 10:13:43,218 - DEBUG - ya.test - _save_outputs: Command (pid 488857) majflt: 0
2025-11-06 10:13:43,218 - DEBUG - ya.test - _save_outputs: Command (pid 488857) maxrss: 549176
2025-11-06 10:13:43,218 - DEBUG - ya.test - _save_outputs: Command (pid 488857) minflt: 51629
2025-11-06 10:13:43,219 - DEBUG - ya.test - _save_outputs: Command (pid 488857) msgrcv: 0
2025-11-06 10:13:43,219 - DEBUG - ya.test - _save_outputs: Command (pid 488857) msgsnd: 0
2025-11-06 10:13:43,220 - DEBUG - ya.test - _save_outputs: Command (pid 488857) nivcsw: 159
2025-11-06 10:13:43,220 - DEBUG - ya.test - _save_outputs: Command (pid 488857) nsignals: 0
2025-11-06 10:13:43,220 - DEBUG - ya.test - _save_outputs: Command (pid 488857) nswap: 0
2025-11-06 10:13:43,220 - DEBUG - ya.test - _save_outputs: Command (pid 488857) nvcsw: 723
2025-11-06 10:13:43,221 - DEBUG - ya.test - _save_outputs: Command (pid 488857) oublock: 8
2025-11-06 10:13:43,221 - DEBUG - ya.test - _save_outputs: Command (pid 488857) stime: 0.29279299999999997
2025-11-06 10:13:43,221 - DEBUG - ya.test - _save_outputs: Command (pid 488857) utime: 0.563716
2025-11-06 10:13:43,222 - DEBUG - ya.test - _save_outputs: Command (pid 488857) wtime: 1.054
2025-11-06 10:13:43,222 - DEBUG - ya.test - _save_outputs: Command (pid 488857) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

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

2025-11-06 10:13:43,224 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/2dji/004566/ydb/apps/ydbd/ydbd
2025-11-06 10:13:43,224 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/2dji/004566/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:13552', '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,226 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-11-06 10:13:43,227 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-11-06 10:13:43,227 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/2dji/004566/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:13552', '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,235 - DEBUG - ya.test - execute: Command pid: 489480
2025-11-06 10:13:44,189 - DEBUG - ya.test - _save_outputs: Command (pid 489480) rc: 0
2025-11-06 10:13:44,190 - DEBUG - ya.test - _save_outputs: Command (pid 489480) elapsed time (sec): 0.9533858299255371
2025-11-06 10:13:44,190 - DEBUG - ya.test - _save_outputs: Command (pid 489480) idrss: 0
2025-11-06 10:13:44,191 - DEBUG - ya.test - _save_outputs: Command (pid 489480) inblock: 0
2025-11-06 10:13:44,191 - DEBUG - ya.test - _save_outputs: Command (pid 489480) isrss: 0
2025-11-06 10:13:44,191 - DEBUG - ya.test - _save_outputs: Command (pid 489480) ixrss: 0
2025-11-06 10:13:44,192 - DEBUG - ya.test - _save_outputs: Command (pid 489480) majflt: 0
2025-11-06 10:13:44,192 - DEBUG - ya.test - _save_outputs: Command (pid 489480) maxrss: 549176
2025-11-06 10:13:44,192 - DEBUG - ya.test - _save_outputs: Command (pid 489480) minflt: 51550
2025-11-06 10:13:44,193 - DEBUG - ya.test - _save_outputs: Command (pid 489480) msgrcv: 0
2025-11-06 10:13:44,193 - DEBUG - ya.test - _save_outputs: Command (pid 489480) msgsnd: 0
2025-11-06 10:13:44,193 - DEBUG - ya.test - _save_outputs: Command (pid 489480) nivcsw: 141
2025-11-06 10:13:44,193 - DEBUG - ya.test - _save_outputs: Command (pid 489480) nsignals: 0
2025-11-06 10:13:44,194 - DEBUG - ya.test - _save_outputs: Command (pid 489480) nswap: 0
2025-11-06 10:13:44,194 - DEBUG - ya.test - _save_outputs: Command (pid 489480) nvcsw: 410
2025-11-06 10:13:44,194 - DEBUG - ya.test - _save_outputs: Command (pid 489480) oublock: 8
2025-11-06 10:13:44,201 - DEBUG - ya.test - _save_outputs: Command (pid 489480) stime: 0.220141
2025-11-06 10:13:44,201 - DEBUG - ya.test - _save_outputs: Command (pid 489480) utime: 0.588959
2025-11-06 10:13:44,202 - DEBUG - ya.test - _save_outputs: Command (pid 489480) wtime: 0.961
2025-11-06 10:13:44,202 - DEBUG - ya.test - _save_outputs: Command (pid 489480) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

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

2025-11-06 10:13:44,203 - 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,502 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-11-06 10:13:44,568 - 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,578 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-06 10:13:44,581 - 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,635 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-06 10:13:44,636 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 32e11d12-2315-4ab5-819b-136dbafe6276, localhost:13552): creating call state
2025-11-06 10:13:44,636 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 32e11d12-2315-4ab5-819b-136dbafe6276, localhost:13552): request = { database: "/Root" }
2025-11-06 10:13:44,648 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 32e11d12-2315-4ab5-819b-136dbafe6276, localhost:13552): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-ew6xquenpy.auto.internal" port: 13552 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,649 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-ew6xquenpy.auto.internal:13552, location 1, ssl: False>]>
2025-11-06 10:13:44,650 - 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,672 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:13552
2025-11-06 10:13:44,673 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-06 10:13:44,675 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, b6731834-a5b8-4212-8a6e-4faa67e65172, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:13:44,676 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, b6731834-a5b8-4212-8a6e-4faa67e65172, ghrun-ew6xquenpy.auto.internal:13552): request = {  }
2025-11-06 10:13:44,686 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, b6731834-a5b8-4212-8a6e-4faa67e65172, ghrun-ew6xquenpy.auto.internal:13552): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" node_id: 1 }
2025-11-06 10:13:44,687 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, 25466580-3a75-47a8-b640-31a4d409353d, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:13:44,688 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, 25466580-3a75-47a8-b640-31a4d409353d, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" }
2025-11-06 10:13:44,703 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, 25466580-3a75-47a8-b640-31a4d409353d, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:13:44,715 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:13:44,716 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, dc4450c8-d1cc-4d94-90a9-c88bcab2b1be, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:13:44,717 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, dc4450c8-d1cc-4d94-90a9-c88bcab2b1be, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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,719 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, dc4450c8-d1cc-4d94-90a9-c88bcab2b1be, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:13:47,979 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:13:47,980 - INFO - __tests__.alter_compression - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-11-06 10:13:47,980 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:13:47,981 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5b164cba-9c1a-4ad8-978a-75d3cea721c3, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:13:47,982 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5b164cba-9c1a-4ad8-978a-75d3cea721c3, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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,984 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5b164cba-9c1a-4ad8-978a-75d3cea721c3, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:13:48,953 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:13:48,954 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:13:48,955 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, bb38987a-143a-4864-b3f3-4b58d1093d0b, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:13:48,957 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, bb38987a-143a-4864-b3f3-4b58d1093d0b, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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,959 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, bb38987a-143a-4864-b3f3-4b58d1093d0b, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:13:50,040 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:13:50,041 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:13:50,042 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ac891938-0be2-4839-ae77-6fc5d23a1452, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:13:50,043 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ac891938-0be2-4839-ae77-6fc5d23a1452, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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:50,068 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ac891938-0be2-4839-ae77-6fc5d23a1452, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:13:50,917 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:13:50,918 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:13:50,919 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e06c2f6d-9b9c-4f07-993e-49667ae2146f, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:13:50,919 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e06c2f6d-9b9c-4f07-993e-49667ae2146f, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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,921 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e06c2f6d-9b9c-4f07-993e-49667ae2146f, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:13:52,189 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:13:52,194 - 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:52,195 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:13:52,199 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b9533287-d06c-494f-a925-fedb689c8009, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:13:52,200 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b9533287-d06c-494f-a925-fedb689c8009, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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:52,202 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b9533287-d06c-494f-a925-fedb689c8009, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:13:53,377 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:13:53,378 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:13:53,379 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ad5c0c92-1722-4cc0-b3ca-12b09bdca37d, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:13:53,380 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ad5c0c92-1722-4cc0-b3ca-12b09bdca37d, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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:53,381 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ad5c0c92-1722-4cc0-b3ca-12b09bdca37d, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:13:53,685 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:13:53,687 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:13:53,688 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ae679040-77e7-4dd8-9cb2-5dab5a6eec4c, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:13:53,688 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ae679040-77e7-4dd8-9cb2-5dab5a6eec4c, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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,689 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ae679040-77e7-4dd8-9cb2-5dab5a6eec4c, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:13:53,987 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:13:53,987 - 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,988 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:13:53,989 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b9e117fd-8be6-4ad3-b0dd-1ca2200b4517, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:13:53,990 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b9e117fd-8be6-4ad3-b0dd-1ca2200b4517, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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,992 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b9e117fd-8be6-4ad3-b0dd-1ca2200b4517, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:13:55,062 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:13:55,063 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:13:55,064 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, cdbea33e-a52f-4c11-a71b-962dcc5e5184, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:13:55,065 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, cdbea33e-a52f-4c11-a71b-962dcc5e5184, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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:55,066 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, cdbea33e-a52f-4c11-a71b-962dcc5e5184, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:13:55,339 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:13:55,340 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:13:55,341 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d521ebfa-7b4c-467c-a8a7-a521edaca652, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:13:55,342 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d521ebfa-7b4c-467c-a8a7-a521edaca652, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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:55,343 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d521ebfa-7b4c-467c-a8a7-a521edaca652, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:13:55,731 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:13:55,732 - 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,733 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:13:55,734 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ad20d9d9-ba02-4693-ab3f-31bad3a589ea, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:13:55,739 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ad20d9d9-ba02-4693-ab3f-31bad3a589ea, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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,741 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ad20d9d9-ba02-4693-ab3f-31bad3a589ea, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:13:56,787 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:13:56,788 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:13:56,792 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 437a725d-3ae3-49c2-be6b-b1499f023707, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:13:56,793 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 437a725d-3ae3-49c2-be6b-b1499f023707, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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,794 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 437a725d-3ae3-49c2-be6b-b1499f023707, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:13:57,075 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:13:57,076 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:13:57,077 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9df19a85-62a4-4707-a2b3-c635260cc467, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:13:57,077 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9df19a85-62a4-4707-a2b3-c635260cc467, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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:57,079 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9df19a85-62a4-4707-a2b3-c635260cc467, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:13:57,589 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:13:57,590 - 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,590 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:13:57,591 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4e6b00c0-6845-4de8-b30e-bea78f4b867d, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:13:57,592 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4e6b00c0-6845-4de8-b30e-bea78f4b867d, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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,593 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4e6b00c0-6845-4de8-b30e-bea78f4b867d, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:13:58,706 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:13:58,707 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:13:58,707 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 57cb82da-a9cd-4017-ba0c-162124a67c12, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:13:58,708 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 57cb82da-a9cd-4017-ba0c-162124a67c12, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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,710 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 57cb82da-a9cd-4017-ba0c-162124a67c12, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:13:59,097 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:13:59,098 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:13:59,107 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 93918f3f-4cd2-4abc-8181-1a05f52644af, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:13:59,109 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 93918f3f-4cd2-4abc-8181-1a05f52644af, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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:59,110 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 93918f3f-4cd2-4abc-8181-1a05f52644af, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:13:59,940 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:13:59,941 - 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,942 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:13:59,942 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a5da73b9-a637-4ff7-a5df-eaac21dd31ff, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:13:59,944 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a5da73b9-a637-4ff7-a5df-eaac21dd31ff, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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,945 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a5da73b9-a637-4ff7-a5df-eaac21dd31ff, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:01,071 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:01,072 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:01,073 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, de0ac185-a962-4dae-bd13-a0b8d1aa1533, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:14:01,073 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, de0ac185-a962-4dae-bd13-a0b8d1aa1533, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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:01,075 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, de0ac185-a962-4dae-bd13-a0b8d1aa1533, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:01,396 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:01,397 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:01,398 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8b7318a9-90aa-4be5-8c62-1e55c907fb22, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:14:01,402 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8b7318a9-90aa-4be5-8c62-1e55c907fb22, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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:01,403 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8b7318a9-90aa-4be5-8c62-1e55c907fb22, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:02,067 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:02,068 - 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:02,068 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:02,069 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9f4d7308-1bec-4811-a845-3922b352597d, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:14:02,070 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9f4d7308-1bec-4811-a845-3922b352597d, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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:02,084 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9f4d7308-1bec-4811-a845-3922b352597d, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:03,125 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:03,125 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:03,126 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 23d5cf8f-d3d8-4d38-bbeb-b87ccf4bd5b4, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:14:03,128 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 23d5cf8f-d3d8-4d38-bbeb-b87ccf4bd5b4, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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:03,129 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 23d5cf8f-d3d8-4d38-bbeb-b87ccf4bd5b4, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:03,500 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:03,501 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:03,501 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 31851ccb-9dae-4644-b963-9544f2147c1d, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:14:03,502 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 31851ccb-9dae-4644-b963-9544f2147c1d, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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,503 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 31851ccb-9dae-4644-b963-9544f2147c1d, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:04,291 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:04,292 - 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,293 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:04,293 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e2848bd0-cc56-48f4-952a-f27ef87ac9a9, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:14:04,295 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e2848bd0-cc56-48f4-952a-f27ef87ac9a9, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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,296 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e2848bd0-cc56-48f4-952a-f27ef87ac9a9, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:05,414 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:05,415 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:05,416 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4ddabb73-44ce-4219-ba0c-14ca01ea10f7, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:14:05,417 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4ddabb73-44ce-4219-ba0c-14ca01ea10f7, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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,420 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4ddabb73-44ce-4219-ba0c-14ca01ea10f7, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:05,865 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:05,870 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:05,871 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 479da239-8e60-499f-9261-74d6996e9345, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:14:05,872 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 479da239-8e60-499f-9261-74d6996e9345, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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,885 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 479da239-8e60-499f-9261-74d6996e9345, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:07,134 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:07,135 - 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:07,136 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:07,136 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, efe20285-2199-488b-915a-ae2cf7f4f446, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:14:07,137 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, efe20285-2199-488b-915a-ae2cf7f4f446, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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:07,148 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, efe20285-2199-488b-915a-ae2cf7f4f446, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:08,261 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:08,262 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:08,263 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5f69f5c5-281c-41dc-83d3-ba2aa56c64f1, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:14:08,263 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5f69f5c5-281c-41dc-83d3-ba2aa56c64f1, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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:08,265 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5f69f5c5-281c-41dc-83d3-ba2aa56c64f1, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:08,585 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:08,586 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:08,587 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 495ba3c1-4e74-42e7-b317-62d01526f861, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:14:08,588 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 495ba3c1-4e74-42e7-b317-62d01526f861, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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,589 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 495ba3c1-4e74-42e7-b317-62d01526f861, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:09,419 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:09,420 - 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:09,420 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:09,421 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2cdc9e1a-4e25-48ba-9554-a7a10631a39b, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:14:09,422 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2cdc9e1a-4e25-48ba-9554-a7a10631a39b, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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:09,424 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2cdc9e1a-4e25-48ba-9554-a7a10631a39b, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:10,740 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:10,741 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:10,741 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a328f433-5cad-49ae-bff3-27f7a2b198b0, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:14:10,742 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a328f433-5cad-49ae-bff3-27f7a2b198b0, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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,744 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a328f433-5cad-49ae-bff3-27f7a2b198b0, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:11,127 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:11,128 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:11,129 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, dc42183e-1216-4b45-9fe9-50bc85d39292, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:14:11,130 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, dc42183e-1216-4b45-9fe9-50bc85d39292, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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:11,134 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, dc42183e-1216-4b45-9fe9-50bc85d39292, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:11,940 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:11,941 - 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,941 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:11,942 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, dbc1b4a8-6816-4fdf-9aa1-d44926a68a75, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:14:11,944 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, dbc1b4a8-6816-4fdf-9aa1-d44926a68a75, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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,945 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, dbc1b4a8-6816-4fdf-9aa1-d44926a68a75, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:13,389 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:13,390 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:13,393 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9b458ff2-a3ee-4b2b-aec9-bfb8951a002c, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:14:13,399 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9b458ff2-a3ee-4b2b-aec9-bfb8951a002c, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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,407 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9b458ff2-a3ee-4b2b-aec9-bfb8951a002c, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:13,828 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:13,829 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:13,830 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 56b513de-7e9e-4876-88e3-286cfa0d8672, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:14:13,831 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 56b513de-7e9e-4876-88e3-286cfa0d8672, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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,834 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 56b513de-7e9e-4876-88e3-286cfa0d8672, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:14,207 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:14,208 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:14,208 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 91d1f2f3-83f7-46c9-b7f1-f3b2ff28f49f, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:14:14,209 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 91d1f2f3-83f7-46c9-b7f1-f3b2ff28f49f, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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,211 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 91d1f2f3-83f7-46c9-b7f1-f3b2ff28f49f, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:19,002 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:29,071 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:29,072 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 60730cd1-e617-4da3-ba48-31806b1e4020, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:14:29,073 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 60730cd1-e617-4da3-ba48-31806b1e4020, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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:29,074 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 60730cd1-e617-4da3-ba48-31806b1e4020, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:32,704 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:32,761 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-11-06 10:14:32,762 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:32,763 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6c0a32c5-30b1-4c26-a7f8-b458bb5d2a91, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:14:32,764 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6c0a32c5-30b1-4c26-a7f8-b458bb5d2a91, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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,765 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6c0a32c5-30b1-4c26-a7f8-b458bb5d2a91, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:36,621 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:46,675 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:46,676 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a6459a00-534c-4ba6-8476-07c0a2b98d68, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:14:46,677 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a6459a00-534c-4ba6-8476-07c0a2b98d68, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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:46,679 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a6459a00-534c-4ba6-8476-07c0a2b98d68, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:14:50,952 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:14:55,403 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-06 10:14:55,403 - 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:14:55,415 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-06 10:14:55,415 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, aa428a4f-7deb-4562-b263-57b735f50e7c, localhost:13552): creating call state
2025-11-06 10:14:55,416 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, aa428a4f-7deb-4562-b263-57b735f50e7c, localhost:13552): request = { database: "/Root" }
2025-11-06 10:14:55,426 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, aa428a4f-7deb-4562-b263-57b735f50e7c, localhost:13552): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-ew6xquenpy.auto.internal" port: 13552 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:14:55,427 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-ew6xquenpy.auto.internal:13552, location 1, ssl: False>]>
2025-11-06 10:14:55,428 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:13552
2025-11-06 10:15:01,018 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:01,019 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 400d85a8-1312-42c3-b263-1efa3b0d4e8c, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:01,020 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 400d85a8-1312-42c3-b263-1efa3b0d4e8c, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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:01,021 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 400d85a8-1312-42c3-b263-1efa3b0d4e8c, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:01,909 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:11,915 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:11,916 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4bba7cdb-ba5c-48ee-8ac5-b3084a38b50c, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:11,917 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4bba7cdb-ba5c-48ee-8ac5-b3084a38b50c, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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,918 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4bba7cdb-ba5c-48ee-8ac5-b3084a38b50c, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:12,776 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:12,781 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8009216)
2025-11-06 10:15:12,781 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:12,787 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d9fed118-be19-4d70-aebd-f2ca4f832022, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:12,788 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d9fed118-be19-4d70-aebd-f2ca4f832022, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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:12,789 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d9fed118-be19-4d70-aebd-f2ca4f832022, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:13,130 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:13,134 - INFO - ya.test - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_4_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 4])
2025-11-06 10:15:13,135 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:13,136 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 14cefa32-1ecc-4853-a3d6-bf34907a1396, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:13,137 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 14cefa32-1ecc-4853-a3d6-bf34907a1396, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_4_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 4)\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:13,138 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 14cefa32-1ecc-4853-a3d6-bf34907a1396, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:16,721 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:16,722 - INFO - __tests__.alter_compression - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_4_compression created
2025-11-06 10:15:16,722 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:16,723 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8a448faf-ae54-4b41-8db8-cd42368688c1, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:16,724 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8a448faf-ae54-4b41-8db8-cd42368688c1, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_4_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:16,725 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8a448faf-ae54-4b41-8db8-cd42368688c1, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:17,630 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:17,631 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:17,632 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4b9efb83-a20f-489d-8417-fce0dd5ce9d2, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:17,633 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4b9efb83-a20f-489d-8417-fce0dd5ce9d2, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:17,635 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4b9efb83-a20f-489d-8417-fce0dd5ce9d2, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:19,123 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:19,124 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:19,124 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 314d2982-525d-4a76-b64c-2b6b9b4dbf29, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:19,125 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 314d2982-525d-4a76-b64c-2b6b9b4dbf29, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:19,127 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 314d2982-525d-4a76-b64c-2b6b9b4dbf29, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:20,198 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:20,198 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:20,199 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d168451b-2f47-40a1-ace6-2c6e295570ea, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:20,203 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d168451b-2f47-40a1-ace6-2c6e295570ea, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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_4_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:20,205 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d168451b-2f47-40a1-ace6-2c6e295570ea, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:21,987 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:21,988 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318960, 'BlobCount': 128}}
2025-11-06 10:15:21,988 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:21,989 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 57d65488-0223-469d-ad84-2649c1e6d995, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:21,990 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 57d65488-0223-469d-ad84-2649c1e6d995, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:21,995 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 57d65488-0223-469d-ad84-2649c1e6d995, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:23,297 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:23,298 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:23,299 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 04faf686-c4a6-4ca2-887e-c74575e0d152, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:23,300 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 04faf686-c4a6-4ca2-887e-c74575e0d152, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:23,301 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 04faf686-c4a6-4ca2-887e-c74575e0d152, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:23,711 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:23,712 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:23,713 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7ddcce01-751e-44ca-b982-07d54b784c56, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:23,714 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7ddcce01-751e-44ca-b982-07d54b784c56, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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_4_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,715 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7ddcce01-751e-44ca-b982-07d54b784c56, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:24,133 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:24,133 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 638256, 'BlobCount': 256}}
2025-11-06 10:15:24,134 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:24,134 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5a42b820-5280-492c-b6a3-a3b8d8cf171a, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:24,135 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5a42b820-5280-492c-b6a3-a3b8d8cf171a, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:24,137 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5a42b820-5280-492c-b6a3-a3b8d8cf171a, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:25,463 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:25,464 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:25,465 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c3c6fbe9-e273-41a1-9b8e-af47a76e62a6, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:25,466 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c3c6fbe9-e273-41a1-9b8e-af47a76e62a6, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:25,468 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c3c6fbe9-e273-41a1-9b8e-af47a76e62a6, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:25,829 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:25,830 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:25,831 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 66dc9363-6a9e-47a0-9009-58b61d163c63, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:25,832 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 66dc9363-6a9e-47a0-9009-58b61d163c63, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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_4_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:25,833 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 66dc9363-6a9e-47a0-9009-58b61d163c63, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:26,391 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:26,391 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 957296, 'BlobCount': 384}}
2025-11-06 10:15:26,392 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:26,392 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 593c1f0b-23f7-4c51-882a-51ac2747fa0b, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:26,393 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 593c1f0b-23f7-4c51-882a-51ac2747fa0b, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:26,396 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 593c1f0b-23f7-4c51-882a-51ac2747fa0b, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:27,868 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:27,869 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:27,870 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b1e62f95-0a0c-4478-adb7-63e6a8910212, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:27,870 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b1e62f95-0a0c-4478-adb7-63e6a8910212, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:27,872 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b1e62f95-0a0c-4478-adb7-63e6a8910212, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:28,211 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:28,211 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:28,212 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 93c8aa99-9cc1-4a98-97af-9ce25899b8d6, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:28,213 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 93c8aa99-9cc1-4a98-97af-9ce25899b8d6, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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_4_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:28,227 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 93c8aa99-9cc1-4a98-97af-9ce25899b8d6, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:28,860 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:28,861 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1276656, 'BlobCount': 512}}
2025-11-06 10:15:28,861 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:28,862 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f8e65808-88f7-4f7c-876d-a3f5798f0fba, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:28,863 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f8e65808-88f7-4f7c-876d-a3f5798f0fba, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:28,864 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f8e65808-88f7-4f7c-876d-a3f5798f0fba, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:30,107 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:30,108 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:30,108 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 33974fa4-23ac-4739-aca0-c293e5fc5efb, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:30,109 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 33974fa4-23ac-4739-aca0-c293e5fc5efb, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:30,111 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 33974fa4-23ac-4739-aca0-c293e5fc5efb, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:30,519 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:30,520 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:30,521 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, cebf561a-9902-4f7c-b7cb-480b7980ec6c, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:30,522 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, cebf561a-9902-4f7c-b7cb-480b7980ec6c, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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_4_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,524 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, cebf561a-9902-4f7c-b7cb-480b7980ec6c, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:31,068 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:31,069 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1595616, 'BlobCount': 640}}
2025-11-06 10:15:31,069 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:31,070 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 645a5473-03ff-4504-9d2a-948fb430b306, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:31,071 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 645a5473-03ff-4504-9d2a-948fb430b306, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:31,081 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 645a5473-03ff-4504-9d2a-948fb430b306, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:32,307 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:32,308 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:32,308 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4fdb743b-177a-4dc9-96b1-4a24ea202796, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:32,309 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4fdb743b-177a-4dc9-96b1-4a24ea202796, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:32,311 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4fdb743b-177a-4dc9-96b1-4a24ea202796, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:32,607 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:32,608 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:32,608 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f8c6c23e-82d4-4597-b0e1-b86a93643037, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:32,609 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f8c6c23e-82d4-4597-b0e1-b86a93643037, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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_4_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:32,610 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f8c6c23e-82d4-4597-b0e1-b86a93643037, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:33,200 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:33,201 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1914800, 'BlobCount': 768}}
2025-11-06 10:15:33,201 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:33,202 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 33a13e8c-5b95-45b1-90d3-b32a45a36a58, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:33,203 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 33a13e8c-5b95-45b1-90d3-b32a45a36a58, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:33,205 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 33a13e8c-5b95-45b1-90d3-b32a45a36a58, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:34,522 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:34,523 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:34,523 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 97c6a3df-72c2-42a8-b56c-24b2eac36099, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:34,524 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 97c6a3df-72c2-42a8-b56c-24b2eac36099, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:34,526 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 97c6a3df-72c2-42a8-b56c-24b2eac36099, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:34,880 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:34,880 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:34,881 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b4968986-b61e-423d-aae4-18f6073e7326, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:34,882 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b4968986-b61e-423d-aae4-18f6073e7326, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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_4_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:34,884 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b4968986-b61e-423d-aae4-18f6073e7326, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:35,429 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:35,429 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2233936, 'BlobCount': 896}}
2025-11-06 10:15:35,430 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:35,430 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 72016233-07a7-4bb8-b655-323d5c3482f2, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:35,431 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 72016233-07a7-4bb8-b655-323d5c3482f2, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:35,433 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 72016233-07a7-4bb8-b655-323d5c3482f2, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:36,639 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:36,639 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:36,640 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 896fbd00-0a75-4ff3-84e4-51e4508d6eae, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:36,641 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 896fbd00-0a75-4ff3-84e4-51e4508d6eae, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:36,647 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 896fbd00-0a75-4ff3-84e4-51e4508d6eae, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:36,957 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:36,958 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:36,958 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0e408a73-0dc2-4b0d-86f9-f31928f9319d, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:36,959 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0e408a73-0dc2-4b0d-86f9-f31928f9319d, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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_4_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,961 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0e408a73-0dc2-4b0d-86f9-f31928f9319d, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:37,587 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:37,588 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2553424, 'BlobCount': 1024}}
2025-11-06 10:15:37,589 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:37,589 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, faa41b39-b2d1-42b4-bdcc-ac07a1005825, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:37,590 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, faa41b39-b2d1-42b4-bdcc-ac07a1005825, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:37,592 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, faa41b39-b2d1-42b4-bdcc-ac07a1005825, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:38,841 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:38,842 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:38,843 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7b835b2c-6477-4029-b275-4b51451d909e, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:38,844 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7b835b2c-6477-4029-b275-4b51451d909e, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:38,847 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7b835b2c-6477-4029-b275-4b51451d909e, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:39,156 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:39,156 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:39,157 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 99b89ab1-7a07-48b1-bd58-573992cc21c8, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:39,158 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 99b89ab1-7a07-48b1-bd58-573992cc21c8, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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_4_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:39,161 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 99b89ab1-7a07-48b1-bd58-573992cc21c8, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:40,011 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:40,012 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2872432, 'BlobCount': 1152}}
2025-11-06 10:15:40,012 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:40,013 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b6976f1d-cedf-4890-aab8-261d074b48a6, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:40,014 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b6976f1d-cedf-4890-aab8-261d074b48a6, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:40,015 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b6976f1d-cedf-4890-aab8-261d074b48a6, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:41,280 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:41,281 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:41,281 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 91821f87-37a0-4b1b-8f1a-d72b6e92ce82, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:41,282 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 91821f87-37a0-4b1b-8f1a-d72b6e92ce82, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:41,284 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 91821f87-37a0-4b1b-8f1a-d72b6e92ce82, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:41,650 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:41,651 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:41,651 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b2361cda-903e-4d0b-adfa-1a65cbd86901, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:41,652 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b2361cda-903e-4d0b-adfa-1a65cbd86901, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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_4_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,654 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b2361cda-903e-4d0b-adfa-1a65cbd86901, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:42,532 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:42,533 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3191936, 'BlobCount': 1280}}
2025-11-06 10:15:42,533 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:42,534 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2eb4f50f-e8bd-44e1-8889-562d3f524a44, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:42,535 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2eb4f50f-e8bd-44e1-8889-562d3f524a44, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_4_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:42,536 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2eb4f50f-e8bd-44e1-8889-562d3f524a44, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:43,685 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:43,686 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:43,687 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8939f498-251b-486a-8ec5-55e9aac9a12a, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:43,688 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8939f498-251b-486a-8ec5-55e9aac9a12a, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:43,689 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8939f498-251b-486a-8ec5-55e9aac9a12a, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:44,010 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:44,011 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:44,012 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b71bf473-c469-48b3-9038-df31e8b6052a, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:44,013 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b71bf473-c469-48b3-9038-df31e8b6052a, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:44,016 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b71bf473-c469-48b3-9038-df31e8b6052a, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:44,428 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:44,429 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:44,429 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d30de79b-2db8-4047-8fca-c07efdded450, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:44,430 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d30de79b-2db8-4047-8fca-c07efdded450, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:44,432 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d30de79b-2db8-4047-8fca-c07efdded450, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:15:48,964 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:59,036 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:15:59,037 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8e234fb1-332a-4fec-ac2e-48cbfa0df929, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:15:59,038 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8e234fb1-332a-4fec-ac2e-48cbfa0df929, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:15:59,040 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8e234fb1-332a-4fec-ac2e-48cbfa0df929, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:16:03,037 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:16:03,106 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_4_compression`, volumes `value` (8000000, 1595968)
2025-11-06 10:16:03,107 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:16:03,108 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, fbacc858-72e2-4489-aff7-fe9b6b7666f1, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:16:03,109 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, fbacc858-72e2-4489-aff7-fe9b6b7666f1, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:16:03,110 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, fbacc858-72e2-4489-aff7-fe9b6b7666f1, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:16:03,511 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:16:03,511 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:16:03,512 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5e375d0c-12e8-458d-99d4-96a0591bf70e, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:16:03,512 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5e375d0c-12e8-458d-99d4-96a0591bf70e, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:16:03,513 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5e375d0c-12e8-458d-99d4-96a0591bf70e, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:16:07,760 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:16:17,803 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:16:17,804 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9a2ebead-f20e-4498-916a-079bf491d55e, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:16:17,805 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9a2ebead-f20e-4498-916a-079bf491d55e, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:16:17,806 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9a2ebead-f20e-4498-916a-079bf491d55e, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:16:20,343 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:16:30,363 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:16:30,364 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c9476b88-75e0-46c7-9756-3b65fdd65dd0, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:16:30,364 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c9476b88-75e0-46c7-9756-3b65fdd65dd0, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:16:30,366 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c9476b88-75e0-46c7-9756-3b65fdd65dd0, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:16:31,063 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:16:34,470 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-06 10:16:34,471 - 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:34,507 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-06 10:16:34,508 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 1aa107fa-834f-4d2e-b29a-12a03b3d0da2, localhost:13552): creating call state
2025-11-06 10:16:34,509 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 1aa107fa-834f-4d2e-b29a-12a03b3d0da2, localhost:13552): request = { database: "/Root" }
2025-11-06 10:16:34,518 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 1aa107fa-834f-4d2e-b29a-12a03b3d0da2, localhost:13552): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-ew6xquenpy.auto.internal" port: 13552 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:34,519 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-ew6xquenpy.auto.internal:13552, location 1, ssl: False>]>
2025-11-06 10:16:34,520 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:13552
2025-11-06 10:16:41,071 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:16:41,072 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7c4dc6b1-6d16-4ae1-8792-f53097588277, ghrun-ew6xquenpy.auto.internal:13552): creating call state
2025-11-06 10:16:41,072 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7c4dc6b1-6d16-4ae1-8792-f53097588277, ghrun-ew6xquenpy.auto.internal:13552): request = { session_id: "ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-06 10:16:41,074 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7c4dc6b1-6d16-4ae1-8792-f53097588277, ghrun-ew6xquenpy.auto.internal:13552): response = { <_MultiThreadedRendezvous object> }
2025-11-06 10:16:42,279 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGI1NmIzMDItYzkxNzVkMmUtNTQzOTdlZTgtOGYyNWZjYWU=
2025-11-06 10:16:42,283 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_4_compression`, volumes `value` (8000000, 1466456)
2025-11-06 10:16:42,283 - INFO - root - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_4_compression` 8092160 / 1466456: 5.518174428690666
2025-11-06 10:16:42,286 - INFO - ya.test - pytest_runtest_teardown: Test teardown
