2025-11-11 13:21:00,596 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-11 13:21:00,596 - INFO - ya.test - pytest_runtest_setup: test
2025-11-11 13:21:00,597 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-11 13:21:00,597 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-11 13:21:00,653 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/bhk2/004b67/ydb/apps/ydbd/ydbd
2025-11-11 13:21:00,654 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/16206
2025-11-11 13:21:00,656 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/bhk2/004b67/r3tmp/kikimr_cluster_f3trx1db
2025-11-11 13:21:00,698 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/bhk2/004b67/ydb/apps/ydbd/ydbd
2025-11-11 13:21:00,698 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/3087
2025-11-11 13:21:00,699 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/18533
2025-11-11 13:21:00,699 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/24075
2025-11-11 13:21:00,700 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/1698
2025-11-11 13:21:00,702 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/bhk2/004b67/ydb/tests/olap/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/zip_bomb.py.TestZipBomb.test/cluster/kikimr_configs"
2025-11-11 13:21:00,702 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/bhk2/004b67/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/bhk2/004b67/ydb/tests/olap/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/zip_bomb.py.TestZipBomb.test/cluster/node_1/logfile_c7u7xtfp.log --grpc-port=3087 --mon-port=18533 --ic-port=16206
2025-11-11 13:21:00,703 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:0 on node localhost:3087/1, disk_size 10485760
2025-11-11 13:21:00,703 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/bhk2/004b67/ydb/tests/olap/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/zip_bomb.py.TestZipBomb.test/cluster/kikimr_configs"
2025-11-11 13:21:00,703 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/bhk2/004b67/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/bhk2/004b67/ydb/tests/olap/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/zip_bomb.py.TestZipBomb.test/cluster/node_1/logfile_c7u7xtfp.log --grpc-port=3087 --mon-port=18533 --ic-port=16206
2025-11-11 13:21:00,705 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/bhk2/004b67/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/bhk2/004b67/ydb/tests/olap/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/zip_bomb.py.TestZipBomb.test/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/bhk2/004b67/ydb/tests/olap/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/zip_bomb.py.TestZipBomb.test/cluster/node_1/logfile_c7u7xtfp.log', '--grpc-port=3087', '--mon-port=18533', '--ic-port=16206')' in '/home/runner/.ya/build/build_root/bhk2/004b67/ydb/tests/olap/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/zip_bomb.py.TestZipBomb.test/cluster/node_1' (no wait)
2025-11-11 13:21:00,706 - DEBUG - ya.test - execute: Command pid: 3340228
2025-11-11 13:21:00,707 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:3087/1
2025-11-11 13:21:00,709 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.90
2025-11-11 13:21:00,711 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.90
2025-11-11 13:21:00,711 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/bhk2/004b67/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-11 13:21:00,712 - DEBUG - ya.test - execute: Command pid: 3340229
2025-11-11 13:21:01,183 - DEBUG - ya.test - _save_outputs: Command (pid 3340229) rc: 0
2025-11-11 13:21:01,183 - DEBUG - ya.test - _save_outputs: Command (pid 3340229) elapsed time (sec): 0.4695613384246826
2025-11-11 13:21:01,183 - DEBUG - ya.test - _save_outputs: Command (pid 3340229) idrss: 0
2025-11-11 13:21:01,183 - DEBUG - ya.test - _save_outputs: Command (pid 3340229) inblock: 0
2025-11-11 13:21:01,184 - DEBUG - ya.test - _save_outputs: Command (pid 3340229) isrss: 0
2025-11-11 13:21:01,185 - DEBUG - ya.test - _save_outputs: Command (pid 3340229) ixrss: 0
2025-11-11 13:21:01,185 - DEBUG - ya.test - _save_outputs: Command (pid 3340229) majflt: 0
2025-11-11 13:21:01,185 - DEBUG - ya.test - _save_outputs: Command (pid 3340229) maxrss: 541148
2025-11-11 13:21:01,185 - DEBUG - ya.test - _save_outputs: Command (pid 3340229) minflt: 16167
2025-11-11 13:21:01,185 - DEBUG - ya.test - _save_outputs: Command (pid 3340229) msgrcv: 0
2025-11-11 13:21:01,186 - DEBUG - ya.test - _save_outputs: Command (pid 3340229) msgsnd: 0
2025-11-11 13:21:01,186 - DEBUG - ya.test - _save_outputs: Command (pid 3340229) nivcsw: 30
2025-11-11 13:21:01,187 - DEBUG - ya.test - _save_outputs: Command (pid 3340229) nsignals: 0
2025-11-11 13:21:01,187 - DEBUG - ya.test - _save_outputs: Command (pid 3340229) nswap: 0
2025-11-11 13:21:01,187 - DEBUG - ya.test - _save_outputs: Command (pid 3340229) nvcsw: 19
2025-11-11 13:21:01,187 - DEBUG - ya.test - _save_outputs: Command (pid 3340229) oublock: 8
2025-11-11 13:21:01,187 - DEBUG - ya.test - _save_outputs: Command (pid 3340229) stime: 0.30578099999999997
2025-11-11 13:21:01,188 - DEBUG - ya.test - _save_outputs: Command (pid 3340229) utime: 0.11265599999999999
2025-11-11 13:21:01,188 - DEBUG - ya.test - _save_outputs: Command (pid 3340229) wtime: 0.471
2025-11-11 13:21:01,188 - DEBUG - ya.test - _save_outputs: Command (pid 3340229) output:
Git info:
    Commit: b1fe97d9d8127d8f2b1d0c3f6dfd6bba81272e1b
    Branch: 
    Author: Nikolay Shestakov <n.shestakov@gmail.com>
    Summary: Merge 50d8af9ebc780945b43536873ee711ed2559af4b into c6a8dfb1a22b05b4afbbf1cd50c1ca5a0dcd4305

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-3ynj4chmly
    Host information: 
        Linux ghrun-3ynj4chmly 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/10226725676/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/10226725676/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 -UNDEBUG -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 -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -UNDEBUG -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-11 13:21:01,188 - DEBUG - ya.test - _save_outputs: Command (pid 3340229) errors:

2025-11-11 13:21:01,188 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: b1fe97d9d8127d8f2b1d0c3f6dfd6bba81272e1b
    Branch: 
    Author: Nikolay Shestakov <n.shestakov@gmail.com>
    Summary: Merge 50d8af9ebc780945b43536873ee711ed2559af4b into c6a8dfb1a22b05b4afbbf1cd50c1ca5a0dcd4305
2025-11-11 13:21:02,882 - WARNING - ydb.topic - __del__: Topic client was not closed properly. Consider using method close().
2025-11-11 13:21:02,884 - DEBUG - ydb.topic - close: Close topic client
2025-11-11 13:21:02,884 - DEBUG - ydb.topic - close: Topic client was closed
2025-11-11 13:21:02,884 - WARNING - ydb.topic - __del__: Topic client was not closed properly. Consider using method close().
2025-11-11 13:21:02,885 - DEBUG - ydb.topic - close: Close topic client
2025-11-11 13:21:02,887 - DEBUG - ydb.topic - close: Topic client was closed
2025-11-11 13:21:02,887 - WARNING - ydb.topic - __del__: Topic client was not closed properly. Consider using method close().
2025-11-11 13:21:02,888 - DEBUG - ydb.topic - close: Close topic client
2025-11-11 13:21:02,888 - DEBUG - ydb.topic - close: Topic client was closed
2025-11-11 13:21:02,888 - WARNING - ydb.topic - __del__: Topic client was not closed properly. Consider using method close().
2025-11-11 13:21:02,888 - DEBUG - ydb.topic - close: Close topic client
2025-11-11 13:21:02,888 - DEBUG - ydb.topic - close: Topic client was closed
2025-11-11 13:21:02,889 - WARNING - ydb.topic - __del__: Topic client was not closed properly. Consider using method close().
2025-11-11 13:21:02,889 - DEBUG - ydb.topic - close: Close topic client
2025-11-11 13:21:02,890 - DEBUG - ydb.topic - close: Topic client was closed
2025-11-11 13:21:02,890 - WARNING - ydb.topic - __del__: Topic client was not closed properly. Consider using method close().
2025-11-11 13:21:02,890 - DEBUG - ydb.topic - close: Close topic client
2025-11-11 13:21:02,891 - DEBUG - ydb.topic - close: Topic client was closed
2025-11-11 13:21:02,892 - WARNING - ydb.topic - __del__: Topic client was not closed properly. Consider using method close().
2025-11-11 13:21:02,892 - DEBUG - ydb.topic - close: Close topic client
2025-11-11 13:21:02,892 - DEBUG - ydb.topic - close: Topic client was closed
2025-11-11 13:21:02,893 - WARNING - ydb.topic - __del__: Topic client was not closed properly. Consider using method close().
2025-11-11 13:21:02,893 - DEBUG - ydb.topic - close: Close topic client
2025-11-11 13:21:02,893 - DEBUG - ydb.topic - close: Topic client was closed
2025-11-11 13:21:03,077 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/bhk2/004b67/ydb/apps/ydbd/ydbd
2025-11-11 13:21:03,078 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/bhk2/004b67/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:3087', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineHostConfig {\n    HostConfigId: 1\n    Drive {\n      Path: "SectorMap:1:0"\n    }\n  }\n}\nCommand {\n  DefineBox {\n    BoxId: 1\n    Host {\n      Key {\n        Fqdn: "localhost"\n        IcPort: 16206\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-11 13:21:03,080 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.91
2025-11-11 13:21:03,081 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.91
2025-11-11 13:21:03,081 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/bhk2/004b67/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:3087', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineHostConfig {\n    HostConfigId: 1\n    Drive {\n      Path: "SectorMap:1:0"\n    }\n  }\n}\nCommand {\n  DefineBox {\n    BoxId: 1\n    Host {\n      Key {\n        Fqdn: "localhost"\n        IcPort: 16206\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-11 13:21:03,082 - DEBUG - ya.test - execute: Command pid: 3341684
2025-11-11 13:21:03,181 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-3ynj4chmly.auto.internal:23944
2025-11-11 13:21:03,303 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:15690
2025-11-11 13:21:03,523 - DEBUG - ya.test - _save_outputs: Command (pid 3341684) rc: 0
2025-11-11 13:21:03,524 - DEBUG - ya.test - _save_outputs: Command (pid 3341684) elapsed time (sec): 0.44052982330322266
2025-11-11 13:21:03,524 - DEBUG - ya.test - _save_outputs: Command (pid 3341684) idrss: 0
2025-11-11 13:21:03,524 - DEBUG - ya.test - _save_outputs: Command (pid 3341684) inblock: 0
2025-11-11 13:21:03,524 - DEBUG - ya.test - _save_outputs: Command (pid 3341684) isrss: 0
2025-11-11 13:21:03,524 - DEBUG - ya.test - _save_outputs: Command (pid 3341684) ixrss: 0
2025-11-11 13:21:03,524 - DEBUG - ya.test - _save_outputs: Command (pid 3341684) majflt: 0
2025-11-11 13:21:03,525 - DEBUG - ya.test - _save_outputs: Command (pid 3341684) maxrss: 549384
2025-11-11 13:21:03,525 - DEBUG - ya.test - _save_outputs: Command (pid 3341684) minflt: 18309
2025-11-11 13:21:03,525 - DEBUG - ya.test - _save_outputs: Command (pid 3341684) msgrcv: 0
2025-11-11 13:21:03,525 - DEBUG - ya.test - _save_outputs: Command (pid 3341684) msgsnd: 0
2025-11-11 13:21:03,525 - DEBUG - ya.test - _save_outputs: Command (pid 3341684) nivcsw: 2
2025-11-11 13:21:03,525 - DEBUG - ya.test - _save_outputs: Command (pid 3341684) nsignals: 0
2025-11-11 13:21:03,526 - DEBUG - ya.test - _save_outputs: Command (pid 3341684) nswap: 0
2025-11-11 13:21:03,526 - DEBUG - ya.test - _save_outputs: Command (pid 3341684) nvcsw: 143
2025-11-11 13:21:03,526 - DEBUG - ya.test - _save_outputs: Command (pid 3341684) oublock: 8
2025-11-11 13:21:03,526 - DEBUG - ya.test - _save_outputs: Command (pid 3341684) stime: 0.26483999999999996
2025-11-11 13:21:03,526 - DEBUG - ya.test - _save_outputs: Command (pid 3341684) utime: 0.13241999999999998
2025-11-11 13:21:03,526 - DEBUG - ya.test - _save_outputs: Command (pid 3341684) wtime: 0.442
2025-11-11 13:21:03,527 - DEBUG - ya.test - _save_outputs: Command (pid 3341684) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 4

2025-11-11 13:21:03,527 - DEBUG - ya.test - _save_outputs: Command (pid 3341684) errors:

2025-11-11 13:21:03,528 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/bhk2/004b67/ydb/apps/ydbd/ydbd
2025-11-11 13:21:03,528 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/bhk2/004b67/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:3087', '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-11 13:21:03,530 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.92
2025-11-11 13:21:03,533 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.92
2025-11-11 13:21:03,534 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/bhk2/004b67/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:3087', '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-11 13:21:03,535 - DEBUG - ya.test - execute: Command pid: 3341903
2025-11-11 13:21:04,045 - DEBUG - ya.test - _save_outputs: Command (pid 3341903) rc: 0
2025-11-11 13:21:04,045 - DEBUG - ya.test - _save_outputs: Command (pid 3341903) elapsed time (sec): 0.5088739395141602
2025-11-11 13:21:04,046 - DEBUG - ya.test - _save_outputs: Command (pid 3341903) idrss: 0
2025-11-11 13:21:04,046 - DEBUG - ya.test - _save_outputs: Command (pid 3341903) inblock: 0
2025-11-11 13:21:04,046 - DEBUG - ya.test - _save_outputs: Command (pid 3341903) isrss: 0
2025-11-11 13:21:04,046 - DEBUG - ya.test - _save_outputs: Command (pid 3341903) ixrss: 0
2025-11-11 13:21:04,046 - DEBUG - ya.test - _save_outputs: Command (pid 3341903) majflt: 0
2025-11-11 13:21:04,046 - DEBUG - ya.test - _save_outputs: Command (pid 3341903) maxrss: 549388
2025-11-11 13:21:04,046 - DEBUG - ya.test - _save_outputs: Command (pid 3341903) minflt: 18311
2025-11-11 13:21:04,047 - DEBUG - ya.test - _save_outputs: Command (pid 3341903) msgrcv: 0
2025-11-11 13:21:04,047 - DEBUG - ya.test - _save_outputs: Command (pid 3341903) msgsnd: 0
2025-11-11 13:21:04,047 - DEBUG - ya.test - _save_outputs: Command (pid 3341903) nivcsw: 3
2025-11-11 13:21:04,048 - DEBUG - ya.test - _save_outputs: Command (pid 3341903) nsignals: 0
2025-11-11 13:21:04,048 - DEBUG - ya.test - _save_outputs: Command (pid 3341903) nswap: 0
2025-11-11 13:21:04,048 - DEBUG - ya.test - _save_outputs: Command (pid 3341903) nvcsw: 138
2025-11-11 13:21:04,048 - DEBUG - ya.test - _save_outputs: Command (pid 3341903) oublock: 8
2025-11-11 13:21:04,049 - DEBUG - ya.test - _save_outputs: Command (pid 3341903) stime: 0.362421
2025-11-11 13:21:04,049 - DEBUG - ya.test - _save_outputs: Command (pid 3341903) utime: 0.100685
2025-11-11 13:21:04,049 - DEBUG - ya.test - _save_outputs: Command (pid 3341903) wtime: 0.51
2025-11-11 13:21:04,049 - DEBUG - ya.test - _save_outputs: Command (pid 3341903) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-11 13:21:04,049 - DEBUG - ya.test - _save_outputs: Command (pid 3341903) errors:

2025-11-11 13:21:04,050 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-11 13:21:04,060 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-11-11 13:21:04,070 - INFO - ya.test - pytest_runtest_call: Test call (class_name: zip_bomb.py::TestZipBomb, test_name: test)
2025-11-11 13:21:04,072 - 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-11 13:21:04,074 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-11 13:21:04,074 - 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-11 13:21:04,078 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-11 13:21:04,079 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 20ddebe5-d1aa-44f2-8489-99d800efd530, localhost:3087): creating call state
2025-11-11 13:21:04,080 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 20ddebe5-d1aa-44f2-8489-99d800efd530, localhost:3087): request = { database: "/Root" }
2025-11-11 13:21:04,083 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 20ddebe5-d1aa-44f2-8489-99d800efd530, localhost:3087): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-3ynj4chmly.auto.internal" port: 3087 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-11 13:21:04,083 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-3ynj4chmly.auto.internal:3087, location 1, ssl: False>]>
2025-11-11 13:21:04,084 - 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-11 13:21:04,091 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:3087
2025-11-11 13:21:04,092 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-11 13:21:04,093 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, b6a1c0d5-345a-47e2-8d5a-42409a124415, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:04,093 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, b6a1c0d5-345a-47e2-8d5a-42409a124415, ghrun-3ynj4chmly.auto.internal:3087): request = {  }
2025-11-11 13:21:04,095 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, b6a1c0d5-345a-47e2-8d5a-42409a124415, ghrun-3ynj4chmly.auto.internal:3087): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=Y2FjM2ZhNGItZDU2NWM4ZjEtMTVkYjFkYjktOWQzZjYwYmI=" node_id: 1 }
2025-11-11 13:21:04,096 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, 06f30b6b-aa19-44f8-bfa2-dac32bf06a82, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:04,096 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, 06f30b6b-aa19-44f8-bfa2-dac32bf06a82, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=Y2FjM2ZhNGItZDU2NWM4ZjEtMTVkYjFkYjktOWQzZjYwYmI=" }
2025-11-11 13:21:04,098 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, 06f30b6b-aa19-44f8-bfa2-dac32bf06a82, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:04,099 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=Y2FjM2ZhNGItZDU2NWM4ZjEtMTVkYjFkYjktOWQzZjYwYmI=
2025-11-11 13:21:04,100 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 42116a1c-e1e6-4569-9370-f50c7d6d1811, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:04,100 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 42116a1c-e1e6-4569-9370-f50c7d6d1811, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=Y2FjM2ZhNGItZDU2NWM4ZjEtMTVkYjFkYjktOWQzZjYwYmI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `huge` (\n                    k Int32 NOT NULL,\n                    v1 String,\n                    v2 String,\n                    v3 String,\n                    v4 String,\n                    v5 String,\n                    PRIMARY KEY (k)\n                ) WITH (STORE = COLUMN, AUTO_PARTITIONING_MIN_PARTITIONS_COUNT=1)\n            " } stats_mode: STATS_MODE_NONE }
2025-11-11 13:21:04,101 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 42116a1c-e1e6-4569-9370-f50c7d6d1811, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:04,139 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2FjM2ZhNGItZDU2NWM4ZjEtMTVkYjFkYjktOWQzZjYwYmI=
2025-11-11 13:21:04,139 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2FjM2ZhNGItZDU2NWM4ZjEtMTVkYjFkYjktOWQzZjYwYmI=
2025-11-11 13:21:04,140 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6f962ce7-d766-4bc2-9d0d-f8c29567e472, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:04,143 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6f962ce7-d766-4bc2-9d0d-f8c29567e472, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=Y2FjM2ZhNGItZDU2NWM4ZjEtMTVkYjFkYjktOWQzZjYwYmI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $n = 100000;\n                $values_list = ListReplicate(42ul, $n);\n                $value = \'xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx\';\n                $rows_list = ListFoldMap($values_list, 0, ($val, $i)->((<|k:$i, v1:$value||\'1\', v2:$value||\'2\', v3:$value||\'3\', v4:$value||\'4\', v5:$value||\'5\'|>, $i + 1)));\n\n                UPSERT INTO `huge`\n                SELECT * FROM AS_TABLE($rows_list);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-11 13:21:04,144 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6f962ce7-d766-4bc2-9d0d-f8c29567e472, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:04,328 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-3ynj4chmly.auto.internal:18758
2025-11-11 13:21:04,525 - 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-11 13:21:08,528 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-3ynj4chmly.auto.internal:11231
2025-11-11 13:21:08,578 - 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-11 13:21:08,835 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2FjM2ZhNGItZDU2NWM4ZjEtMTVkYjFkYjktOWQzZjYwYmI=
2025-11-11 13:21:08,836 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2FjM2ZhNGItZDU2NWM4ZjEtMTVkYjFkYjktOWQzZjYwYmI=
2025-11-11 13:21:08,836 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 45b7521d-c290-45e6-96b9-8b155ca9908d, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:08,839 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 45b7521d-c290-45e6-96b9-8b155ca9908d, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=Y2FjM2ZhNGItZDU2NWM4ZjEtMTVkYjFkYjktOWQzZjYwYmI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $n = 100000;\n                $values_list = ListReplicate(42ul, $n);\n                $value = \'xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx\';\n                $rows_list = ListFoldMap($values_list, 100000, ($val, $i)->((<|k:$i, v1:$value||\'1\', v2:$value||\'2\', v3:$value||\'3\', v4:$value||\'4\', v5:$value||\'5\'|>, $i + 1)));\n\n                UPSERT INTO `huge`\n                SELECT * FROM AS_TABLE($rows_list);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-11 13:21:08,841 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 45b7521d-c290-45e6-96b9-8b155ca9908d, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:09,252 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-11 13:21:09,252 - 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-11 13:21:10,201 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-11 13:21:10,201 - 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-11 13:21:12,581 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-3ynj4chmly.auto.internal:23944
2025-11-11 13:21:12,629 - 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-11 13:21:13,753 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2FjM2ZhNGItZDU2NWM4ZjEtMTVkYjFkYjktOWQzZjYwYmI=
2025-11-11 13:21:13,754 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2FjM2ZhNGItZDU2NWM4ZjEtMTVkYjFkYjktOWQzZjYwYmI=
2025-11-11 13:21:13,755 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7eb21642-c96e-47db-b46a-be698da80661, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,755 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 1 < 100, will create new one.
2025-11-11 13:21:13,756 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7eb21642-c96e-47db-b46a-be698da80661, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=Y2FjM2ZhNGItZDU2NWM4ZjEtMTVkYjFkYjktOWQzZjYwYmI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            SELECT\n                MAX(v1),\n                MAX(v2),\n                MAX(v3),\n                MAX(v4),\n                MAX(v5)\n            FROM huge\n        " } stats_mode: STATS_MODE_NONE }
2025-11-11 13:21:13,757 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, f2ac70e1-572e-4fa2-9235-97c9b02d038c, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,759 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7eb21642-c96e-47db-b46a-be698da80661, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,760 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, f2ac70e1-572e-4fa2-9235-97c9b02d038c, ghrun-3ynj4chmly.auto.internal:3087): request = {  }
2025-11-11 13:21:13,765 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, f2ac70e1-572e-4fa2-9235-97c9b02d038c, ghrun-3ynj4chmly.auto.internal:3087): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=ZjI4NTQ0ODAtNTZjMGU5Y2EtZWIxZjViNTItYzY5NjY4NTM=" node_id: 1 }
2025-11-11 13:21:13,767 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, 4bfe8925-2c27-4114-ab9c-2860041a0b68, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,767 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, 4bfe8925-2c27-4114-ab9c-2860041a0b68, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=ZjI4NTQ0ODAtNTZjMGU5Y2EtZWIxZjViNTItYzY5NjY4NTM=" }
2025-11-11 13:21:13,769 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, 4bfe8925-2c27-4114-ab9c-2860041a0b68, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,771 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=ZjI4NTQ0ODAtNTZjMGU5Y2EtZWIxZjViNTItYzY5NjY4NTM=
2025-11-11 13:21:13,772 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 168c7ed1-b66b-4754-a4ab-199359a6ca59, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,772 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 2 < 100, will create new one.
2025-11-11 13:21:13,772 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 168c7ed1-b66b-4754-a4ab-199359a6ca59, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=ZjI4NTQ0ODAtNTZjMGU5Y2EtZWIxZjViNTItYzY5NjY4NTM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            SELECT\n                MAX(v1),\n                MAX(v2),\n                MAX(v3),\n                MAX(v4),\n                MAX(v5)\n            FROM huge\n        " } stats_mode: STATS_MODE_NONE }
2025-11-11 13:21:13,773 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 07303284-7dc9-4dec-9d1d-1b0a84af798d, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,774 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 168c7ed1-b66b-4754-a4ab-199359a6ca59, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,774 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 07303284-7dc9-4dec-9d1d-1b0a84af798d, ghrun-3ynj4chmly.auto.internal:3087): request = {  }
2025-11-11 13:21:13,777 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 07303284-7dc9-4dec-9d1d-1b0a84af798d, ghrun-3ynj4chmly.auto.internal:3087): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=M2U0NTJlMzEtOWFiMzUxNGUtOTYzMGE3MGQtZjk1MDkxYTg=" node_id: 1 }
2025-11-11 13:21:13,778 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, 0ae0d450-bba2-41c2-b3f3-23d41c5b364b, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,778 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, 0ae0d450-bba2-41c2-b3f3-23d41c5b364b, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=M2U0NTJlMzEtOWFiMzUxNGUtOTYzMGE3MGQtZjk1MDkxYTg=" }
2025-11-11 13:21:13,779 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, 0ae0d450-bba2-41c2-b3f3-23d41c5b364b, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,780 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=M2U0NTJlMzEtOWFiMzUxNGUtOTYzMGE3MGQtZjk1MDkxYTg=
2025-11-11 13:21:13,781 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1bbd531d-8f77-40ff-8deb-c61da382ab3d, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,781 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 3 < 100, will create new one.
2025-11-11 13:21:13,782 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1bbd531d-8f77-40ff-8deb-c61da382ab3d, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=M2U0NTJlMzEtOWFiMzUxNGUtOTYzMGE3MGQtZjk1MDkxYTg=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            SELECT\n                MAX(v1),\n                MAX(v2),\n                MAX(v3),\n                MAX(v4),\n                MAX(v5)\n            FROM huge\n        " } stats_mode: STATS_MODE_NONE }
2025-11-11 13:21:13,782 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, ea8ce0a3-b1d6-4ac9-bd72-ad10935a87f1, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,783 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, ea8ce0a3-b1d6-4ac9-bd72-ad10935a87f1, ghrun-3ynj4chmly.auto.internal:3087): request = {  }
2025-11-11 13:21:13,783 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1bbd531d-8f77-40ff-8deb-c61da382ab3d, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,785 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, ea8ce0a3-b1d6-4ac9-bd72-ad10935a87f1, ghrun-3ynj4chmly.auto.internal:3087): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=ZWZjYjk4NWMtYTJlYzhmNjYtMjJhNDhjMzgtNTk2MWFmZjY=" node_id: 1 }
2025-11-11 13:21:13,786 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, 23430fba-6fd7-42b1-af99-17bc2afbfe4b, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,786 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, 23430fba-6fd7-42b1-af99-17bc2afbfe4b, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=ZWZjYjk4NWMtYTJlYzhmNjYtMjJhNDhjMzgtNTk2MWFmZjY=" }
2025-11-11 13:21:13,787 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, 23430fba-6fd7-42b1-af99-17bc2afbfe4b, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,788 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=ZWZjYjk4NWMtYTJlYzhmNjYtMjJhNDhjMzgtNTk2MWFmZjY=
2025-11-11 13:21:13,789 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d7191ab7-fd7a-43a5-8233-91660139bc9c, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,789 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 4 < 100, will create new one.
2025-11-11 13:21:13,789 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d7191ab7-fd7a-43a5-8233-91660139bc9c, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=ZWZjYjk4NWMtYTJlYzhmNjYtMjJhNDhjMzgtNTk2MWFmZjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            SELECT\n                MAX(v1),\n                MAX(v2),\n                MAX(v3),\n                MAX(v4),\n                MAX(v5)\n            FROM huge\n        " } stats_mode: STATS_MODE_NONE }
2025-11-11 13:21:13,790 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 4033d7f7-62b5-4925-9dcf-849c29d75a6c, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,791 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 4033d7f7-62b5-4925-9dcf-849c29d75a6c, ghrun-3ynj4chmly.auto.internal:3087): request = {  }
2025-11-11 13:21:13,791 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d7191ab7-fd7a-43a5-8233-91660139bc9c, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,793 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 4033d7f7-62b5-4925-9dcf-849c29d75a6c, ghrun-3ynj4chmly.auto.internal:3087): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=M2ZiMWZlYjAtMjc0Njc4MDQtNTBiMWJlNzMtZGMyY2Q3OTI=" node_id: 1 }
2025-11-11 13:21:13,793 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, 9760f1b7-5ac0-4c71-9eb6-b23abac9cdcc, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,794 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, 9760f1b7-5ac0-4c71-9eb6-b23abac9cdcc, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=M2ZiMWZlYjAtMjc0Njc4MDQtNTBiMWJlNzMtZGMyY2Q3OTI=" }
2025-11-11 13:21:13,794 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, 9760f1b7-5ac0-4c71-9eb6-b23abac9cdcc, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,796 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=M2ZiMWZlYjAtMjc0Njc4MDQtNTBiMWJlNzMtZGMyY2Q3OTI=
2025-11-11 13:21:13,796 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0fff0f96-0dbd-4f9c-ad20-db4d11bfcf90, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,796 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 5 < 100, will create new one.
2025-11-11 13:21:13,797 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0fff0f96-0dbd-4f9c-ad20-db4d11bfcf90, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=M2ZiMWZlYjAtMjc0Njc4MDQtNTBiMWJlNzMtZGMyY2Q3OTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            SELECT\n                MAX(v1),\n                MAX(v2),\n                MAX(v3),\n                MAX(v4),\n                MAX(v5)\n            FROM huge\n        " } stats_mode: STATS_MODE_NONE }
2025-11-11 13:21:13,798 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, f2d87b3e-b577-438f-be10-f2dfd95cf329, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,798 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, f2d87b3e-b577-438f-be10-f2dfd95cf329, ghrun-3ynj4chmly.auto.internal:3087): request = {  }
2025-11-11 13:21:13,799 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0fff0f96-0dbd-4f9c-ad20-db4d11bfcf90, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,801 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, f2d87b3e-b577-438f-be10-f2dfd95cf329, ghrun-3ynj4chmly.auto.internal:3087): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=YmFiMjdhNjYtMjljZmQ3ZmYtODZhMGYyMzYtMzI4ZDg5YWQ=" node_id: 1 }
2025-11-11 13:21:13,801 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, 20c7fdf0-3d86-452e-9147-e75b9b6079ee, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,802 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, 20c7fdf0-3d86-452e-9147-e75b9b6079ee, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=YmFiMjdhNjYtMjljZmQ3ZmYtODZhMGYyMzYtMzI4ZDg5YWQ=" }
2025-11-11 13:21:13,802 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, 20c7fdf0-3d86-452e-9147-e75b9b6079ee, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,804 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=YmFiMjdhNjYtMjljZmQ3ZmYtODZhMGYyMzYtMzI4ZDg5YWQ=
2025-11-11 13:21:13,805 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6e44ec95-bb0e-439c-b759-9587cef76bfe, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,805 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 6 < 100, will create new one.
2025-11-11 13:21:13,805 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6e44ec95-bb0e-439c-b759-9587cef76bfe, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=YmFiMjdhNjYtMjljZmQ3ZmYtODZhMGYyMzYtMzI4ZDg5YWQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            SELECT\n                MAX(v1),\n                MAX(v2),\n                MAX(v3),\n                MAX(v4),\n                MAX(v5)\n            FROM huge\n        " } stats_mode: STATS_MODE_NONE }
2025-11-11 13:21:13,806 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, ff3193ff-bcfa-4c80-87b9-fe0fa7a8ead9, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,807 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, ff3193ff-bcfa-4c80-87b9-fe0fa7a8ead9, ghrun-3ynj4chmly.auto.internal:3087): request = {  }
2025-11-11 13:21:13,807 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6e44ec95-bb0e-439c-b759-9587cef76bfe, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,809 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, ff3193ff-bcfa-4c80-87b9-fe0fa7a8ead9, ghrun-3ynj4chmly.auto.internal:3087): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=OGE1YmRhYmQtNjRlZGEzMjktMjllMWQxNjItNDcyZGE0Mzk=" node_id: 1 }
2025-11-11 13:21:13,811 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, d9d53b8b-1479-437f-838a-d32191ec4f9f, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,811 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, d9d53b8b-1479-437f-838a-d32191ec4f9f, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=OGE1YmRhYmQtNjRlZGEzMjktMjllMWQxNjItNDcyZGE0Mzk=" }
2025-11-11 13:21:13,812 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, d9d53b8b-1479-437f-838a-d32191ec4f9f, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,813 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=OGE1YmRhYmQtNjRlZGEzMjktMjllMWQxNjItNDcyZGE0Mzk=
2025-11-11 13:21:13,814 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e4243eea-f123-4e13-a3b9-e6a1d41beb86, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,814 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 7 < 100, will create new one.
2025-11-11 13:21:13,815 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e4243eea-f123-4e13-a3b9-e6a1d41beb86, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=OGE1YmRhYmQtNjRlZGEzMjktMjllMWQxNjItNDcyZGE0Mzk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            SELECT\n                MAX(v1),\n                MAX(v2),\n                MAX(v3),\n                MAX(v4),\n                MAX(v5)\n            FROM huge\n        " } stats_mode: STATS_MODE_NONE }
2025-11-11 13:21:13,816 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 0034aa7f-d686-41ef-ac8e-1e41134b891e, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,816 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e4243eea-f123-4e13-a3b9-e6a1d41beb86, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,817 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 0034aa7f-d686-41ef-ac8e-1e41134b891e, ghrun-3ynj4chmly.auto.internal:3087): request = {  }
2025-11-11 13:21:13,819 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 0034aa7f-d686-41ef-ac8e-1e41134b891e, ghrun-3ynj4chmly.auto.internal:3087): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=YzY1OGI2NGUtNDdlZDNhZWMtMmRjNjZiMC0xOTdmM2RjMQ==" node_id: 1 }
2025-11-11 13:21:13,820 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, 365744b6-1a76-463e-b325-998bff103349, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,820 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, 365744b6-1a76-463e-b325-998bff103349, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=YzY1OGI2NGUtNDdlZDNhZWMtMmRjNjZiMC0xOTdmM2RjMQ==" }
2025-11-11 13:21:13,820 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, 365744b6-1a76-463e-b325-998bff103349, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,822 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=YzY1OGI2NGUtNDdlZDNhZWMtMmRjNjZiMC0xOTdmM2RjMQ==
2025-11-11 13:21:13,822 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8332ace9-05e6-4042-b0e5-a988f4ae6ef7, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,823 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8332ace9-05e6-4042-b0e5-a988f4ae6ef7, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=YzY1OGI2NGUtNDdlZDNhZWMtMmRjNjZiMC0xOTdmM2RjMQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            SELECT\n                MAX(v1),\n                MAX(v2),\n                MAX(v3),\n                MAX(v4),\n                MAX(v5)\n            FROM huge\n        " } stats_mode: STATS_MODE_NONE }
2025-11-11 13:21:13,823 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 8 < 100, will create new one.
2025-11-11 13:21:13,824 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 317231a1-01ee-4291-b145-4a70eac2a321, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,824 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 317231a1-01ee-4291-b145-4a70eac2a321, ghrun-3ynj4chmly.auto.internal:3087): request = {  }
2025-11-11 13:21:13,825 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8332ace9-05e6-4042-b0e5-a988f4ae6ef7, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,830 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 317231a1-01ee-4291-b145-4a70eac2a321, ghrun-3ynj4chmly.auto.internal:3087): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=YTEyZWI5YmQtYTUxZjM0NWEtNzUzNzk0ZTYtZmNhZTA2MjM=" node_id: 1 }
2025-11-11 13:21:13,830 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, 20962a21-66ba-42ae-888f-577605f37b0f, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,831 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, 20962a21-66ba-42ae-888f-577605f37b0f, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=YTEyZWI5YmQtYTUxZjM0NWEtNzUzNzk0ZTYtZmNhZTA2MjM=" }
2025-11-11 13:21:13,831 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, 20962a21-66ba-42ae-888f-577605f37b0f, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,833 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=YTEyZWI5YmQtYTUxZjM0NWEtNzUzNzk0ZTYtZmNhZTA2MjM=
2025-11-11 13:21:13,833 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ac600d25-960d-4274-8398-bf39b251ee84, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,833 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 9 < 100, will create new one.
2025-11-11 13:21:13,834 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ac600d25-960d-4274-8398-bf39b251ee84, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=YTEyZWI5YmQtYTUxZjM0NWEtNzUzNzk0ZTYtZmNhZTA2MjM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            SELECT\n                MAX(v1),\n                MAX(v2),\n                MAX(v3),\n                MAX(v4),\n                MAX(v5)\n            FROM huge\n        " } stats_mode: STATS_MODE_NONE }
2025-11-11 13:21:13,835 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 2a52bfdc-16cc-4d9e-be63-fa9c1d585ae4, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,836 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ac600d25-960d-4274-8398-bf39b251ee84, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,836 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 2a52bfdc-16cc-4d9e-be63-fa9c1d585ae4, ghrun-3ynj4chmly.auto.internal:3087): request = {  }
2025-11-11 13:21:13,839 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 2a52bfdc-16cc-4d9e-be63-fa9c1d585ae4, ghrun-3ynj4chmly.auto.internal:3087): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=N2ZmNDgyYTMtOWExN2I5Y2ItYjUxZTE2MjItMWIwZmY3ZDM=" node_id: 1 }
2025-11-11 13:21:13,840 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, 1084bd9f-41c5-4232-8eb3-2c9310372d93, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,840 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, 1084bd9f-41c5-4232-8eb3-2c9310372d93, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=N2ZmNDgyYTMtOWExN2I5Y2ItYjUxZTE2MjItMWIwZmY3ZDM=" }
2025-11-11 13:21:13,840 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, 1084bd9f-41c5-4232-8eb3-2c9310372d93, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,845 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=N2ZmNDgyYTMtOWExN2I5Y2ItYjUxZTE2MjItMWIwZmY3ZDM=
2025-11-11 13:21:13,845 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6093e280-bd69-4a34-b4f2-a2353ff10ea1, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,846 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 10 < 100, will create new one.
2025-11-11 13:21:13,846 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6093e280-bd69-4a34-b4f2-a2353ff10ea1, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=N2ZmNDgyYTMtOWExN2I5Y2ItYjUxZTE2MjItMWIwZmY3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            SELECT\n                MAX(v1),\n                MAX(v2),\n                MAX(v3),\n                MAX(v4),\n                MAX(v5)\n            FROM huge\n        " } stats_mode: STATS_MODE_NONE }
2025-11-11 13:21:13,847 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 9db468cb-7392-49ba-830d-0e05dd2ce5a5, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,848 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 9db468cb-7392-49ba-830d-0e05dd2ce5a5, ghrun-3ynj4chmly.auto.internal:3087): request = {  }
2025-11-11 13:21:13,848 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6093e280-bd69-4a34-b4f2-a2353ff10ea1, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,854 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 9db468cb-7392-49ba-830d-0e05dd2ce5a5, ghrun-3ynj4chmly.auto.internal:3087): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=Zjk1NmJjYzAtYTQyNTc4ZjQtZTE1MWI5NWQtYjFlZmEwMjk=" node_id: 1 }
2025-11-11 13:21:13,854 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, 9a6ff870-064c-45be-8fff-baa34a67db60, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,855 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, 9a6ff870-064c-45be-8fff-baa34a67db60, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=Zjk1NmJjYzAtYTQyNTc4ZjQtZTE1MWI5NWQtYjFlZmEwMjk=" }
2025-11-11 13:21:13,855 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, 9a6ff870-064c-45be-8fff-baa34a67db60, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,857 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=Zjk1NmJjYzAtYTQyNTc4ZjQtZTE1MWI5NWQtYjFlZmEwMjk=
2025-11-11 13:21:13,858 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, dda0b7cb-a765-4626-aa9d-d55ea8651b5e, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,858 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 11 < 100, will create new one.
2025-11-11 13:21:13,859 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, dda0b7cb-a765-4626-aa9d-d55ea8651b5e, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=Zjk1NmJjYzAtYTQyNTc4ZjQtZTE1MWI5NWQtYjFlZmEwMjk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            SELECT\n                MAX(v1),\n                MAX(v2),\n                MAX(v3),\n                MAX(v4),\n                MAX(v5)\n            FROM huge\n        " } stats_mode: STATS_MODE_NONE }
2025-11-11 13:21:13,859 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 890ddd52-8090-4201-93bf-bd5272db1542, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,860 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, dda0b7cb-a765-4626-aa9d-d55ea8651b5e, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,861 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 890ddd52-8090-4201-93bf-bd5272db1542, ghrun-3ynj4chmly.auto.internal:3087): request = {  }
2025-11-11 13:21:13,864 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 890ddd52-8090-4201-93bf-bd5272db1542, ghrun-3ynj4chmly.auto.internal:3087): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=YTJiMDE2YmQtYTY0ODY0ZmMtZjhjZTMwNGYtNDBjYTBkMzg=" node_id: 1 }
2025-11-11 13:21:13,865 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, 697a16f2-ae6f-4ac2-aaa0-e69a3420b7e7, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,865 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, 697a16f2-ae6f-4ac2-aaa0-e69a3420b7e7, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=YTJiMDE2YmQtYTY0ODY0ZmMtZjhjZTMwNGYtNDBjYTBkMzg=" }
2025-11-11 13:21:13,866 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, 697a16f2-ae6f-4ac2-aaa0-e69a3420b7e7, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,868 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=YTJiMDE2YmQtYTY0ODY0ZmMtZjhjZTMwNGYtNDBjYTBkMzg=
2025-11-11 13:21:13,868 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 765b71ca-b1b0-4d30-b783-03853b0ebb9e, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,868 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 12 < 100, will create new one.
2025-11-11 13:21:13,869 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 765b71ca-b1b0-4d30-b783-03853b0ebb9e, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=YTJiMDE2YmQtYTY0ODY0ZmMtZjhjZTMwNGYtNDBjYTBkMzg=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            SELECT\n                MAX(v1),\n                MAX(v2),\n                MAX(v3),\n                MAX(v4),\n                MAX(v5)\n            FROM huge\n        " } stats_mode: STATS_MODE_NONE }
2025-11-11 13:21:13,869 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 14010535-57b1-4743-9d93-5e1bd9637d9e, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,870 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 14010535-57b1-4743-9d93-5e1bd9637d9e, ghrun-3ynj4chmly.auto.internal:3087): request = {  }
2025-11-11 13:21:13,871 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 765b71ca-b1b0-4d30-b783-03853b0ebb9e, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,874 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 14010535-57b1-4743-9d93-5e1bd9637d9e, ghrun-3ynj4chmly.auto.internal:3087): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=MWJhZTY1MDctOTE0MWI0ZS05NWFjZGFmZC0zOWM5MjljYQ==" node_id: 1 }
2025-11-11 13:21:13,875 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, c046f782-103c-4dba-a58a-d365e83870dc, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,875 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, c046f782-103c-4dba-a58a-d365e83870dc, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=MWJhZTY1MDctOTE0MWI0ZS05NWFjZGFmZC0zOWM5MjljYQ==" }
2025-11-11 13:21:13,876 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, c046f782-103c-4dba-a58a-d365e83870dc, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,878 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=MWJhZTY1MDctOTE0MWI0ZS05NWFjZGFmZC0zOWM5MjljYQ==
2025-11-11 13:21:13,878 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b5638149-04db-4e09-bd1b-76bbf13ff2f6, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,879 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 13 < 100, will create new one.
2025-11-11 13:21:13,879 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b5638149-04db-4e09-bd1b-76bbf13ff2f6, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=MWJhZTY1MDctOTE0MWI0ZS05NWFjZGFmZC0zOWM5MjljYQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            SELECT\n                MAX(v1),\n                MAX(v2),\n                MAX(v3),\n                MAX(v4),\n                MAX(v5)\n            FROM huge\n        " } stats_mode: STATS_MODE_NONE }
2025-11-11 13:21:13,880 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 691f7bb9-dafe-4864-9487-62c8b55da025, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,881 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 691f7bb9-dafe-4864-9487-62c8b55da025, ghrun-3ynj4chmly.auto.internal:3087): request = {  }
2025-11-11 13:21:13,881 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b5638149-04db-4e09-bd1b-76bbf13ff2f6, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,896 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 691f7bb9-dafe-4864-9487-62c8b55da025, ghrun-3ynj4chmly.auto.internal:3087): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=N2E1MWQ2NDktNzJmODc5Zi04YzIxYmFhOS05ZTRlODg0ZQ==" node_id: 1 }
2025-11-11 13:21:13,897 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, cf909a5e-f15f-4e6c-8346-0e1ac7057366, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,897 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, cf909a5e-f15f-4e6c-8346-0e1ac7057366, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=N2E1MWQ2NDktNzJmODc5Zi04YzIxYmFhOS05ZTRlODg0ZQ==" }
2025-11-11 13:21:13,898 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, cf909a5e-f15f-4e6c-8346-0e1ac7057366, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,900 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=N2E1MWQ2NDktNzJmODc5Zi04YzIxYmFhOS05ZTRlODg0ZQ==
2025-11-11 13:21:13,901 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9dea90af-39e6-4c1e-876a-6837aadbc068, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,901 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 14 < 100, will create new one.
2025-11-11 13:21:13,902 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9dea90af-39e6-4c1e-876a-6837aadbc068, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=N2E1MWQ2NDktNzJmODc5Zi04YzIxYmFhOS05ZTRlODg0ZQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            SELECT\n                MAX(v1),\n                MAX(v2),\n                MAX(v3),\n                MAX(v4),\n                MAX(v5)\n            FROM huge\n        " } stats_mode: STATS_MODE_NONE }
2025-11-11 13:21:13,903 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 5e55d606-ff19-41d7-9590-4d75b0bc85ee, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,903 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 5e55d606-ff19-41d7-9590-4d75b0bc85ee, ghrun-3ynj4chmly.auto.internal:3087): request = {  }
2025-11-11 13:21:13,904 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9dea90af-39e6-4c1e-876a-6837aadbc068, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,906 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 5e55d606-ff19-41d7-9590-4d75b0bc85ee, ghrun-3ynj4chmly.auto.internal:3087): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=Njg4NGI3ZGYtN2Y1NjIzODMtODIxNGM0NDgtNWY2ZWJlYzg=" node_id: 1 }
2025-11-11 13:21:13,906 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, dfb53f7b-0fe0-4edf-95b0-92db53698837, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,907 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, dfb53f7b-0fe0-4edf-95b0-92db53698837, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=Njg4NGI3ZGYtN2Y1NjIzODMtODIxNGM0NDgtNWY2ZWJlYzg=" }
2025-11-11 13:21:13,907 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, dfb53f7b-0fe0-4edf-95b0-92db53698837, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,912 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=Njg4NGI3ZGYtN2Y1NjIzODMtODIxNGM0NDgtNWY2ZWJlYzg=
2025-11-11 13:21:13,913 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 290ffcad-d3bb-4e48-ad57-1db0f22042c3, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,913 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 15 < 100, will create new one.
2025-11-11 13:21:13,914 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 290ffcad-d3bb-4e48-ad57-1db0f22042c3, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=Njg4NGI3ZGYtN2Y1NjIzODMtODIxNGM0NDgtNWY2ZWJlYzg=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            SELECT\n                MAX(v1),\n                MAX(v2),\n                MAX(v3),\n                MAX(v4),\n                MAX(v5)\n            FROM huge\n        " } stats_mode: STATS_MODE_NONE }
2025-11-11 13:21:13,914 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 18c1d95b-3cce-4990-8c5e-a8fdced191c0, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,916 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 18c1d95b-3cce-4990-8c5e-a8fdced191c0, ghrun-3ynj4chmly.auto.internal:3087): request = {  }
2025-11-11 13:21:13,916 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 290ffcad-d3bb-4e48-ad57-1db0f22042c3, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,918 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 18c1d95b-3cce-4990-8c5e-a8fdced191c0, ghrun-3ynj4chmly.auto.internal:3087): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=Y2FlMjQ3MC0yZjliYjI0Yi1hOWQ1YjY0Ny1iODNiNjIyNw==" node_id: 1 }
2025-11-11 13:21:13,918 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, 73928d83-fb7b-44bb-a67b-023feba43a49, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,919 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, 73928d83-fb7b-44bb-a67b-023feba43a49, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=Y2FlMjQ3MC0yZjliYjI0Yi1hOWQ1YjY0Ny1iODNiNjIyNw==" }
2025-11-11 13:21:13,920 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, 73928d83-fb7b-44bb-a67b-023feba43a49, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,925 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=Y2FlMjQ3MC0yZjliYjI0Yi1hOWQ1YjY0Ny1iODNiNjIyNw==
2025-11-11 13:21:13,925 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0e775bc3-dc6d-47eb-b148-9a9fcefccfba, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,926 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0e775bc3-dc6d-47eb-b148-9a9fcefccfba, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=Y2FlMjQ3MC0yZjliYjI0Yi1hOWQ1YjY0Ny1iODNiNjIyNw==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            SELECT\n                MAX(v1),\n                MAX(v2),\n                MAX(v3),\n                MAX(v4),\n                MAX(v5)\n            FROM huge\n        " } stats_mode: STATS_MODE_NONE }
2025-11-11 13:21:13,926 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 16 < 100, will create new one.
2025-11-11 13:21:13,928 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, b3e4a6b8-6152-4ea2-a4fd-eb362d7d0f91, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,928 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0e775bc3-dc6d-47eb-b148-9a9fcefccfba, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,928 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, b3e4a6b8-6152-4ea2-a4fd-eb362d7d0f91, ghrun-3ynj4chmly.auto.internal:3087): request = {  }
2025-11-11 13:21:13,933 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, b3e4a6b8-6152-4ea2-a4fd-eb362d7d0f91, ghrun-3ynj4chmly.auto.internal:3087): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=YWM3M2I2YjMtNjZkYzY3NzAtNDUyNWYxOS0yMDJhNTliNQ==" node_id: 1 }
2025-11-11 13:21:13,934 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, e4ad6fbe-a902-44fe-8173-2e74b506dc52, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,934 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, e4ad6fbe-a902-44fe-8173-2e74b506dc52, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=YWM3M2I2YjMtNjZkYzY3NzAtNDUyNWYxOS0yMDJhNTliNQ==" }
2025-11-11 13:21:13,935 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, e4ad6fbe-a902-44fe-8173-2e74b506dc52, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,936 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=YWM3M2I2YjMtNjZkYzY3NzAtNDUyNWYxOS0yMDJhNTliNQ==
2025-11-11 13:21:13,937 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 97be5c1c-e2c0-4c97-9c7e-0c894849f463, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,938 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 17 < 100, will create new one.
2025-11-11 13:21:13,938 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 97be5c1c-e2c0-4c97-9c7e-0c894849f463, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=YWM3M2I2YjMtNjZkYzY3NzAtNDUyNWYxOS0yMDJhNTliNQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            SELECT\n                MAX(v1),\n                MAX(v2),\n                MAX(v3),\n                MAX(v4),\n                MAX(v5)\n            FROM huge\n        " } stats_mode: STATS_MODE_NONE }
2025-11-11 13:21:13,939 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 0f39986b-e9bf-4dfa-a00d-78614d9b0709, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,940 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 97be5c1c-e2c0-4c97-9c7e-0c894849f463, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,940 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 0f39986b-e9bf-4dfa-a00d-78614d9b0709, ghrun-3ynj4chmly.auto.internal:3087): request = {  }
2025-11-11 13:21:13,945 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 0f39986b-e9bf-4dfa-a00d-78614d9b0709, ghrun-3ynj4chmly.auto.internal:3087): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=YWVjMWY4YzUtYjc5MzQyOWQtNDQzN2E1OC1iNjU0NGQxMQ==" node_id: 1 }
2025-11-11 13:21:13,946 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, b3b9e397-9eb2-4054-ba5f-178020b8059a, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,947 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, b3b9e397-9eb2-4054-ba5f-178020b8059a, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=YWVjMWY4YzUtYjc5MzQyOWQtNDQzN2E1OC1iNjU0NGQxMQ==" }
2025-11-11 13:21:13,947 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, b3b9e397-9eb2-4054-ba5f-178020b8059a, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,949 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=YWVjMWY4YzUtYjc5MzQyOWQtNDQzN2E1OC1iNjU0NGQxMQ==
2025-11-11 13:21:13,950 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 94ad48fe-2b72-4f14-bb30-588c4fbec2f0, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,950 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 94ad48fe-2b72-4f14-bb30-588c4fbec2f0, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=YWVjMWY4YzUtYjc5MzQyOWQtNDQzN2E1OC1iNjU0NGQxMQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            SELECT\n                MAX(v1),\n                MAX(v2),\n                MAX(v3),\n                MAX(v4),\n                MAX(v5)\n            FROM huge\n        " } stats_mode: STATS_MODE_NONE }
2025-11-11 13:21:13,951 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 94ad48fe-2b72-4f14-bb30-588c4fbec2f0, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,951 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 18 < 100, will create new one.
2025-11-11 13:21:13,954 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, fe96f85d-3358-486f-abfe-ba20a5df261b, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,955 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, fe96f85d-3358-486f-abfe-ba20a5df261b, ghrun-3ynj4chmly.auto.internal:3087): request = {  }
2025-11-11 13:21:13,960 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, fe96f85d-3358-486f-abfe-ba20a5df261b, ghrun-3ynj4chmly.auto.internal:3087): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=Njc2YTUwNTctYzM0YzM2Y2UtN2Y1ZDEyODAtMmI1ZjgxMjA=" node_id: 1 }
2025-11-11 13:21:13,961 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, fd93f7f9-b838-44d6-a3b4-c46ea30f6bc4, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,961 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, fd93f7f9-b838-44d6-a3b4-c46ea30f6bc4, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=Njc2YTUwNTctYzM0YzM2Y2UtN2Y1ZDEyODAtMmI1ZjgxMjA=" }
2025-11-11 13:21:13,961 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, fd93f7f9-b838-44d6-a3b4-c46ea30f6bc4, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,963 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=Njc2YTUwNTctYzM0YzM2Y2UtN2Y1ZDEyODAtMmI1ZjgxMjA=
2025-11-11 13:21:13,964 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5532daae-5ed9-406b-af00-df5e39789192, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,964 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 19 < 100, will create new one.
2025-11-11 13:21:13,965 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5532daae-5ed9-406b-af00-df5e39789192, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=Njc2YTUwNTctYzM0YzM2Y2UtN2Y1ZDEyODAtMmI1ZjgxMjA=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            SELECT\n                MAX(v1),\n                MAX(v2),\n                MAX(v3),\n                MAX(v4),\n                MAX(v5)\n            FROM huge\n        " } stats_mode: STATS_MODE_NONE }
2025-11-11 13:21:13,965 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 72593a2f-efbf-407b-b730-655cea6b055c, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,966 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 72593a2f-efbf-407b-b730-655cea6b055c, ghrun-3ynj4chmly.auto.internal:3087): request = {  }
2025-11-11 13:21:13,966 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5532daae-5ed9-406b-af00-df5e39789192, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,968 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 72593a2f-efbf-407b-b730-655cea6b055c, ghrun-3ynj4chmly.auto.internal:3087): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=Njk1YTFmMDItOTcwM2E0MmItZTI2YjdhN2YtNTA0MjQzMjQ=" node_id: 1 }
2025-11-11 13:21:13,969 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, 321e8309-b820-45b0-b13c-579ea4a9e3b8, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,969 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, 321e8309-b820-45b0-b13c-579ea4a9e3b8, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=Njk1YTFmMDItOTcwM2E0MmItZTI2YjdhN2YtNTA0MjQzMjQ=" }
2025-11-11 13:21:13,970 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, 321e8309-b820-45b0-b13c-579ea4a9e3b8, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:13,975 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=Njk1YTFmMDItOTcwM2E0MmItZTI2YjdhN2YtNTA0MjQzMjQ=
2025-11-11 13:21:13,975 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7d7d7551-8524-48a7-8c2b-9d03282ecc76, ghrun-3ynj4chmly.auto.internal:3087): creating call state
2025-11-11 13:21:13,976 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7d7d7551-8524-48a7-8c2b-9d03282ecc76, ghrun-3ynj4chmly.auto.internal:3087): request = { session_id: "ydb://session/3?node_id=1&id=Njk1YTFmMDItOTcwM2E0MmItZTI2YjdhN2YtNTA0MjQzMjQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            SELECT\n                MAX(v1),\n                MAX(v2),\n                MAX(v3),\n                MAX(v4),\n                MAX(v5)\n            FROM huge\n        " } stats_mode: STATS_MODE_NONE }
2025-11-11 13:21:13,977 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7d7d7551-8524-48a7-8c2b-9d03282ecc76, ghrun-3ynj4chmly.auto.internal:3087): response = { <_MultiThreadedRendezvous object> }
2025-11-11 13:21:16,636 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-3ynj4chmly.auto.internal:22647
2025-11-11 13:21:16,683 - 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-11 13:21:19,255 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:15690
2025-11-11 13:21:19,375 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:15690". Check endpoint correctness.
2025-11-11 13:21:20,204 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:15690
2025-11-11 13:21:20,318 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:15690". Check endpoint correctness.
2025-11-11 13:21:20,563 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-11 13:21:20,564 - 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-11 13:21:20,685 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-3ynj4chmly.auto.internal:2708
2025-11-11 13:21:20,736 - 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-11 13:21:21,322 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-11 13:21:21,322 - 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-11 13:21:22,232 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-11 13:21:22,233 - 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-11 13:21:22,233 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-11 13:21:22,238 - 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-11 13:21:22,243 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-11 13:21:22,243 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 97a2f708-10d1-459c-ad3f-aa1b1766f520, localhost:26702): creating call state
2025-11-11 13:21:22,244 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 97a2f708-10d1-459c-ad3f-aa1b1766f520, localhost:26702): request = { database: "/Root" }
2025-11-11 13:21:22,246 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 97a2f708-10d1-459c-ad3f-aa1b1766f520, localhost:26702): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-3ynj4chmly.auto.internal" port: 26702 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-11 13:21:22,247 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-3ynj4chmly.auto.internal:26702, location 1, ssl: False>]>
2025-11-11 13:21:22,247 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:26702
2025-11-11 13:21:23,143 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-11 13:21:23,143 - 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-11 13:21:24,739 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-3ynj4chmly.auto.internal:2575
2025-11-11 13:21:24,792 - 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-11 13:21:28,313 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YmFiMjdhNjYtMjljZmQ3ZmYtODZhMGYyMzYtMzI4ZDg5YWQ=
2025-11-11 13:21:28,795 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-3ynj4chmly.auto.internal:31622
2025-11-11 13:21:28,854 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:15690
2025-11-11 13:21:29,982 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-11 13:21:29,983 - 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-11 13:21:29,987 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-11 13:21:29,987 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 2d68c5d6-3189-4b8a-980c-15e561d923c9, localhost:27231): creating call state
2025-11-11 13:21:29,988 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 2d68c5d6-3189-4b8a-980c-15e561d923c9, localhost:27231): request = { database: "/Root" }
2025-11-11 13:21:29,992 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 2d68c5d6-3189-4b8a-980c-15e561d923c9, localhost:27231): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-3ynj4chmly.auto.internal" port: 27231 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-11 13:21:29,993 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-3ynj4chmly.auto.internal:27231, location 1, ssl: False>]>
2025-11-11 13:21:29,994 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:27231
2025-11-11 13:21:30,390 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=M2U0NTJlMzEtOWFiMzUxNGUtOTYzMGE3MGQtZjk1MDkxYTg=
2025-11-11 13:21:30,566 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:15690
2025-11-11 13:21:30,692 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:15690". Check endpoint correctness.
2025-11-11 13:21:31,325 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:15690
2025-11-11 13:21:31,366 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTEyZWI5YmQtYTUxZjM0NWEtNzUzNzk0ZTYtZmNhZTA2MjM=
2025-11-11 13:21:31,456 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:15690". Check endpoint correctness.
2025-11-11 13:21:32,241 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:15690
2025-11-11 13:21:32,379 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:15690". Check endpoint correctness.
2025-11-11 13:21:32,587 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=OGE1YmRhYmQtNjRlZGEzMjktMjllMWQxNjItNDcyZGE0Mzk=
2025-11-11 13:21:32,603 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-11 13:21:32,611 - 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-11 13:21:33,149 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:15690
2025-11-11 13:21:33,229 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzY1OGI2NGUtNDdlZDNhZWMtMmRjNjZiMC0xOTdmM2RjMQ==
2025-11-11 13:21:33,275 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:15690". Check endpoint correctness.
2025-11-11 13:21:33,298 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-11 13:21:33,299 - 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-11 13:21:34,064 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZjYjk4NWMtYTJlYzhmNjYtMjJhNDhjMzgtNTk2MWFmZjY=
2025-11-11 13:21:34,107 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-11 13:21:34,108 - 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-11 13:21:34,195 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZjI4NTQ0ODAtNTZjMGU5Y2EtZWIxZjViNTItYzY5NjY4NTM=
2025-11-11 13:21:34,390 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-11 13:21:34,391 - 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-11 13:21:35,620 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=M2ZiMWZlYjAtMjc0Njc4MDQtNTBiMWJlNzMtZGMyY2Q3OTI=
2025-11-11 13:21:35,769 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2ZmNDgyYTMtOWExN2I5Y2ItYjUxZTE2MjItMWIwZmY3ZDM=
2025-11-11 13:21:36,761 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2FjM2ZhNGItZDU2NWM4ZjEtMTVkYjFkYjktOWQzZjYwYmI=
2025-11-11 13:21:42,617 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:15690
2025-11-11 13:21:42,784 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:15690". Check endpoint correctness.
2025-11-11 13:21:43,304 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:15690
2025-11-11 13:21:43,482 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:15690". Check endpoint correctness.
2025-11-11 13:21:44,111 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:15690
2025-11-11 13:21:44,301 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:15690". Check endpoint correctness.
2025-11-11 13:21:44,394 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:15690
2025-11-11 13:21:44,575 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-11 13:21:44,596 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:15690". Check endpoint correctness.
2025-11-11 13:21:44,600 - 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-11 13:21:45,375 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-11 13:21:45,376 - 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-11 13:21:45,651 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-11 13:21:45,716 - 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-11 13:21:45,733 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-11 13:21:45,853 - 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-11 13:21:54,611 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:15690
2025-11-11 13:21:54,666 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:15690". Check endpoint correctness.
2025-11-11 13:21:55,391 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:15690
2025-11-11 13:21:55,444 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:15690". Check endpoint correctness.
2025-11-11 13:21:55,821 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:15690
2025-11-11 13:21:55,867 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:15690
2025-11-11 13:21:55,876 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:15690". Check endpoint correctness.
2025-11-11 13:21:55,953 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:15690". Check endpoint correctness.
2025-11-11 13:21:56,586 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-11 13:21:56,595 - 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-11 13:21:56,690 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-11 13:21:56,711 - 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-11 13:21:56,963 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-11 13:21:56,993 - 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-11 13:21:57,247 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-11 13:21:57,270 - 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-11 13:21:59,538 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MWJhZTY1MDctOTE0MWI0ZS05NWFjZGFmZC0zOWM5MjljYQ==
2025-11-11 13:22:00,336 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTJiMDE2YmQtYTY0ODY0ZmMtZjhjZTMwNGYtNDBjYTBkMzg=
2025-11-11 13:22:01,093 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Njk1YTFmMDItOTcwM2E0MmItZTI2YjdhN2YtNTA0MjQzMjQ=
2025-11-11 13:22:01,129 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YWVjMWY4YzUtYjc5MzQyOWQtNDQzN2E1OC1iNjU0NGQxMQ==
2025-11-11 13:22:01,468 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Zjk1NmJjYzAtYTQyNTc4ZjQtZTE1MWI5NWQtYjFlZmEwMjk=
2025-11-11 13:22:02,256 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YWM3M2I2YjMtNjZkYzY3NzAtNDUyNWYxOS0yMDJhNTliNQ==
2025-11-11 13:22:02,467 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Njg4NGI3ZGYtN2Y1NjIzODMtODIxNGM0NDgtNWY2ZWJlYzg=
2025-11-11 13:22:02,700 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Njc2YTUwNTctYzM0YzM2Y2UtN2Y1ZDEyODAtMmI1ZjgxMjA=
2025-11-11 13:22:02,716 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2E1MWQ2NDktNzJmODc5Zi04YzIxYmFhOS05ZTRlODg0ZQ==
2025-11-11 13:22:03,136 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2FlMjQ3MC0yZjliYjI0Yi1hOWQ1YjY0Ny1iODNiNjIyNw==
2025-11-11 13:22:03,177 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-11-11 13:22:06,607 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:15690
2025-11-11 13:22:06,669 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:15690". Check endpoint correctness.
2025-11-11 13:22:06,752 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:15690
2025-11-11 13:22:06,812 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:15690". Check endpoint correctness.
2025-11-11 13:22:07,003 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:15690
2025-11-11 13:22:07,049 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:15690". Check endpoint correctness.
2025-11-11 13:22:07,275 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:15690
2025-11-11 13:22:07,331 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:15690". Check endpoint correctness.
2025-11-11 13:22:08,047 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-11 13:22:08,055 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-11 13:22:08,093 - 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-11 13:22:08,106 - 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-11 13:22:08,563 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-11 13:22:08,564 - 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-11 13:22:09,193 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-11 13:22:09,195 - 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-11 13:22:14,291 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-11 13:22:14,295 - 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-11 13:22:15,194 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:3087/1
2025-11-11 13:22:15,195 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/1698
2025-11-11 13:22:15,195 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/24075
2025-11-11 13:22:15,196 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/18533
2025-11-11 13:22:15,197 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/3087
2025-11-11 13:22:15,201 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/16206
2025-11-11 13:22:15,443 - WARNING - ydb.topic - __del__: Topic client was not closed properly. Consider using method close().
2025-11-11 13:22:15,476 - DEBUG - ydb.topic - close: Close topic client
2025-11-11 13:22:15,479 - DEBUG - ydb.topic - close: Topic client was closed
