2025-11-01 16:24:34,033 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 16:24:34,033 - INFO - ya.test - pytest_runtest_setup: test_create_and_drop_the_same_tenant2[enable_alter_database_create_hive_first--false]
2025-11-01 16:24:34,033 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 16:24:34,034 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-01 16:24:34,034 - INFO - ydb.tests.library.fixtures - ydb_cluster: destroy ydb_cluster for __tests__.test_dynamic_tenants
2025-11-01 16:24:41,035 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:14980/1
2025-11-01 16:24:41,036 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/64381
2025-11-01 16:24:41,036 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/17122
2025-11-01 16:24:41,037 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/11200
2025-11-01 16:24:41,037 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/1277
2025-11-01 16:24:41,037 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/61378
2025-11-01 16:24:41,037 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/11859
2025-11-01 16:24:41,037 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/26033
2025-11-01 16:24:41,038 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/11257
2025-11-01 16:24:41,038 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/16768
2025-11-01 16:24:41,038 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/5963
2025-11-01 16:24:41,038 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/21749
2025-11-01 16:24:41,039 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/2484
2025-11-01 16:24:41,039 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/65026
2025-11-01 16:24:41,039 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/22564
2025-11-01 16:24:41,040 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/7024
2025-11-01 16:24:41,040 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/22886
2025-11-01 16:24:41,040 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/25884
2025-11-01 16:24:41,041 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/26817
2025-11-01 16:24:41,041 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/20919
2025-11-01 16:24:41,041 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/29304
2025-11-01 16:24:41,041 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/61749
2025-11-01 16:24:41,041 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/3996
2025-11-01 16:24:41,042 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/5479
2025-11-01 16:24:41,042 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/7265
2025-11-01 16:24:41,042 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/18925
2025-11-01 16:24:41,042 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/16805
2025-11-01 16:24:41,042 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/17673
2025-11-01 16:24:41,042 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/29676
2025-11-01 16:24:41,043 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/16881
2025-11-01 16:24:41,043 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/24403
2025-11-01 16:24:41,043 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/8768
2025-11-01 16:24:41,043 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/20862
2025-11-01 16:24:41,043 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/23499
2025-11-01 16:24:41,044 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/1497
2025-11-01 16:24:41,044 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/26766
2025-11-01 16:24:41,044 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/2628
2025-11-01 16:24:41,044 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/16095
2025-11-01 16:24:41,044 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/62277
2025-11-01 16:24:41,044 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/4446
2025-11-01 16:24:41,045 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/19956
2025-11-01 16:24:41,045 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/17555
2025-11-01 16:24:41,045 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/5952
2025-11-01 16:24:41,045 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/7865
2025-11-01 16:24:41,045 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/2092
2025-11-01 16:24:41,045 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/63687
2025-11-01 16:24:41,046 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/8580
2025-11-01 16:24:41,046 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/30493
2025-11-01 16:24:41,046 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/1534
2025-11-01 16:24:41,046 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/14653
2025-11-01 16:24:41,046 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/27463
2025-11-01 16:24:41,047 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/18584
2025-11-01 16:24:41,048 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/12367
2025-11-01 16:24:41,048 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/32012
2025-11-01 16:24:41,049 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/14980
2025-11-01 16:24:41,049 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/10779
2025-11-01 16:24:41,103 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/drlt/00162f/ydb/apps/ydbd/ydbd
2025-11-01 16:24:41,105 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/29830
2025-11-01 16:24:41,105 - INFO - ydb.tests.library.fixtures - ydb_cluster: setup ydb_cluster for __tests__.test_dynamic_tenants
2025-11-01 16:24:41,106 - INFO - ydb.tests.library.fixtures - ydb_cluster: setup ydb_cluster as local
2025-11-01 16:24:41,106 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/drlt/00162f/r3tmp/kikimr_cluster_0b8vfq3y
2025-11-01 16:24:41,134 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/drlt/00162f/ydb/apps/ydbd/ydbd
2025-11-01 16:24:41,135 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/18089
2025-11-01 16:24:41,135 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/21339
2025-11-01 16:24:41,135 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/4459
2025-11-01 16:24:41,136 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/19835
2025-11-01 16:24:41,136 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/drlt/00162f/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/kikimr_configs"
2025-11-01 16:24:41,136 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/drlt/00162f/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/drlt/00162f/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/node_1/logfile_qkzg0r2c.log --grpc-port=18089 --mon-port=21339 --ic-port=29830
2025-11-01 16:24:41,136 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:18089/1, disk_size 68719476736
2025-11-01 16:24:41,137 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/drlt/00162f/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/kikimr_configs"
2025-11-01 16:24:41,137 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/drlt/00162f/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/drlt/00162f/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/node_1/logfile_qkzg0r2c.log --grpc-port=18089 --mon-port=21339 --ic-port=29830
2025-11-01 16:24:41,137 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/drlt/00162f/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/drlt/00162f/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/drlt/00162f/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/node_1/logfile_qkzg0r2c.log', '--grpc-port=18089', '--mon-port=21339', '--ic-port=29830')' in '/home/runner/.ya/build/build_root/drlt/00162f/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/node_1' (no wait)
2025-11-01 16:24:41,138 - DEBUG - ya.test - execute: Command pid: 1447622
2025-11-01 16:24:41,139 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:18089/1
2025-11-01 16:24:41,140 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.30
2025-11-01 16:24:41,141 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.30
2025-11-01 16:24:41,141 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/drlt/00162f/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 16:24:41,142 - DEBUG - ya.test - execute: Command pid: 1447623
2025-11-01 16:24:41,574 - DEBUG - ya.test - _save_outputs: Command (pid 1447623) rc: 0
2025-11-01 16:24:41,574 - DEBUG - ya.test - _save_outputs: Command (pid 1447623) elapsed time (sec): 0.4316861629486084
2025-11-01 16:24:41,574 - DEBUG - ya.test - _save_outputs: Command (pid 1447623) idrss: 0
2025-11-01 16:24:41,575 - DEBUG - ya.test - _save_outputs: Command (pid 1447623) inblock: 0
2025-11-01 16:24:41,575 - DEBUG - ya.test - _save_outputs: Command (pid 1447623) isrss: 0
2025-11-01 16:24:41,575 - DEBUG - ya.test - _save_outputs: Command (pid 1447623) ixrss: 0
2025-11-01 16:24:41,575 - DEBUG - ya.test - _save_outputs: Command (pid 1447623) majflt: 0
2025-11-01 16:24:41,575 - DEBUG - ya.test - _save_outputs: Command (pid 1447623) maxrss: 538524
2025-11-01 16:24:41,575 - DEBUG - ya.test - _save_outputs: Command (pid 1447623) minflt: 16129
2025-11-01 16:24:41,575 - DEBUG - ya.test - _save_outputs: Command (pid 1447623) msgrcv: 0
2025-11-01 16:24:41,575 - DEBUG - ya.test - _save_outputs: Command (pid 1447623) msgsnd: 0
2025-11-01 16:24:41,575 - DEBUG - ya.test - _save_outputs: Command (pid 1447623) nivcsw: 3
2025-11-01 16:24:41,576 - DEBUG - ya.test - _save_outputs: Command (pid 1447623) nsignals: 0
2025-11-01 16:24:41,576 - DEBUG - ya.test - _save_outputs: Command (pid 1447623) nswap: 0
2025-11-01 16:24:41,576 - DEBUG - ya.test - _save_outputs: Command (pid 1447623) nvcsw: 13
2025-11-01 16:24:41,576 - DEBUG - ya.test - _save_outputs: Command (pid 1447623) oublock: 8
2025-11-01 16:24:41,576 - DEBUG - ya.test - _save_outputs: Command (pid 1447623) stime: 0.266333
2025-11-01 16:24:41,576 - DEBUG - ya.test - _save_outputs: Command (pid 1447623) utime: 0.11702499999999999
2025-11-01 16:24:41,576 - DEBUG - ya.test - _save_outputs: Command (pid 1447623) wtime: 0.432
2025-11-01 16:24:41,577 - DEBUG - ya.test - _save_outputs: Command (pid 1447623) output:
Git info:
    Commit: b759454d1e40b275ba8b2f5964202fc9f08a1c3c
    Branch: 
    Author: Denis Khalikov <dennis.khalikov@gmail.com>
    Summary: Merge b3001557f326a9ac3df9852d3eea5c83a6651a93 into 88f362bbf1115d2653ecf70400035099c5165741

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

    
Build info:
    Compiler: /home/runner/.ya/tools/v4/9944335923/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9944335923/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -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-01 16:24:41,577 - DEBUG - ya.test - _save_outputs: Command (pid 1447623) errors:

2025-11-01 16:24:41,577 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: b759454d1e40b275ba8b2f5964202fc9f08a1c3c
    Branch: 
    Author: Denis Khalikov <dennis.khalikov@gmail.com>
    Summary: Merge b3001557f326a9ac3df9852d3eea5c83a6651a93 into 88f362bbf1115d2653ecf70400035099c5165741
2025-11-01 16:24:43,304 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/drlt/00162f/ydb/apps/ydbd/ydbd
2025-11-01 16:24:43,304 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/drlt/00162f/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:18089', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineHostConfig {\n    HostConfigId: 1\n    Drive {\n      Path: "SectorMap:1:64"\n    }\n  }\n}\nCommand {\n  DefineBox {\n    BoxId: 1\n    Host {\n      Key {\n        Fqdn: "localhost"\n        IcPort: 29830\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-01 16:24:43,306 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.31
2025-11-01 16:24:43,306 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.31
2025-11-01 16:24:43,307 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/drlt/00162f/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:18089', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineHostConfig {\n    HostConfigId: 1\n    Drive {\n      Path: "SectorMap:1:64"\n    }\n  }\n}\nCommand {\n  DefineBox {\n    BoxId: 1\n    Host {\n      Key {\n        Fqdn: "localhost"\n        IcPort: 29830\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-01 16:24:43,307 - DEBUG - ya.test - execute: Command pid: 1447996
2025-11-01 16:24:43,699 - DEBUG - ya.test - _save_outputs: Command (pid 1447996) rc: 0
2025-11-01 16:24:43,699 - DEBUG - ya.test - _save_outputs: Command (pid 1447996) elapsed time (sec): 0.39040708541870117
2025-11-01 16:24:43,699 - DEBUG - ya.test - _save_outputs: Command (pid 1447996) idrss: 0
2025-11-01 16:24:43,699 - DEBUG - ya.test - _save_outputs: Command (pid 1447996) inblock: 0
2025-11-01 16:24:43,699 - DEBUG - ya.test - _save_outputs: Command (pid 1447996) isrss: 0
2025-11-01 16:24:43,700 - DEBUG - ya.test - _save_outputs: Command (pid 1447996) ixrss: 0
2025-11-01 16:24:43,700 - DEBUG - ya.test - _save_outputs: Command (pid 1447996) majflt: 0
2025-11-01 16:24:43,700 - DEBUG - ya.test - _save_outputs: Command (pid 1447996) maxrss: 546980
2025-11-01 16:24:43,701 - DEBUG - ya.test - _save_outputs: Command (pid 1447996) minflt: 18270
2025-11-01 16:24:43,701 - DEBUG - ya.test - _save_outputs: Command (pid 1447996) msgrcv: 0
2025-11-01 16:24:43,701 - DEBUG - ya.test - _save_outputs: Command (pid 1447996) msgsnd: 0
2025-11-01 16:24:43,701 - DEBUG - ya.test - _save_outputs: Command (pid 1447996) nivcsw: 6
2025-11-01 16:24:43,701 - DEBUG - ya.test - _save_outputs: Command (pid 1447996) nsignals: 0
2025-11-01 16:24:43,701 - DEBUG - ya.test - _save_outputs: Command (pid 1447996) nswap: 0
2025-11-01 16:24:43,702 - DEBUG - ya.test - _save_outputs: Command (pid 1447996) nvcsw: 132
2025-11-01 16:24:43,702 - DEBUG - ya.test - _save_outputs: Command (pid 1447996) oublock: 8
2025-11-01 16:24:43,702 - DEBUG - ya.test - _save_outputs: Command (pid 1447996) stime: 0.234012
2025-11-01 16:24:43,702 - DEBUG - ya.test - _save_outputs: Command (pid 1447996) utime: 0.113106
2025-11-01 16:24:43,702 - DEBUG - ya.test - _save_outputs: Command (pid 1447996) wtime: 0.391
2025-11-01 16:24:43,702 - DEBUG - ya.test - _save_outputs: Command (pid 1447996) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 4

2025-11-01 16:24:43,702 - DEBUG - ya.test - _save_outputs: Command (pid 1447996) errors:

2025-11-01 16:24:43,703 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/drlt/00162f/ydb/apps/ydbd/ydbd
2025-11-01 16:24:43,703 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/drlt/00162f/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:18089', '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-01 16:24:43,705 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.32
2025-11-01 16:24:43,706 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.32
2025-11-01 16:24:43,706 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/drlt/00162f/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:18089', '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-01 16:24:43,707 - DEBUG - ya.test - execute: Command pid: 1448066
2025-11-01 16:24:44,133 - DEBUG - ya.test - _save_outputs: Command (pid 1448066) rc: 0
2025-11-01 16:24:44,133 - DEBUG - ya.test - _save_outputs: Command (pid 1448066) elapsed time (sec): 0.42383766174316406
2025-11-01 16:24:44,133 - DEBUG - ya.test - _save_outputs: Command (pid 1448066) idrss: 0
2025-11-01 16:24:44,134 - DEBUG - ya.test - _save_outputs: Command (pid 1448066) inblock: 0
2025-11-01 16:24:44,134 - DEBUG - ya.test - _save_outputs: Command (pid 1448066) isrss: 0
2025-11-01 16:24:44,134 - DEBUG - ya.test - _save_outputs: Command (pid 1448066) ixrss: 0
2025-11-01 16:24:44,134 - DEBUG - ya.test - _save_outputs: Command (pid 1448066) majflt: 0
2025-11-01 16:24:44,135 - DEBUG - ya.test - _save_outputs: Command (pid 1448066) maxrss: 546968
2025-11-01 16:24:44,135 - DEBUG - ya.test - _save_outputs: Command (pid 1448066) minflt: 18269
2025-11-01 16:24:44,135 - DEBUG - ya.test - _save_outputs: Command (pid 1448066) msgrcv: 0
2025-11-01 16:24:44,135 - DEBUG - ya.test - _save_outputs: Command (pid 1448066) msgsnd: 0
2025-11-01 16:24:44,135 - DEBUG - ya.test - _save_outputs: Command (pid 1448066) nivcsw: 4
2025-11-01 16:24:44,135 - DEBUG - ya.test - _save_outputs: Command (pid 1448066) nsignals: 0
2025-11-01 16:24:44,136 - DEBUG - ya.test - _save_outputs: Command (pid 1448066) nswap: 0
2025-11-01 16:24:44,136 - DEBUG - ya.test - _save_outputs: Command (pid 1448066) nvcsw: 135
2025-11-01 16:24:44,136 - DEBUG - ya.test - _save_outputs: Command (pid 1448066) oublock: 8
2025-11-01 16:24:44,136 - DEBUG - ya.test - _save_outputs: Command (pid 1448066) stime: 0.28837799999999997
2025-11-01 16:24:44,136 - DEBUG - ya.test - _save_outputs: Command (pid 1448066) utime: 0.09612599999999999
2025-11-01 16:24:44,136 - DEBUG - ya.test - _save_outputs: Command (pid 1448066) wtime: 0.425
2025-11-01 16:24:44,137 - DEBUG - ya.test - _save_outputs: Command (pid 1448066) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-01 16:24:44,137 - DEBUG - ya.test - _save_outputs: Command (pid 1448066) errors:

2025-11-01 16:24:44,138 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-01 16:24:44,150 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-11-01 16:24:44,159 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_dynamic_tenants.py, test_name: test_create_and_drop_the_same_tenant2[enable_alter_database_create_hive_first--false])
2025-11-01 16:24:44,160 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: create_database
2025-11-01 16:24:44,669 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/drlt/00162f/ydb/apps/ydbd/ydbd
2025-11-01 16:24:44,670 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/18642
2025-11-01 16:24:44,671 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/12799
2025-11-01 16:24:44,671 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/23492
2025-11-01 16:24:44,671 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/26672
2025-11-01 16:24:44,672 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/29876
2025-11-01 16:24:44,672 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/drlt/00162f/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/kikimr_configs"
2025-11-01 16:24:44,672 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/drlt/00162f/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:18089 --tenant=/Root/users/database --log-file-name=/home/runner/.ya/build/build_root/drlt/00162f/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/slot_1/logfile_vmj11llj.log --grpc-port=18642 --mon-port=12799 --ic-port=23492
2025-11-01 16:24:44,673 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/drlt/00162f/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/kikimr_configs"
2025-11-01 16:24:44,673 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/drlt/00162f/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:18089 --tenant=/Root/users/database --log-file-name=/home/runner/.ya/build/build_root/drlt/00162f/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/slot_1/logfile_vmj11llj.log --grpc-port=18642 --mon-port=12799 --ic-port=23492
2025-11-01 16:24:44,673 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/drlt/00162f/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/drlt/00162f/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/kikimr_configs/config.yaml', '--node-broker=localhost:18089', '--tenant=/Root/users/database', '--log-file-name=/home/runner/.ya/build/build_root/drlt/00162f/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/slot_1/logfile_vmj11llj.log', '--grpc-port=18642', '--mon-port=12799', '--ic-port=23492')' in '/home/runner/.ya/build/build_root/drlt/00162f/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/slot_1' (no wait)
2025-11-01 16:24:44,674 - DEBUG - ya.test - execute: Command pid: 1448249
2025-11-01 16:24:44,675 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:18642/1
2025-11-01 16:24:44,676 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.33
2025-11-01 16:24:44,676 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.33
2025-11-01 16:24:44,677 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/drlt/00162f/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 16:24:44,677 - DEBUG - ya.test - execute: Command pid: 1448250
2025-11-01 16:24:45,104 - DEBUG - ya.test - _save_outputs: Command (pid 1448250) rc: 0
2025-11-01 16:24:45,104 - DEBUG - ya.test - _save_outputs: Command (pid 1448250) elapsed time (sec): 0.4254324436187744
2025-11-01 16:24:45,104 - DEBUG - ya.test - _save_outputs: Command (pid 1448250) idrss: 0
2025-11-01 16:24:45,104 - DEBUG - ya.test - _save_outputs: Command (pid 1448250) inblock: 0
2025-11-01 16:24:45,105 - DEBUG - ya.test - _save_outputs: Command (pid 1448250) isrss: 0
2025-11-01 16:24:45,105 - DEBUG - ya.test - _save_outputs: Command (pid 1448250) ixrss: 0
2025-11-01 16:24:45,105 - DEBUG - ya.test - _save_outputs: Command (pid 1448250) majflt: 0
2025-11-01 16:24:45,106 - DEBUG - ya.test - _save_outputs: Command (pid 1448250) maxrss: 538524
2025-11-01 16:24:45,106 - DEBUG - ya.test - _save_outputs: Command (pid 1448250) minflt: 16130
2025-11-01 16:24:45,106 - DEBUG - ya.test - _save_outputs: Command (pid 1448250) msgrcv: 0
2025-11-01 16:24:45,106 - DEBUG - ya.test - _save_outputs: Command (pid 1448250) msgsnd: 0
2025-11-01 16:24:45,106 - DEBUG - ya.test - _save_outputs: Command (pid 1448250) nivcsw: 6
2025-11-01 16:24:45,106 - DEBUG - ya.test - _save_outputs: Command (pid 1448250) nsignals: 0
2025-11-01 16:24:45,107 - DEBUG - ya.test - _save_outputs: Command (pid 1448250) nswap: 0
2025-11-01 16:24:45,107 - DEBUG - ya.test - _save_outputs: Command (pid 1448250) nvcsw: 13
2025-11-01 16:24:45,107 - DEBUG - ya.test - _save_outputs: Command (pid 1448250) oublock: 8
2025-11-01 16:24:45,107 - DEBUG - ya.test - _save_outputs: Command (pid 1448250) stime: 0.267777
2025-11-01 16:24:45,107 - DEBUG - ya.test - _save_outputs: Command (pid 1448250) utime: 0.109535
2025-11-01 16:24:45,107 - DEBUG - ya.test - _save_outputs: Command (pid 1448250) wtime: 0.426
2025-11-01 16:24:45,108 - DEBUG - ya.test - _save_outputs: Command (pid 1448250) output:
Git info:
    Commit: b759454d1e40b275ba8b2f5964202fc9f08a1c3c
    Branch: 
    Author: Denis Khalikov <dennis.khalikov@gmail.com>
    Summary: Merge b3001557f326a9ac3df9852d3eea5c83a6651a93 into 88f362bbf1115d2653ecf70400035099c5165741

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

    
Build info:
    Compiler: /home/runner/.ya/tools/v4/9944335923/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9944335923/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -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-01 16:24:45,108 - DEBUG - ya.test - _save_outputs: Command (pid 1448250) errors:

2025-11-01 16:24:45,108 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: b759454d1e40b275ba8b2f5964202fc9f08a1c3c
    Branch: 
    Author: Denis Khalikov <dennis.khalikov@gmail.com>
    Summary: Merge b3001557f326a9ac3df9852d3eea5c83a6651a93 into 88f362bbf1115d2653ecf70400035099c5165741
2025-11-01 16:24:45,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-01 16:24:45,111 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 16:24:45,112 - 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-01 16:24:45,113 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: create table one
2025-11-01 16:24:45,116 - DEBUG - ydb.table.SessionPool - subscribe: Active session queue is empty, subscribe waiter for a session
2025-11-01 16:24:45,117 - DEBUG - ydb.table.SessionPool - subscribe: Subscribe waiter <Future at 0x7fd49f1b01f0 state=pending>
2025-11-01 16:24:45,118 - DEBUG - ydb.table.SessionPool - subscribe: Session pool is not large enough (active_count < size: 0 < 1). will create a new session.
2025-11-01 16:24:45,118 - DEBUG - ydb.table.SessionPool - _create: Created session <ydb.table.Session object at 0x7fd49f1b0e20>
2025-11-01 16:24:45,119 - DEBUG - ydb.table.SessionPool - _prepare: Preparing session <ydb.table.Session object at 0x7fd49f1b0e20>
2025-11-01 16:24:45,120 - ERROR - ydb.table.SessionPool - _on_session_create: Failed to create session. Put event to a delayed queue. Reason: Couldn't find valid connection
2025-11-01 16:24:45,120 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/users/database
2025-11-01 16:24:45,121 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 3938ec82-5fed-4739-b93d-26b9c7fe246e, localhost:18089): creating call state
2025-11-01 16:24:45,122 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 3938ec82-5fed-4739-b93d-26b9c7fe246e, localhost:18089): request = { database: "/Root/users/database" }
2025-11-01 16:24:45,124 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 3938ec82-5fed-4739-b93d-26b9c7fe246e, localhost:18089): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-11-01 16:24:45,125 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root/users/database. Endpoint: "localhost:18089". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-11-01 16:24:45,125 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:18089
2025-11-01 16:24:46,729 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 16:24:46,729 - 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-01 16:24:46,736 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/users/database
2025-11-01 16:24:46,736 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 30ac0d78-ce62-422f-b37b-a3789901770a, localhost:18089): creating call state
2025-11-01 16:24:46,737 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 30ac0d78-ce62-422f-b37b-a3789901770a, localhost:18089): request = { database: "/Root/users/database" }
2025-11-01 16:24:46,740 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 30ac0d78-ce62-422f-b37b-a3789901770a, localhost:18089): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-wicuw7bjty.auto.internal" port: 18642 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" node_id: 50000 } self_location: "1" } } } }
2025-11-01 16:24:46,740 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root/users/database: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-wicuw7bjty.auto.internal:18642, location , ssl: False>]>
2025-11-01 16:24:46,741 - 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-01 16:24:46,748 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:18089
2025-11-01 16:24:46,748 - DEBUG - ydb.table.SessionPool - _prepare: Preparing session <ydb.table.Session object at 0x7fd49f1b0e20>
2025-11-01 16:24:46,749 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 903c2135-9d78-4f0f-a724-7895102572ae, ghrun-wicuw7bjty.auto.internal:18642): creating call state
2025-11-01 16:24:46,750 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 903c2135-9d78-4f0f-a724-7895102572ae, ghrun-wicuw7bjty.auto.internal:18642): request = { operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-11-01 16:24:46,752 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, 903c2135-9d78-4f0f-a724-7895102572ae, ghrun-wicuw7bjty.auto.internal:18642): on response callback started
2025-11-01 16:24:46,753 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 903c2135-9d78-4f0f-a724-7895102572ae, ghrun-wicuw7bjty.auto.internal:18642): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=50000&id=NDFmM2VhZDctYjE1MzZkYzgtZGQ2ZTVhNDMtMTAwMTY4NmI=" } } } }
2025-11-01 16:24:46,753 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fd49f1b0e20>
2025-11-01 16:24:46,753 - DEBUG - ydb.table.SessionPool - put: Replying to waiter with a session <ydb.table.Session object at 0x7fd49f1b0e20>
2025-11-01 16:24:46,754 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, 903c2135-9d78-4f0f-a724-7895102572ae, ghrun-wicuw7bjty.auto.internal:18642): on response callback success
2025-11-01 16:24:46,754 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 01465c30-4a87-46bf-afae-fa545cbc77f1, ghrun-wicuw7bjty.auto.internal:18642): creating call state
2025-11-01 16:24:46,755 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 01465c30-4a87-46bf-afae-fa545cbc77f1, ghrun-wicuw7bjty.auto.internal:18642): request = { session_id: "ydb://session/3?node_id=50000&id=NDFmM2VhZDctYjE1MzZkYzgtZGQ2ZTVhNDMtMTAwMTY4NmI=" path: "/Root/users/database/table" columns { name: "id" type { optional_type { item { type_id: UINT64 } } } } columns { name: "value" type { optional_type { item { type_id: UTF8 } } } } primary_key: "id" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:24:46,804 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 01465c30-4a87-46bf-afae-fa545cbc77f1, ghrun-wicuw7bjty.auto.internal:18642): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:24:46,804 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fd49f1b0e20>
2025-11-01 16:24:46,804 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: create table two
2025-11-01 16:24:46,805 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, fd670420-1e24-4a1d-9feb-82cc127f1cce, ghrun-wicuw7bjty.auto.internal:18642): creating call state
2025-11-01 16:24:46,806 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, fd670420-1e24-4a1d-9feb-82cc127f1cce, ghrun-wicuw7bjty.auto.internal:18642): request = { session_id: "ydb://session/3?node_id=50000&id=NDFmM2VhZDctYjE1MzZkYzgtZGQ2ZTVhNDMtMTAwMTY4NmI=" path: "/Root/users/database/table_for_rm" columns { name: "id" type { optional_type { item { type_id: UINT64 } } } } columns { name: "value" type { optional_type { item { type_id: UTF8 } } } } primary_key: "id" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:24:46,832 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, fd670420-1e24-4a1d-9feb-82cc127f1cce, ghrun-wicuw7bjty.auto.internal:18642): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:24:46,832 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fd49f1b0e20>
2025-11-01 16:24:46,832 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: write_some_data
2025-11-01 16:24:46,833 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, b004888b-1a17-41c0-8e16-25e3b4992e36, ghrun-wicuw7bjty.auto.internal:18642): creating call state
2025-11-01 16:24:46,834 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, b004888b-1a17-41c0-8e16-25e3b4992e36, ghrun-wicuw7bjty.auto.internal:18642): request = { session_id: "ydb://session/3?node_id=50000&id=NDFmM2VhZDctYjE1MzZkYzgtZGQ2ZTVhNDMtMTAwMTY4NmI=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "\n                        upsert into table (id, value)\n                        values (1u, \"/Root/users/database_0\");\n                        upsert into table_for_rm (id, value)\n                        values (2u, \"/Root/users/database_0\");\n                        " } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:24:46,858 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, b004888b-1a17-41c0-8e16-25e3b4992e36, ghrun-wicuw7bjty.auto.internal:18642): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-11-01 16:24:46,858 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fd49f1b0e20>
2025-11-01 16:24:46,858 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: read_some_data
2025-11-01 16:24:46,859 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 2732fe3d-ac6c-432a-9f1f-ddb2681b3fb6, ghrun-wicuw7bjty.auto.internal:18642): creating call state
2025-11-01 16:24:46,860 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 2732fe3d-ac6c-432a-9f1f-ddb2681b3fb6, ghrun-wicuw7bjty.auto.internal:18642): request = { session_id: "ydb://session/3?node_id=50000&id=NDFmM2VhZDctYjE1MzZkYzgtZGQ2ZTVhNDMtMTAwMTY4NmI=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "\n                        select id, value FROM table;\n                        select id, value FROM table_for_rm;\n                        " } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:24:46,891 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 2732fe3d-ac6c-432a-9f1f-ddb2681b3fb6, ghrun-wicuw7bjty.auto.internal:18642): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { result_sets { columns { name: "id" type { optional_type { item { type_id: UINT64 } } } } columns { name: "value" type { optional_type { item { type_id: UTF8 } } } } rows { items { uint64_value: 1 } items { text_value: "/Root/users/database_0" } } format: FORMAT_VALUE } result_sets { columns { name: "id" type { optional_type { item { type_id: UINT64 } } } } columns { name: "value" type { optional_type { item { type_id: UTF8 } } } } rows { items { uint64_value: 2 } items { text_value: "/Root/users/database_0" } } format: FORMAT_VALUE } tx_meta { } } } } }
2025-11-01 16:24:46,892 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fd49f1b0e20>
2025-11-01 16:24:46,892 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: drop table two
2025-11-01 16:24:46,893 - DEBUG - ydb.connection - _prepare_call: RpcState(DropTable, 3339f585-06e4-4b67-81fe-d6ff35647cfb, ghrun-wicuw7bjty.auto.internal:18642): creating call state
2025-11-01 16:24:46,893 - DEBUG - ydb.connection - _log_request: RpcState(DropTable, 3339f585-06e4-4b67-81fe-d6ff35647cfb, ghrun-wicuw7bjty.auto.internal:18642): request = { session_id: "ydb://session/3?node_id=50000&id=NDFmM2VhZDctYjE1MzZkYzgtZGQ2ZTVhNDMtMTAwMTY4NmI=" path: "/Root/users/database/table_for_rm" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:24:46,908 - DEBUG - ydb.connection - _log_response: RpcState(DropTable, 3339f585-06e4-4b67-81fe-d6ff35647cfb, ghrun-wicuw7bjty.auto.internal:18642): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:24:46,908 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fd49f1b0e20>
2025-11-01 16:24:46,908 - DEBUG - ydb.table.SessionPool - stop: Requested session pool stop.
2025-11-01 16:24:46,909 - DEBUG - ydb.table.SessionPool - stop: Session pool is under stop, cancelling all in flight waiters.
2025-11-01 16:24:46,909 - DEBUG - ydb.table.SessionPool - stop: Destroying sessions in active queue
2025-11-01 16:24:46,909 - DEBUG - ydb.table.SessionPool - _destroy: Requested session destroy: <ydb.table.Session object at 0x7fd49f1b0e20>, reason: session-pool-terminated
2025-11-01 16:24:46,909 - DEBUG - ydb.table.SessionPool - _terminate_event: Terminated session pool.
2025-11-01 16:24:46,910 - DEBUG - ydb.table.SessionPool - _destroy: Session <ydb.table.Session object at 0x7fd49f1b0e20> is no longer active. Current active count 0.
2025-11-01 16:24:46,910 - DEBUG - ydb.connection - _prepare_call: RpcState(DeleteSession, f3a42857-e485-4a4f-af3a-fa167b3536a6, ghrun-wicuw7bjty.auto.internal:18642): creating call state
2025-11-01 16:24:46,911 - DEBUG - ydb.connection - _log_request: RpcState(DeleteSession, f3a42857-e485-4a4f-af3a-fa167b3536a6, ghrun-wicuw7bjty.auto.internal:18642): request = { session_id: "ydb://session/3?node_id=50000&id=NDFmM2VhZDctYjE1MzZkYzgtZGQ2ZTVhNDMtMTAwMTY4NmI=" operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-11-01 16:24:46,912 - DEBUG - ydb.table.SessionPool - _destroy: Sent delete on session <ydb.table.Session object at 0x7fd49f1b0e20>
2025-11-01 16:24:46,912 - DEBUG - ydb.table.SessionPool - stop: Destroyed active sessions
2025-11-01 16:24:46,912 - DEBUG - ydb.topic - close: Close topic client
2025-11-01 16:24:46,913 - DEBUG - ydb.topic - close: Topic client was closed
2025-11-01 16:24:46,913 - DEBUG - ydb.connection - _on_response_callback: RpcState(DeleteSession, f3a42857-e485-4a4f-af3a-fa167b3536a6, ghrun-wicuw7bjty.auto.internal:18642): on response callback started
2025-11-01 16:24:46,913 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:18089
2025-11-01 16:24:46,914 - DEBUG - ydb.connection - _log_response: RpcState(DeleteSession, f3a42857-e485-4a4f-af3a-fa167b3536a6, ghrun-wicuw7bjty.auto.internal:18642): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:24:46,915 - DEBUG - ydb.connection - _on_response_callback: RpcState(DeleteSession, f3a42857-e485-4a4f-af3a-fa167b3536a6, ghrun-wicuw7bjty.auto.internal:18642): on response callback success
2025-11-01 16:24:46,938 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-wicuw7bjty.auto.internal:18642
2025-11-01 16:24:46,950 - INFO - ydb.pool.Discovery - run: Successfully terminated discovery process
2025-11-01 16:24:46,951 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: remove_database
2025-11-01 16:24:46,952 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - remove_database: /Root/users/database
2025-11-01 16:24:46,952 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_send_op: /Root/users/database: send console operation, token None
2025-11-01 16:24:46,957 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_send_op: /Root/users/database: response from console: RemoveTenantResponse {
  Response {
    operation {
      id: "ydb://cmsrequest/5?tenant=/Root/users/database&cmstid=72057594037936131&txid=1762014286955253&action=2"
    }
  }
}
Status {
  Code: STATUS_CODE_UNSPECIFIED
}

2025-11-01 16:24:46,957 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/users/database: wait console operation done
2025-11-01 16:24:47,461 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/users/database: console operation done
2025-11-01 16:24:47,461 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/users/database: wait tenant gone
2025-11-01 16:24:47,464 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/users/database: tenant gone
2025-11-01 16:24:48,465 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:18642/1
2025-11-01 16:24:48,465 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: done 0
2025-11-01 16:24:48,466 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: create_database
2025-11-01 16:24:48,978 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/drlt/00162f/ydb/apps/ydbd/ydbd
2025-11-01 16:24:48,978 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/18183
2025-11-01 16:24:48,979 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/30590
2025-11-01 16:24:48,979 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/24021
2025-11-01 16:24:48,980 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/30210
2025-11-01 16:24:48,980 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/27298
2025-11-01 16:24:48,980 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/drlt/00162f/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/kikimr_configs"
2025-11-01 16:24:48,981 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/drlt/00162f/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:18089 --tenant=/Root/users/database --log-file-name=/home/runner/.ya/build/build_root/drlt/00162f/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/slot_2/logfile_m3jw7kji.log --grpc-port=18183 --mon-port=30590 --ic-port=24021
2025-11-01 16:24:48,981 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/drlt/00162f/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/kikimr_configs"
2025-11-01 16:24:48,981 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/drlt/00162f/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:18089 --tenant=/Root/users/database --log-file-name=/home/runner/.ya/build/build_root/drlt/00162f/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/slot_2/logfile_m3jw7kji.log --grpc-port=18183 --mon-port=30590 --ic-port=24021
2025-11-01 16:24:48,982 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/drlt/00162f/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/drlt/00162f/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/kikimr_configs/config.yaml', '--node-broker=localhost:18089', '--tenant=/Root/users/database', '--log-file-name=/home/runner/.ya/build/build_root/drlt/00162f/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/slot_2/logfile_m3jw7kji.log', '--grpc-port=18183', '--mon-port=30590', '--ic-port=24021')' in '/home/runner/.ya/build/build_root/drlt/00162f/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/slot_2' (no wait)
2025-11-01 16:24:48,983 - DEBUG - ya.test - execute: Command pid: 1449414
2025-11-01 16:24:48,984 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:18183/2
2025-11-01 16:24:48,985 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.34
2025-11-01 16:24:48,985 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.34
2025-11-01 16:24:48,986 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/drlt/00162f/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 16:24:48,986 - DEBUG - ya.test - execute: Command pid: 1449415
2025-11-01 16:24:49,386 - DEBUG - ya.test - _save_outputs: Command (pid 1449415) rc: 0
2025-11-01 16:24:49,386 - DEBUG - ya.test - _save_outputs: Command (pid 1449415) elapsed time (sec): 0.39850521087646484
2025-11-01 16:24:49,386 - DEBUG - ya.test - _save_outputs: Command (pid 1449415) idrss: 0
2025-11-01 16:24:49,386 - DEBUG - ya.test - _save_outputs: Command (pid 1449415) inblock: 0
2025-11-01 16:24:49,387 - DEBUG - ya.test - _save_outputs: Command (pid 1449415) isrss: 0
2025-11-01 16:24:49,387 - DEBUG - ya.test - _save_outputs: Command (pid 1449415) ixrss: 0
2025-11-01 16:24:49,387 - DEBUG - ya.test - _save_outputs: Command (pid 1449415) majflt: 0
2025-11-01 16:24:49,387 - DEBUG - ya.test - _save_outputs: Command (pid 1449415) maxrss: 538524
2025-11-01 16:24:49,387 - DEBUG - ya.test - _save_outputs: Command (pid 1449415) minflt: 16127
2025-11-01 16:24:49,387 - DEBUG - ya.test - _save_outputs: Command (pid 1449415) msgrcv: 0
2025-11-01 16:24:49,388 - DEBUG - ya.test - _save_outputs: Command (pid 1449415) msgsnd: 0
2025-11-01 16:24:49,388 - DEBUG - ya.test - _save_outputs: Command (pid 1449415) nivcsw: 27
2025-11-01 16:24:49,388 - DEBUG - ya.test - _save_outputs: Command (pid 1449415) nsignals: 0
2025-11-01 16:24:49,388 - DEBUG - ya.test - _save_outputs: Command (pid 1449415) nswap: 0
2025-11-01 16:24:49,389 - DEBUG - ya.test - _save_outputs: Command (pid 1449415) nvcsw: 12
2025-11-01 16:24:49,389 - DEBUG - ya.test - _save_outputs: Command (pid 1449415) oublock: 8
2025-11-01 16:24:49,389 - DEBUG - ya.test - _save_outputs: Command (pid 1449415) stime: 0.253683
2025-11-01 16:24:49,390 - DEBUG - ya.test - _save_outputs: Command (pid 1449415) utime: 0.096174
2025-11-01 16:24:49,390 - DEBUG - ya.test - _save_outputs: Command (pid 1449415) wtime: 0.399
2025-11-01 16:24:49,390 - DEBUG - ya.test - _save_outputs: Command (pid 1449415) output:
Git info:
    Commit: b759454d1e40b275ba8b2f5964202fc9f08a1c3c
    Branch: 
    Author: Denis Khalikov <dennis.khalikov@gmail.com>
    Summary: Merge b3001557f326a9ac3df9852d3eea5c83a6651a93 into 88f362bbf1115d2653ecf70400035099c5165741

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

    
Build info:
    Compiler: /home/runner/.ya/tools/v4/9944335923/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9944335923/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -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-01 16:24:49,391 - DEBUG - ya.test - _save_outputs: Command (pid 1449415) errors:

2025-11-01 16:24:49,392 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 2 version:
Git info:
    Commit: b759454d1e40b275ba8b2f5964202fc9f08a1c3c
    Branch: 
    Author: Denis Khalikov <dennis.khalikov@gmail.com>
    Summary: Merge b3001557f326a9ac3df9852d3eea5c83a6651a93 into 88f362bbf1115d2653ecf70400035099c5165741
2025-11-01 16:24:49,392 - 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-01 16:24:49,394 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 16:24:49,395 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: create table one
2025-11-01 16:24:49,396 - 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-01 16:24:49,396 - DEBUG - ydb.table.SessionPool - subscribe: Active session queue is empty, subscribe waiter for a session
2025-11-01 16:24:49,400 - DEBUG - ydb.table.SessionPool - subscribe: Subscribe waiter <Future at 0x7fd49da3aae0 state=pending>
2025-11-01 16:24:49,401 - DEBUG - ydb.table.SessionPool - subscribe: Session pool is not large enough (active_count < size: 0 < 1). will create a new session.
2025-11-01 16:24:49,402 - DEBUG - ydb.table.SessionPool - _create: Created session <ydb.table.Session object at 0x7fd49da3ae50>
2025-11-01 16:24:49,403 - DEBUG - ydb.table.SessionPool - _prepare: Preparing session <ydb.table.Session object at 0x7fd49da3ae50>
2025-11-01 16:24:49,404 - ERROR - ydb.table.SessionPool - _on_session_create: Failed to create session. Put event to a delayed queue. Reason: Couldn't find valid connection
2025-11-01 16:24:49,404 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/users/database
2025-11-01 16:24:49,405 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 5a0db714-1bed-4c67-87d3-759cbfa567e2, localhost:18089): creating call state
2025-11-01 16:24:49,406 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 5a0db714-1bed-4c67-87d3-759cbfa567e2, localhost:18089): request = { database: "/Root/users/database" }
2025-11-01 16:24:49,408 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 5a0db714-1bed-4c67-87d3-759cbfa567e2, localhost:18089): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-11-01 16:24:49,409 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root/users/database. Endpoint: "localhost:18089". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-11-01 16:24:49,409 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:18089
2025-11-01 16:24:51,491 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 16:24:51,492 - 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-01 16:24:51,497 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/users/database
2025-11-01 16:24:51,497 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 46e5972f-afdc-47f6-a21b-3c6420668f8c, localhost:18089): creating call state
2025-11-01 16:24:51,498 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 46e5972f-afdc-47f6-a21b-3c6420668f8c, localhost:18089): request = { database: "/Root/users/database" }
2025-11-01 16:24:51,500 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 46e5972f-afdc-47f6-a21b-3c6420668f8c, localhost:18089): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-wicuw7bjty.auto.internal" port: 18183 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" node_id: 50001 } self_location: "1" } } } }
2025-11-01 16:24:51,501 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root/users/database: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-wicuw7bjty.auto.internal:18183, location , ssl: False>]>
2025-11-01 16:24:51,501 - 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-01 16:24:51,510 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:18089
2025-11-01 16:24:51,510 - DEBUG - ydb.table.SessionPool - _prepare: Preparing session <ydb.table.Session object at 0x7fd49da3ae50>
2025-11-01 16:24:51,511 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 78385c75-d571-4938-87e1-0ae1555f5c55, ghrun-wicuw7bjty.auto.internal:18183): creating call state
2025-11-01 16:24:51,512 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 78385c75-d571-4938-87e1-0ae1555f5c55, ghrun-wicuw7bjty.auto.internal:18183): request = { operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-11-01 16:24:51,514 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, 78385c75-d571-4938-87e1-0ae1555f5c55, ghrun-wicuw7bjty.auto.internal:18183): on response callback started
2025-11-01 16:24:51,515 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 78385c75-d571-4938-87e1-0ae1555f5c55, ghrun-wicuw7bjty.auto.internal:18183): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=50001&id=NmIyNGQ3OTAtMzg4Mjg5ZjItNGI4Nzk1YjMtMTA3MTQzYjI=" } } } }
2025-11-01 16:24:51,516 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fd49da3ae50>
2025-11-01 16:24:51,516 - DEBUG - ydb.table.SessionPool - put: Replying to waiter with a session <ydb.table.Session object at 0x7fd49da3ae50>
2025-11-01 16:24:51,516 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, 78385c75-d571-4938-87e1-0ae1555f5c55, ghrun-wicuw7bjty.auto.internal:18183): on response callback success
2025-11-01 16:24:51,517 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, fa9a9674-52bb-4570-bb1c-36f2ee33cf9d, ghrun-wicuw7bjty.auto.internal:18183): creating call state
2025-11-01 16:24:51,517 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, fa9a9674-52bb-4570-bb1c-36f2ee33cf9d, ghrun-wicuw7bjty.auto.internal:18183): request = { session_id: "ydb://session/3?node_id=50001&id=NmIyNGQ3OTAtMzg4Mjg5ZjItNGI4Nzk1YjMtMTA3MTQzYjI=" path: "/Root/users/database/table" columns { name: "id" type { optional_type { item { type_id: UINT64 } } } } columns { name: "value" type { optional_type { item { type_id: UTF8 } } } } primary_key: "id" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:24:51,553 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, fa9a9674-52bb-4570-bb1c-36f2ee33cf9d, ghrun-wicuw7bjty.auto.internal:18183): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:24:51,553 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fd49da3ae50>
2025-11-01 16:24:51,554 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: create table two
2025-11-01 16:24:51,554 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 5841d4fc-a05b-4062-8f80-d21e18aaf834, ghrun-wicuw7bjty.auto.internal:18183): creating call state
2025-11-01 16:24:51,555 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 5841d4fc-a05b-4062-8f80-d21e18aaf834, ghrun-wicuw7bjty.auto.internal:18183): request = { session_id: "ydb://session/3?node_id=50001&id=NmIyNGQ3OTAtMzg4Mjg5ZjItNGI4Nzk1YjMtMTA3MTQzYjI=" path: "/Root/users/database/table_for_rm" columns { name: "id" type { optional_type { item { type_id: UINT64 } } } } columns { name: "value" type { optional_type { item { type_id: UTF8 } } } } primary_key: "id" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:24:51,579 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 5841d4fc-a05b-4062-8f80-d21e18aaf834, ghrun-wicuw7bjty.auto.internal:18183): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:24:51,580 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fd49da3ae50>
2025-11-01 16:24:51,580 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: write_some_data
2025-11-01 16:24:51,581 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 7b5539cb-0ef7-4348-9bb2-8478edce7274, ghrun-wicuw7bjty.auto.internal:18183): creating call state
2025-11-01 16:24:51,582 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 7b5539cb-0ef7-4348-9bb2-8478edce7274, ghrun-wicuw7bjty.auto.internal:18183): request = { session_id: "ydb://session/3?node_id=50001&id=NmIyNGQ3OTAtMzg4Mjg5ZjItNGI4Nzk1YjMtMTA3MTQzYjI=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "\n                        upsert into table (id, value)\n                        values (1u, \"/Root/users/database_1\");\n                        upsert into table_for_rm (id, value)\n                        values (2u, \"/Root/users/database_1\");\n                        " } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:24:51,607 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 7b5539cb-0ef7-4348-9bb2-8478edce7274, ghrun-wicuw7bjty.auto.internal:18183): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-11-01 16:24:51,607 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fd49da3ae50>
2025-11-01 16:24:51,608 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: read_some_data
2025-11-01 16:24:51,608 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, a3a7dc54-a942-4ddf-a9d1-debec4fd121b, ghrun-wicuw7bjty.auto.internal:18183): creating call state
2025-11-01 16:24:51,609 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, a3a7dc54-a942-4ddf-a9d1-debec4fd121b, ghrun-wicuw7bjty.auto.internal:18183): request = { session_id: "ydb://session/3?node_id=50001&id=NmIyNGQ3OTAtMzg4Mjg5ZjItNGI4Nzk1YjMtMTA3MTQzYjI=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "\n                        select id, value FROM table;\n                        select id, value FROM table_for_rm;\n                        " } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:24:51,644 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, a3a7dc54-a942-4ddf-a9d1-debec4fd121b, ghrun-wicuw7bjty.auto.internal:18183): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { result_sets { columns { name: "id" type { optional_type { item { type_id: UINT64 } } } } columns { name: "value" type { optional_type { item { type_id: UTF8 } } } } rows { items { uint64_value: 1 } items { text_value: "/Root/users/database_1" } } format: FORMAT_VALUE } result_sets { columns { name: "id" type { optional_type { item { type_id: UINT64 } } } } columns { name: "value" type { optional_type { item { type_id: UTF8 } } } } rows { items { uint64_value: 2 } items { text_value: "/Root/users/database_1" } } format: FORMAT_VALUE } tx_meta { } } } } }
2025-11-01 16:24:51,645 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fd49da3ae50>
2025-11-01 16:24:51,646 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: drop table two
2025-11-01 16:24:51,646 - DEBUG - ydb.connection - _prepare_call: RpcState(DropTable, 1569dfe8-e549-45b2-b864-3f1ada63e0e5, ghrun-wicuw7bjty.auto.internal:18183): creating call state
2025-11-01 16:24:51,648 - DEBUG - ydb.connection - _log_request: RpcState(DropTable, 1569dfe8-e549-45b2-b864-3f1ada63e0e5, ghrun-wicuw7bjty.auto.internal:18183): request = { session_id: "ydb://session/3?node_id=50001&id=NmIyNGQ3OTAtMzg4Mjg5ZjItNGI4Nzk1YjMtMTA3MTQzYjI=" path: "/Root/users/database/table_for_rm" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:24:51,664 - DEBUG - ydb.connection - _log_response: RpcState(DropTable, 1569dfe8-e549-45b2-b864-3f1ada63e0e5, ghrun-wicuw7bjty.auto.internal:18183): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:24:51,664 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fd49da3ae50>
2025-11-01 16:24:51,664 - DEBUG - ydb.table.SessionPool - stop: Requested session pool stop.
2025-11-01 16:24:51,665 - DEBUG - ydb.table.SessionPool - stop: Session pool is under stop, cancelling all in flight waiters.
2025-11-01 16:24:51,665 - DEBUG - ydb.table.SessionPool - _terminate_event: Terminated session pool.
2025-11-01 16:24:51,665 - DEBUG - ydb.table.SessionPool - stop: Destroying sessions in active queue
2025-11-01 16:24:51,666 - DEBUG - ydb.table.SessionPool - _destroy: Requested session destroy: <ydb.table.Session object at 0x7fd49da3ae50>, reason: session-pool-terminated
2025-11-01 16:24:51,666 - DEBUG - ydb.table.SessionPool - _destroy: Session <ydb.table.Session object at 0x7fd49da3ae50> is no longer active. Current active count 0.
2025-11-01 16:24:51,666 - DEBUG - ydb.connection - _prepare_call: RpcState(DeleteSession, 54d2e3d6-3e54-48cd-a8e1-c466a0c36bd0, ghrun-wicuw7bjty.auto.internal:18183): creating call state
2025-11-01 16:24:51,667 - DEBUG - ydb.connection - _log_request: RpcState(DeleteSession, 54d2e3d6-3e54-48cd-a8e1-c466a0c36bd0, ghrun-wicuw7bjty.auto.internal:18183): request = { session_id: "ydb://session/3?node_id=50001&id=NmIyNGQ3OTAtMzg4Mjg5ZjItNGI4Nzk1YjMtMTA3MTQzYjI=" operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-11-01 16:24:51,668 - DEBUG - ydb.table.SessionPool - _destroy: Sent delete on session <ydb.table.Session object at 0x7fd49da3ae50>
2025-11-01 16:24:51,669 - DEBUG - ydb.table.SessionPool - stop: Destroyed active sessions
2025-11-01 16:24:51,669 - DEBUG - ydb.connection - _on_response_callback: RpcState(DeleteSession, 54d2e3d6-3e54-48cd-a8e1-c466a0c36bd0, ghrun-wicuw7bjty.auto.internal:18183): on response callback started
2025-11-01 16:24:51,669 - DEBUG - ydb.topic - close: Close topic client
2025-11-01 16:24:51,670 - DEBUG - ydb.connection - _log_response: RpcState(DeleteSession, 54d2e3d6-3e54-48cd-a8e1-c466a0c36bd0, ghrun-wicuw7bjty.auto.internal:18183): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:24:51,670 - DEBUG - ydb.topic - close: Topic client was closed
2025-11-01 16:24:51,670 - DEBUG - ydb.connection - _on_response_callback: RpcState(DeleteSession, 54d2e3d6-3e54-48cd-a8e1-c466a0c36bd0, ghrun-wicuw7bjty.auto.internal:18183): on response callback success
2025-11-01 16:24:51,671 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:18089
2025-11-01 16:24:51,700 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-wicuw7bjty.auto.internal:18183
2025-11-01 16:24:51,714 - INFO - ydb.pool.Discovery - run: Successfully terminated discovery process
2025-11-01 16:24:51,714 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: remove_database
2025-11-01 16:24:51,715 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - remove_database: /Root/users/database
2025-11-01 16:24:51,715 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_send_op: /Root/users/database: send console operation, token None
2025-11-01 16:24:51,720 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_send_op: /Root/users/database: response from console: RemoveTenantResponse {
  Response {
    operation {
      id: "ydb://cmsrequest/5?tenant=/Root/users/database&cmstid=72057594037936131&txid=1762014291718127&action=2"
    }
  }
}
Status {
  Code: STATUS_CODE_UNSPECIFIED
}

2025-11-01 16:24:51,720 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/users/database: wait console operation done
2025-11-01 16:24:52,223 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/users/database: console operation done
2025-11-01 16:24:52,224 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/users/database: wait tenant gone
2025-11-01 16:24:52,226 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/users/database: tenant gone
2025-11-01 16:24:53,227 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:18183/2
2025-11-01 16:24:53,227 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: done 1
2025-11-01 16:24:53,227 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: create_database
2025-11-01 16:24:53,739 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/drlt/00162f/ydb/apps/ydbd/ydbd
2025-11-01 16:24:53,740 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/27332
2025-11-01 16:24:53,740 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/18046
2025-11-01 16:24:53,740 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/18178
2025-11-01 16:24:53,741 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/25657
2025-11-01 16:24:53,741 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/32059
2025-11-01 16:24:53,742 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/drlt/00162f/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/kikimr_configs"
2025-11-01 16:24:53,743 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/drlt/00162f/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:18089 --tenant=/Root/users/database --log-file-name=/home/runner/.ya/build/build_root/drlt/00162f/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/slot_3/logfile_8z_ea9az.log --grpc-port=27332 --mon-port=18046 --ic-port=18178
2025-11-01 16:24:53,743 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/drlt/00162f/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/kikimr_configs"
2025-11-01 16:24:53,743 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/drlt/00162f/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:18089 --tenant=/Root/users/database --log-file-name=/home/runner/.ya/build/build_root/drlt/00162f/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/slot_3/logfile_8z_ea9az.log --grpc-port=27332 --mon-port=18046 --ic-port=18178
2025-11-01 16:24:53,744 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/drlt/00162f/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/drlt/00162f/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/kikimr_configs/config.yaml', '--node-broker=localhost:18089', '--tenant=/Root/users/database', '--log-file-name=/home/runner/.ya/build/build_root/drlt/00162f/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/slot_3/logfile_8z_ea9az.log', '--grpc-port=27332', '--mon-port=18046', '--ic-port=18178')' in '/home/runner/.ya/build/build_root/drlt/00162f/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/slot_3' (no wait)
2025-11-01 16:24:53,745 - DEBUG - ya.test - execute: Command pid: 1450622
2025-11-01 16:24:53,746 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:27332/3
2025-11-01 16:24:53,747 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.35
2025-11-01 16:24:53,748 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.35
2025-11-01 16:24:53,748 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/drlt/00162f/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 16:24:53,749 - DEBUG - ya.test - execute: Command pid: 1450623
2025-11-01 16:24:54,152 - DEBUG - ya.test - _save_outputs: Command (pid 1450623) rc: 0
2025-11-01 16:24:54,153 - DEBUG - ya.test - _save_outputs: Command (pid 1450623) elapsed time (sec): 0.4022200107574463
2025-11-01 16:24:54,153 - DEBUG - ya.test - _save_outputs: Command (pid 1450623) idrss: 0
2025-11-01 16:24:54,153 - DEBUG - ya.test - _save_outputs: Command (pid 1450623) inblock: 0
2025-11-01 16:24:54,153 - DEBUG - ya.test - _save_outputs: Command (pid 1450623) isrss: 0
2025-11-01 16:24:54,153 - DEBUG - ya.test - _save_outputs: Command (pid 1450623) ixrss: 0
2025-11-01 16:24:54,153 - DEBUG - ya.test - _save_outputs: Command (pid 1450623) majflt: 0
2025-11-01 16:24:54,154 - DEBUG - ya.test - _save_outputs: Command (pid 1450623) maxrss: 538524
2025-11-01 16:24:54,154 - DEBUG - ya.test - _save_outputs: Command (pid 1450623) minflt: 19451
2025-11-01 16:24:54,154 - DEBUG - ya.test - _save_outputs: Command (pid 1450623) msgrcv: 0
2025-11-01 16:24:54,154 - DEBUG - ya.test - _save_outputs: Command (pid 1450623) msgsnd: 0
2025-11-01 16:24:54,154 - DEBUG - ya.test - _save_outputs: Command (pid 1450623) nivcsw: 4
2025-11-01 16:24:54,155 - DEBUG - ya.test - _save_outputs: Command (pid 1450623) nsignals: 0
2025-11-01 16:24:54,155 - DEBUG - ya.test - _save_outputs: Command (pid 1450623) nswap: 0
2025-11-01 16:24:54,155 - DEBUG - ya.test - _save_outputs: Command (pid 1450623) nvcsw: 18
2025-11-01 16:24:54,155 - DEBUG - ya.test - _save_outputs: Command (pid 1450623) oublock: 8
2025-11-01 16:24:54,156 - DEBUG - ya.test - _save_outputs: Command (pid 1450623) stime: 0.24428899999999998
2025-11-01 16:24:54,156 - DEBUG - ya.test - _save_outputs: Command (pid 1450623) utime: 0.10993
2025-11-01 16:24:54,157 - DEBUG - ya.test - _save_outputs: Command (pid 1450623) wtime: 0.403
2025-11-01 16:24:54,157 - DEBUG - ya.test - _save_outputs: Command (pid 1450623) output:
Git info:
    Commit: b759454d1e40b275ba8b2f5964202fc9f08a1c3c
    Branch: 
    Author: Denis Khalikov <dennis.khalikov@gmail.com>
    Summary: Merge b3001557f326a9ac3df9852d3eea5c83a6651a93 into 88f362bbf1115d2653ecf70400035099c5165741

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

    
Build info:
    Compiler: /home/runner/.ya/tools/v4/9944335923/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9944335923/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -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-01 16:24:54,158 - DEBUG - ya.test - _save_outputs: Command (pid 1450623) errors:

2025-11-01 16:24:54,158 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 3 version:
Git info:
    Commit: b759454d1e40b275ba8b2f5964202fc9f08a1c3c
    Branch: 
    Author: Denis Khalikov <dennis.khalikov@gmail.com>
    Summary: Merge b3001557f326a9ac3df9852d3eea5c83a6651a93 into 88f362bbf1115d2653ecf70400035099c5165741
2025-11-01 16:24:54,158 - 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-01 16:24:54,160 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 16:24:54,160 - 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-01 16:24:54,161 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: create table one
2025-11-01 16:24:54,164 - DEBUG - ydb.table.SessionPool - subscribe: Active session queue is empty, subscribe waiter for a session
2025-11-01 16:24:54,164 - DEBUG - ydb.table.SessionPool - subscribe: Subscribe waiter <Future at 0x7fd49e3381a0 state=pending>
2025-11-01 16:24:54,165 - DEBUG - ydb.table.SessionPool - subscribe: Session pool is not large enough (active_count < size: 0 < 1). will create a new session.
2025-11-01 16:24:54,165 - DEBUG - ydb.table.SessionPool - _create: Created session <ydb.table.Session object at 0x7fd49e30c920>
2025-11-01 16:24:54,166 - DEBUG - ydb.table.SessionPool - _prepare: Preparing session <ydb.table.Session object at 0x7fd49e30c920>
2025-11-01 16:24:54,166 - ERROR - ydb.table.SessionPool - _on_session_create: Failed to create session. Put event to a delayed queue. Reason: Couldn't find valid connection
2025-11-01 16:24:54,167 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/users/database
2025-11-01 16:24:54,168 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 150391ed-4e22-445d-bfcf-062dcf5ad841, localhost:18089): creating call state
2025-11-01 16:24:54,168 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 150391ed-4e22-445d-bfcf-062dcf5ad841, localhost:18089): request = { database: "/Root/users/database" }
2025-11-01 16:24:54,170 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 150391ed-4e22-445d-bfcf-062dcf5ad841, localhost:18089): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-11-01 16:24:54,170 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root/users/database. Endpoint: "localhost:18089". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-11-01 16:24:54,171 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:18089
2025-11-01 16:24:56,333 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 16:24:56,334 - 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-01 16:24:56,339 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/users/database
2025-11-01 16:24:56,339 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 0b322391-1920-43a4-92e1-166421bc0321, localhost:18089): creating call state
2025-11-01 16:24:56,339 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 0b322391-1920-43a4-92e1-166421bc0321, localhost:18089): request = { database: "/Root/users/database" }
2025-11-01 16:24:56,342 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 0b322391-1920-43a4-92e1-166421bc0321, localhost:18089): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-wicuw7bjty.auto.internal" port: 27332 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" node_id: 50002 } self_location: "1" } } } }
2025-11-01 16:24:56,342 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root/users/database: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-wicuw7bjty.auto.internal:27332, location , ssl: False>]>
2025-11-01 16:24:56,342 - 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-01 16:24:56,349 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:18089
2025-11-01 16:24:56,349 - DEBUG - ydb.table.SessionPool - _prepare: Preparing session <ydb.table.Session object at 0x7fd49e30c920>
2025-11-01 16:24:56,350 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 2b54486e-ff5b-4cf0-8b24-9744350e63ff, ghrun-wicuw7bjty.auto.internal:27332): creating call state
2025-11-01 16:24:56,350 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 2b54486e-ff5b-4cf0-8b24-9744350e63ff, ghrun-wicuw7bjty.auto.internal:27332): request = { operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-11-01 16:24:56,353 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, 2b54486e-ff5b-4cf0-8b24-9744350e63ff, ghrun-wicuw7bjty.auto.internal:27332): on response callback started
2025-11-01 16:24:56,353 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 2b54486e-ff5b-4cf0-8b24-9744350e63ff, ghrun-wicuw7bjty.auto.internal:27332): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=50002&id=MTRlMGE3ZmMtZTg5ZDA2YjctNTc4NzBhM2MtMWE3ZDY2ODI=" } } } }
2025-11-01 16:24:56,354 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fd49e30c920>
2025-11-01 16:24:56,355 - DEBUG - ydb.table.SessionPool - put: Replying to waiter with a session <ydb.table.Session object at 0x7fd49e30c920>
2025-11-01 16:24:56,356 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 26e79c04-3460-4381-92e1-978dc1fb4157, ghrun-wicuw7bjty.auto.internal:27332): creating call state
2025-11-01 16:24:56,356 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, 2b54486e-ff5b-4cf0-8b24-9744350e63ff, ghrun-wicuw7bjty.auto.internal:27332): on response callback success
2025-11-01 16:24:56,357 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 26e79c04-3460-4381-92e1-978dc1fb4157, ghrun-wicuw7bjty.auto.internal:27332): request = { session_id: "ydb://session/3?node_id=50002&id=MTRlMGE3ZmMtZTg5ZDA2YjctNTc4NzBhM2MtMWE3ZDY2ODI=" path: "/Root/users/database/table" columns { name: "id" type { optional_type { item { type_id: UINT64 } } } } columns { name: "value" type { optional_type { item { type_id: UTF8 } } } } primary_key: "id" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:24:56,392 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 26e79c04-3460-4381-92e1-978dc1fb4157, ghrun-wicuw7bjty.auto.internal:27332): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:24:56,393 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fd49e30c920>
2025-11-01 16:24:56,393 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: create table two
2025-11-01 16:24:56,394 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 550f2859-502c-4bae-a55b-82f4a4ef7bbc, ghrun-wicuw7bjty.auto.internal:27332): creating call state
2025-11-01 16:24:56,394 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 550f2859-502c-4bae-a55b-82f4a4ef7bbc, ghrun-wicuw7bjty.auto.internal:27332): request = { session_id: "ydb://session/3?node_id=50002&id=MTRlMGE3ZmMtZTg5ZDA2YjctNTc4NzBhM2MtMWE3ZDY2ODI=" path: "/Root/users/database/table_for_rm" columns { name: "id" type { optional_type { item { type_id: UINT64 } } } } columns { name: "value" type { optional_type { item { type_id: UTF8 } } } } primary_key: "id" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:24:56,420 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 550f2859-502c-4bae-a55b-82f4a4ef7bbc, ghrun-wicuw7bjty.auto.internal:27332): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:24:56,421 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fd49e30c920>
2025-11-01 16:24:56,421 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: write_some_data
2025-11-01 16:24:56,421 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 12172f5c-0479-434d-af00-4d6a75effff2, ghrun-wicuw7bjty.auto.internal:27332): creating call state
2025-11-01 16:24:56,422 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 12172f5c-0479-434d-af00-4d6a75effff2, ghrun-wicuw7bjty.auto.internal:27332): request = { session_id: "ydb://session/3?node_id=50002&id=MTRlMGE3ZmMtZTg5ZDA2YjctNTc4NzBhM2MtMWE3ZDY2ODI=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "\n                        upsert into table (id, value)\n                        values (1u, \"/Root/users/database_2\");\n                        upsert into table_for_rm (id, value)\n                        values (2u, \"/Root/users/database_2\");\n                        " } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:24:56,589 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 12172f5c-0479-434d-af00-4d6a75effff2, ghrun-wicuw7bjty.auto.internal:27332): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-11-01 16:24:56,590 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fd49e30c920>
2025-11-01 16:24:56,590 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: read_some_data
2025-11-01 16:24:56,591 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, bf048309-7437-4b6d-b0bd-c1d6cf8ebfba, ghrun-wicuw7bjty.auto.internal:27332): creating call state
2025-11-01 16:24:56,591 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, bf048309-7437-4b6d-b0bd-c1d6cf8ebfba, ghrun-wicuw7bjty.auto.internal:27332): request = { session_id: "ydb://session/3?node_id=50002&id=MTRlMGE3ZmMtZTg5ZDA2YjctNTc4NzBhM2MtMWE3ZDY2ODI=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "\n                        select id, value FROM table;\n                        select id, value FROM table_for_rm;\n                        " } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:24:56,627 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, bf048309-7437-4b6d-b0bd-c1d6cf8ebfba, ghrun-wicuw7bjty.auto.internal:27332): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { result_sets { columns { name: "id" type { optional_type { item { type_id: UINT64 } } } } columns { name: "value" type { optional_type { item { type_id: UTF8 } } } } rows { items { uint64_value: 1 } items { text_value: "/Root/users/database_2" } } format: FORMAT_VALUE } result_sets { columns { name: "id" type { optional_type { item { type_id: UINT64 } } } } columns { name: "value" type { optional_type { item { type_id: UTF8 } } } } rows { items { uint64_value: 2 } items { text_value: "/Root/users/database_2" } } format: FORMAT_VALUE } tx_meta { } } } } }
2025-11-01 16:24:56,628 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fd49e30c920>
2025-11-01 16:24:56,628 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: drop table two
2025-11-01 16:24:56,628 - DEBUG - ydb.connection - _prepare_call: RpcState(DropTable, c93a5657-7c24-4634-a392-25ec29c91e28, ghrun-wicuw7bjty.auto.internal:27332): creating call state
2025-11-01 16:24:56,629 - DEBUG - ydb.connection - _log_request: RpcState(DropTable, c93a5657-7c24-4634-a392-25ec29c91e28, ghrun-wicuw7bjty.auto.internal:27332): request = { session_id: "ydb://session/3?node_id=50002&id=MTRlMGE3ZmMtZTg5ZDA2YjctNTc4NzBhM2MtMWE3ZDY2ODI=" path: "/Root/users/database/table_for_rm" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:24:56,643 - DEBUG - ydb.connection - _log_response: RpcState(DropTable, c93a5657-7c24-4634-a392-25ec29c91e28, ghrun-wicuw7bjty.auto.internal:27332): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:24:56,644 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fd49e30c920>
2025-11-01 16:24:56,644 - DEBUG - ydb.table.SessionPool - stop: Requested session pool stop.
2025-11-01 16:24:56,645 - DEBUG - ydb.table.SessionPool - stop: Session pool is under stop, cancelling all in flight waiters.
2025-11-01 16:24:56,645 - DEBUG - ydb.table.SessionPool - _terminate_event: Terminated session pool.
2025-11-01 16:24:56,645 - DEBUG - ydb.table.SessionPool - stop: Destroying sessions in active queue
2025-11-01 16:24:56,646 - DEBUG - ydb.table.SessionPool - _destroy: Requested session destroy: <ydb.table.Session object at 0x7fd49e30c920>, reason: session-pool-terminated
2025-11-01 16:24:56,647 - DEBUG - ydb.table.SessionPool - _destroy: Session <ydb.table.Session object at 0x7fd49e30c920> is no longer active. Current active count 0.
2025-11-01 16:24:56,647 - DEBUG - ydb.connection - _prepare_call: RpcState(DeleteSession, 62d82187-c026-47bc-afc3-12a481fc2874, ghrun-wicuw7bjty.auto.internal:27332): creating call state
2025-11-01 16:24:56,648 - DEBUG - ydb.connection - _log_request: RpcState(DeleteSession, 62d82187-c026-47bc-afc3-12a481fc2874, ghrun-wicuw7bjty.auto.internal:27332): request = { session_id: "ydb://session/3?node_id=50002&id=MTRlMGE3ZmMtZTg5ZDA2YjctNTc4NzBhM2MtMWE3ZDY2ODI=" operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-11-01 16:24:56,649 - DEBUG - ydb.table.SessionPool - _destroy: Sent delete on session <ydb.table.Session object at 0x7fd49e30c920>
2025-11-01 16:24:56,649 - DEBUG - ydb.connection - _on_response_callback: RpcState(DeleteSession, 62d82187-c026-47bc-afc3-12a481fc2874, ghrun-wicuw7bjty.auto.internal:27332): on response callback started
2025-11-01 16:24:56,650 - DEBUG - ydb.table.SessionPool - stop: Destroyed active sessions
2025-11-01 16:24:56,650 - DEBUG - ydb.connection - _log_response: RpcState(DeleteSession, 62d82187-c026-47bc-afc3-12a481fc2874, ghrun-wicuw7bjty.auto.internal:27332): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:24:56,651 - DEBUG - ydb.topic - close: Close topic client
2025-11-01 16:24:56,651 - DEBUG - ydb.connection - _on_response_callback: RpcState(DeleteSession, 62d82187-c026-47bc-afc3-12a481fc2874, ghrun-wicuw7bjty.auto.internal:27332): on response callback success
2025-11-01 16:24:56,652 - DEBUG - ydb.topic - close: Topic client was closed
2025-11-01 16:24:56,652 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:18089
2025-11-01 16:24:56,652 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-wicuw7bjty.auto.internal:27332
2025-11-01 16:24:56,653 - INFO - ydb.pool.Discovery - run: Successfully terminated discovery process
2025-11-01 16:24:56,654 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: remove_database
2025-11-01 16:24:56,655 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - remove_database: /Root/users/database
2025-11-01 16:24:56,655 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_send_op: /Root/users/database: send console operation, token None
2025-11-01 16:24:56,659 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_send_op: /Root/users/database: response from console: RemoveTenantResponse {
  Response {
    operation {
      id: "ydb://cmsrequest/5?tenant=/Root/users/database&cmstid=72057594037936131&txid=1762014296657644&action=2"
    }
  }
}
Status {
  Code: STATUS_CODE_UNSPECIFIED
}

2025-11-01 16:24:56,660 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/users/database: wait console operation done
2025-11-01 16:24:57,164 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/users/database: console operation done
2025-11-01 16:24:57,164 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/users/database: wait tenant gone
2025-11-01 16:24:57,167 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/users/database: tenant gone
2025-11-01 16:24:58,168 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:27332/3
2025-11-01 16:24:58,168 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: done 2
2025-11-01 16:24:58,168 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: create_database
2025-11-01 16:24:58,678 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/drlt/00162f/ydb/apps/ydbd/ydbd
2025-11-01 16:24:58,679 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/6838
2025-11-01 16:24:58,680 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/2002
2025-11-01 16:24:58,680 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/5393
2025-11-01 16:24:58,680 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/5394
2025-11-01 16:24:58,681 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/22737
2025-11-01 16:24:58,681 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/9052
2025-11-01 16:24:58,682 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/drlt/00162f/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/kikimr_configs"
2025-11-01 16:24:58,682 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/drlt/00162f/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:18089 --tenant=/Root/users/database --log-file-name=/home/runner/.ya/build/build_root/drlt/00162f/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/slot_4/logfile_3qi8s0f_.log --grpc-port=6838 --mon-port=2002 --ic-port=5394
2025-11-01 16:24:58,683 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/drlt/00162f/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/kikimr_configs"
2025-11-01 16:24:58,683 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/drlt/00162f/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:18089 --tenant=/Root/users/database --log-file-name=/home/runner/.ya/build/build_root/drlt/00162f/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/slot_4/logfile_3qi8s0f_.log --grpc-port=6838 --mon-port=2002 --ic-port=5394
2025-11-01 16:24:58,684 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/drlt/00162f/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/drlt/00162f/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/kikimr_configs/config.yaml', '--node-broker=localhost:18089', '--tenant=/Root/users/database', '--log-file-name=/home/runner/.ya/build/build_root/drlt/00162f/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/slot_4/logfile_3qi8s0f_.log', '--grpc-port=6838', '--mon-port=2002', '--ic-port=5394')' in '/home/runner/.ya/build/build_root/drlt/00162f/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/slot_4' (no wait)
2025-11-01 16:24:58,685 - DEBUG - ya.test - execute: Command pid: 1452683
2025-11-01 16:24:58,686 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:6838/4
2025-11-01 16:24:58,688 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.36
2025-11-01 16:24:58,689 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.36
2025-11-01 16:24:58,689 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/drlt/00162f/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 16:24:58,690 - DEBUG - ya.test - execute: Command pid: 1452687
2025-11-01 16:24:59,204 - DEBUG - ya.test - _save_outputs: Command (pid 1452687) rc: 0
2025-11-01 16:24:59,204 - DEBUG - ya.test - _save_outputs: Command (pid 1452687) elapsed time (sec): 0.5132632255554199
2025-11-01 16:24:59,205 - DEBUG - ya.test - _save_outputs: Command (pid 1452687) idrss: 0
2025-11-01 16:24:59,205 - DEBUG - ya.test - _save_outputs: Command (pid 1452687) inblock: 0
2025-11-01 16:24:59,205 - DEBUG - ya.test - _save_outputs: Command (pid 1452687) isrss: 0
2025-11-01 16:24:59,205 - DEBUG - ya.test - _save_outputs: Command (pid 1452687) ixrss: 0
2025-11-01 16:24:59,205 - DEBUG - ya.test - _save_outputs: Command (pid 1452687) majflt: 0
2025-11-01 16:24:59,206 - DEBUG - ya.test - _save_outputs: Command (pid 1452687) maxrss: 538524
2025-11-01 16:24:59,206 - DEBUG - ya.test - _save_outputs: Command (pid 1452687) minflt: 16129
2025-11-01 16:24:59,206 - DEBUG - ya.test - _save_outputs: Command (pid 1452687) msgrcv: 0
2025-11-01 16:24:59,206 - DEBUG - ya.test - _save_outputs: Command (pid 1452687) msgsnd: 0
2025-11-01 16:24:59,206 - DEBUG - ya.test - _save_outputs: Command (pid 1452687) nivcsw: 1
2025-11-01 16:24:59,207 - DEBUG - ya.test - _save_outputs: Command (pid 1452687) nsignals: 0
2025-11-01 16:24:59,207 - DEBUG - ya.test - _save_outputs: Command (pid 1452687) nswap: 0
2025-11-01 16:24:59,207 - DEBUG - ya.test - _save_outputs: Command (pid 1452687) nvcsw: 15
2025-11-01 16:24:59,207 - DEBUG - ya.test - _save_outputs: Command (pid 1452687) oublock: 8
2025-11-01 16:24:59,207 - DEBUG - ya.test - _save_outputs: Command (pid 1452687) stime: 0.332897
2025-11-01 16:24:59,207 - DEBUG - ya.test - _save_outputs: Command (pid 1452687) utime: 0.132356
2025-11-01 16:24:59,208 - DEBUG - ya.test - _save_outputs: Command (pid 1452687) wtime: 0.514
2025-11-01 16:24:59,208 - DEBUG - ya.test - _save_outputs: Command (pid 1452687) output:
Git info:
    Commit: b759454d1e40b275ba8b2f5964202fc9f08a1c3c
    Branch: 
    Author: Denis Khalikov <dennis.khalikov@gmail.com>
    Summary: Merge b3001557f326a9ac3df9852d3eea5c83a6651a93 into 88f362bbf1115d2653ecf70400035099c5165741

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

    
Build info:
    Compiler: /home/runner/.ya/tools/v4/9944335923/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9944335923/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -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-01 16:24:59,208 - DEBUG - ya.test - _save_outputs: Command (pid 1452687) errors:

2025-11-01 16:24:59,208 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 4 version:
Git info:
    Commit: b759454d1e40b275ba8b2f5964202fc9f08a1c3c
    Branch: 
    Author: Denis Khalikov <dennis.khalikov@gmail.com>
    Summary: Merge b3001557f326a9ac3df9852d3eea5c83a6651a93 into 88f362bbf1115d2653ecf70400035099c5165741
2025-11-01 16:24:59,209 - 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-01 16:24:59,211 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 16:24:59,212 - 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-01 16:24:59,212 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: create table one
2025-11-01 16:24:59,215 - DEBUG - ydb.table.SessionPool - subscribe: Active session queue is empty, subscribe waiter for a session
2025-11-01 16:24:59,216 - DEBUG - ydb.table.SessionPool - subscribe: Subscribe waiter <Future at 0x7fd49e500060 state=pending>
2025-11-01 16:24:59,217 - DEBUG - ydb.table.SessionPool - subscribe: Session pool is not large enough (active_count < size: 0 < 1). will create a new session.
2025-11-01 16:24:59,217 - DEBUG - ydb.table.SessionPool - _create: Created session <ydb.table.Session object at 0x7fd49e500880>
2025-11-01 16:24:59,218 - DEBUG - ydb.table.SessionPool - _prepare: Preparing session <ydb.table.Session object at 0x7fd49e500880>
2025-11-01 16:24:59,218 - ERROR - ydb.table.SessionPool - _on_session_create: Failed to create session. Put event to a delayed queue. Reason: Couldn't find valid connection
2025-11-01 16:24:59,219 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/users/database
2025-11-01 16:24:59,220 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 69200eaf-7b75-4fc2-991a-a543e5d391be, localhost:18089): creating call state
2025-11-01 16:24:59,220 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 69200eaf-7b75-4fc2-991a-a543e5d391be, localhost:18089): request = { database: "/Root/users/database" }
2025-11-01 16:24:59,222 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 69200eaf-7b75-4fc2-991a-a543e5d391be, localhost:18089): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-11-01 16:24:59,223 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root/users/database. Endpoint: "localhost:18089". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-11-01 16:24:59,223 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:18089
2025-11-01 16:25:00,992 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 16:25:00,992 - 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-01 16:25:00,997 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/users/database
2025-11-01 16:25:00,998 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 0e256900-9cb0-4cde-8015-31458435f59b, localhost:18089): creating call state
2025-11-01 16:25:00,998 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 0e256900-9cb0-4cde-8015-31458435f59b, localhost:18089): request = { database: "/Root/users/database" }
2025-11-01 16:25:01,001 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 0e256900-9cb0-4cde-8015-31458435f59b, localhost:18089): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-wicuw7bjty.auto.internal" port: 6838 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" node_id: 50003 } self_location: "1" } } } }
2025-11-01 16:25:01,001 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root/users/database: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-wicuw7bjty.auto.internal:6838, location , ssl: False>]>
2025-11-01 16:25:01,002 - 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-01 16:25:01,009 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:18089
2025-11-01 16:25:01,009 - DEBUG - ydb.table.SessionPool - _prepare: Preparing session <ydb.table.Session object at 0x7fd49e500880>
2025-11-01 16:25:01,010 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 6f7209d4-eae7-4688-89d0-2b2fb21472a1, ghrun-wicuw7bjty.auto.internal:6838): creating call state
2025-11-01 16:25:01,010 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 6f7209d4-eae7-4688-89d0-2b2fb21472a1, ghrun-wicuw7bjty.auto.internal:6838): request = { operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-11-01 16:25:01,013 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, 6f7209d4-eae7-4688-89d0-2b2fb21472a1, ghrun-wicuw7bjty.auto.internal:6838): on response callback started
2025-11-01 16:25:01,013 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 6f7209d4-eae7-4688-89d0-2b2fb21472a1, ghrun-wicuw7bjty.auto.internal:6838): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=50003&id=OTE3Njg4ZGUtZWIxODIxYzUtMTFjMTEwOWEtM2IwYTlmNmY=" } } } }
2025-11-01 16:25:01,014 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fd49e500880>
2025-11-01 16:25:01,014 - DEBUG - ydb.table.SessionPool - put: Replying to waiter with a session <ydb.table.Session object at 0x7fd49e500880>
2025-11-01 16:25:01,015 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, b8609323-ab3d-4a39-a945-ad6fb1e0c685, ghrun-wicuw7bjty.auto.internal:6838): creating call state
2025-11-01 16:25:01,015 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, 6f7209d4-eae7-4688-89d0-2b2fb21472a1, ghrun-wicuw7bjty.auto.internal:6838): on response callback success
2025-11-01 16:25:01,016 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, b8609323-ab3d-4a39-a945-ad6fb1e0c685, ghrun-wicuw7bjty.auto.internal:6838): request = { session_id: "ydb://session/3?node_id=50003&id=OTE3Njg4ZGUtZWIxODIxYzUtMTFjMTEwOWEtM2IwYTlmNmY=" path: "/Root/users/database/table" columns { name: "id" type { optional_type { item { type_id: UINT64 } } } } columns { name: "value" type { optional_type { item { type_id: UTF8 } } } } primary_key: "id" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:25:01,074 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, b8609323-ab3d-4a39-a945-ad6fb1e0c685, ghrun-wicuw7bjty.auto.internal:6838): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:25:01,074 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fd49e500880>
2025-11-01 16:25:01,074 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: create table two
2025-11-01 16:25:01,076 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, b4241ee0-f71c-4582-ade5-a0e3118f258c, ghrun-wicuw7bjty.auto.internal:6838): creating call state
2025-11-01 16:25:01,077 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, b4241ee0-f71c-4582-ade5-a0e3118f258c, ghrun-wicuw7bjty.auto.internal:6838): request = { session_id: "ydb://session/3?node_id=50003&id=OTE3Njg4ZGUtZWIxODIxYzUtMTFjMTEwOWEtM2IwYTlmNmY=" path: "/Root/users/database/table_for_rm" columns { name: "id" type { optional_type { item { type_id: UINT64 } } } } columns { name: "value" type { optional_type { item { type_id: UTF8 } } } } primary_key: "id" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:25:01,101 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, b4241ee0-f71c-4582-ade5-a0e3118f258c, ghrun-wicuw7bjty.auto.internal:6838): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:25:01,102 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fd49e500880>
2025-11-01 16:25:01,102 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: write_some_data
2025-11-01 16:25:01,103 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, b2abc9b1-0832-42ed-bce5-5ff6cbf7ecbf, ghrun-wicuw7bjty.auto.internal:6838): creating call state
2025-11-01 16:25:01,103 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, b2abc9b1-0832-42ed-bce5-5ff6cbf7ecbf, ghrun-wicuw7bjty.auto.internal:6838): request = { session_id: "ydb://session/3?node_id=50003&id=OTE3Njg4ZGUtZWIxODIxYzUtMTFjMTEwOWEtM2IwYTlmNmY=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "\n                        upsert into table (id, value)\n                        values (1u, \"/Root/users/database_3\");\n                        upsert into table_for_rm (id, value)\n                        values (2u, \"/Root/users/database_3\");\n                        " } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:25:01,129 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, b2abc9b1-0832-42ed-bce5-5ff6cbf7ecbf, ghrun-wicuw7bjty.auto.internal:6838): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-11-01 16:25:01,130 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fd49e500880>
2025-11-01 16:25:01,130 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: read_some_data
2025-11-01 16:25:01,131 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 43a0a5f4-5a5e-4055-a394-54ec71a9deab, ghrun-wicuw7bjty.auto.internal:6838): creating call state
2025-11-01 16:25:01,131 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 43a0a5f4-5a5e-4055-a394-54ec71a9deab, ghrun-wicuw7bjty.auto.internal:6838): request = { session_id: "ydb://session/3?node_id=50003&id=OTE3Njg4ZGUtZWIxODIxYzUtMTFjMTEwOWEtM2IwYTlmNmY=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "\n                        select id, value FROM table;\n                        select id, value FROM table_for_rm;\n                        " } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:25:01,165 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 43a0a5f4-5a5e-4055-a394-54ec71a9deab, ghrun-wicuw7bjty.auto.internal:6838): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { result_sets { columns { name: "id" type { optional_type { item { type_id: UINT64 } } } } columns { name: "value" type { optional_type { item { type_id: UTF8 } } } } rows { items { uint64_value: 1 } items { text_value: "/Root/users/database_3" } } format: FORMAT_VALUE } result_sets { columns { name: "id" type { optional_type { item { type_id: UINT64 } } } } columns { name: "value" type { optional_type { item { type_id: UTF8 } } } } rows { items { uint64_value: 2 } items { text_value: "/Root/users/database_3" } } format: FORMAT_VALUE } tx_meta { } } } } }
2025-11-01 16:25:01,165 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fd49e500880>
2025-11-01 16:25:01,166 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: drop table two
2025-11-01 16:25:01,166 - DEBUG - ydb.connection - _prepare_call: RpcState(DropTable, a4062613-e3c9-4bc9-afd1-3abd612799f0, ghrun-wicuw7bjty.auto.internal:6838): creating call state
2025-11-01 16:25:01,166 - DEBUG - ydb.connection - _log_request: RpcState(DropTable, a4062613-e3c9-4bc9-afd1-3abd612799f0, ghrun-wicuw7bjty.auto.internal:6838): request = { session_id: "ydb://session/3?node_id=50003&id=OTE3Njg4ZGUtZWIxODIxYzUtMTFjMTEwOWEtM2IwYTlmNmY=" path: "/Root/users/database/table_for_rm" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:25:01,181 - DEBUG - ydb.connection - _log_response: RpcState(DropTable, a4062613-e3c9-4bc9-afd1-3abd612799f0, ghrun-wicuw7bjty.auto.internal:6838): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:25:01,182 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fd49e500880>
2025-11-01 16:25:01,182 - DEBUG - ydb.table.SessionPool - stop: Requested session pool stop.
2025-11-01 16:25:01,182 - DEBUG - ydb.table.SessionPool - stop: Session pool is under stop, cancelling all in flight waiters.
2025-11-01 16:25:01,182 - DEBUG - ydb.table.SessionPool - stop: Destroying sessions in active queue
2025-11-01 16:25:01,182 - DEBUG - ydb.table.SessionPool - _destroy: Requested session destroy: <ydb.table.Session object at 0x7fd49e500880>, reason: session-pool-terminated
2025-11-01 16:25:01,183 - DEBUG - ydb.table.SessionPool - _terminate_event: Terminated session pool.
2025-11-01 16:25:01,183 - DEBUG - ydb.table.SessionPool - _destroy: Session <ydb.table.Session object at 0x7fd49e500880> is no longer active. Current active count 0.
2025-11-01 16:25:01,184 - DEBUG - ydb.connection - _prepare_call: RpcState(DeleteSession, e3841273-0a5a-4684-8305-e863157dd993, ghrun-wicuw7bjty.auto.internal:6838): creating call state
2025-11-01 16:25:01,184 - DEBUG - ydb.connection - _log_request: RpcState(DeleteSession, e3841273-0a5a-4684-8305-e863157dd993, ghrun-wicuw7bjty.auto.internal:6838): request = { session_id: "ydb://session/3?node_id=50003&id=OTE3Njg4ZGUtZWIxODIxYzUtMTFjMTEwOWEtM2IwYTlmNmY=" operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-11-01 16:25:01,186 - DEBUG - ydb.table.SessionPool - _destroy: Sent delete on session <ydb.table.Session object at 0x7fd49e500880>
2025-11-01 16:25:01,186 - DEBUG - ydb.connection - _on_response_callback: RpcState(DeleteSession, e3841273-0a5a-4684-8305-e863157dd993, ghrun-wicuw7bjty.auto.internal:6838): on response callback started
2025-11-01 16:25:01,189 - DEBUG - ydb.table.SessionPool - stop: Destroyed active sessions
2025-11-01 16:25:01,189 - DEBUG - ydb.connection - _log_response: RpcState(DeleteSession, e3841273-0a5a-4684-8305-e863157dd993, ghrun-wicuw7bjty.auto.internal:6838): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:25:01,190 - DEBUG - ydb.topic - close: Close topic client
2025-11-01 16:25:01,191 - DEBUG - ydb.connection - _on_response_callback: RpcState(DeleteSession, e3841273-0a5a-4684-8305-e863157dd993, ghrun-wicuw7bjty.auto.internal:6838): on response callback success
2025-11-01 16:25:01,191 - DEBUG - ydb.topic - close: Topic client was closed
2025-11-01 16:25:01,192 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:18089
2025-11-01 16:25:01,200 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-wicuw7bjty.auto.internal:6838
2025-11-01 16:25:01,211 - INFO - ydb.pool.Discovery - run: Successfully terminated discovery process
2025-11-01 16:25:01,212 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: remove_database
2025-11-01 16:25:01,212 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - remove_database: /Root/users/database
2025-11-01 16:25:01,212 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_send_op: /Root/users/database: send console operation, token None
2025-11-01 16:25:01,217 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_send_op: /Root/users/database: response from console: RemoveTenantResponse {
  Response {
    operation {
      id: "ydb://cmsrequest/5?tenant=/Root/users/database&cmstid=72057594037936131&txid=1762014301215213&action=2"
    }
  }
}
Status {
  Code: STATUS_CODE_UNSPECIFIED
}

2025-11-01 16:25:01,218 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/users/database: wait console operation done
2025-11-01 16:25:01,721 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/users/database: console operation done
2025-11-01 16:25:01,723 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/users/database: wait tenant gone
2025-11-01 16:25:01,725 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/users/database: tenant gone
2025-11-01 16:25:02,726 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:6838/4
2025-11-01 16:25:02,727 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: done 3
2025-11-01 16:25:02,729 - INFO - ya.test - pytest_runtest_teardown: Test teardown
