2025-11-06 10:00:52,305 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-06 10:00:52,305 - INFO - ya.test - pytest_runtest_setup: test_create_and_drop_the_same_tenant2[enable_alter_database_create_hive_first--false]
2025-11-06 10:00:52,306 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-06 10:00:52,306 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-06 10:00:52,306 - INFO - ydb.tests.library.fixtures - ydb_cluster: destroy ydb_cluster for __tests__.test_dynamic_tenants
2025-11-06 10:00:59,308 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:5940/1
2025-11-06 10:00:59,312 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/25404
2025-11-06 10:00:59,312 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/4860
2025-11-06 10:00:59,313 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/12224
2025-11-06 10:00:59,313 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/10395
2025-11-06 10:00:59,313 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/21609
2025-11-06 10:00:59,313 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/30638
2025-11-06 10:00:59,313 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/65275
2025-11-06 10:00:59,314 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/3454
2025-11-06 10:00:59,314 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/11811
2025-11-06 10:00:59,314 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/1516
2025-11-06 10:00:59,314 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/63178
2025-11-06 10:00:59,314 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/22360
2025-11-06 10:00:59,314 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/62926
2025-11-06 10:00:59,315 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/27518
2025-11-06 10:00:59,315 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/15306
2025-11-06 10:00:59,315 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/29859
2025-11-06 10:00:59,315 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/1298
2025-11-06 10:00:59,316 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/63393
2025-11-06 10:00:59,316 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/16863
2025-11-06 10:00:59,316 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/14804
2025-11-06 10:00:59,316 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/15533
2025-11-06 10:00:59,316 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/6296
2025-11-06 10:00:59,317 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/5926
2025-11-06 10:00:59,317 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/17938
2025-11-06 10:00:59,317 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/13530
2025-11-06 10:00:59,317 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/26373
2025-11-06 10:00:59,317 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/14254
2025-11-06 10:00:59,318 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/65506
2025-11-06 10:00:59,318 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/11587
2025-11-06 10:00:59,318 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/21319
2025-11-06 10:00:59,318 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/18629
2025-11-06 10:00:59,318 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/27712
2025-11-06 10:00:59,319 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/1462
2025-11-06 10:00:59,319 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/23327
2025-11-06 10:00:59,319 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/12683
2025-11-06 10:00:59,319 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/29275
2025-11-06 10:00:59,319 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/13099
2025-11-06 10:00:59,319 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/27809
2025-11-06 10:00:59,320 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/23314
2025-11-06 10:00:59,320 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/18359
2025-11-06 10:00:59,320 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/25689
2025-11-06 10:00:59,320 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/27756
2025-11-06 10:00:59,320 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/19929
2025-11-06 10:00:59,321 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/27645
2025-11-06 10:00:59,321 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/14002
2025-11-06 10:00:59,321 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/3307
2025-11-06 10:00:59,321 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/22137
2025-11-06 10:00:59,321 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/20241
2025-11-06 10:00:59,321 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/12797
2025-11-06 10:00:59,322 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/24748
2025-11-06 10:00:59,322 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/23183
2025-11-06 10:00:59,322 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/12831
2025-11-06 10:00:59,322 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/14545
2025-11-06 10:00:59,322 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/5940
2025-11-06 10:00:59,323 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/26872
2025-11-06 10:00:59,381 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/4esq/004cd1/ydb/apps/ydbd/ydbd
2025-11-06 10:00:59,382 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/1320
2025-11-06 10:00:59,383 - INFO - ydb.tests.library.fixtures - ydb_cluster: setup ydb_cluster for __tests__.test_dynamic_tenants
2025-11-06 10:00:59,383 - INFO - ydb.tests.library.fixtures - ydb_cluster: setup ydb_cluster as local
2025-11-06 10:00:59,384 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/4esq/004cd1/r3tmp/kikimr_cluster_yjplcb5o
2025-11-06 10:00:59,424 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/4esq/004cd1/ydb/apps/ydbd/ydbd
2025-11-06 10:00:59,424 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/1763
2025-11-06 10:00:59,425 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/5621
2025-11-06 10:00:59,425 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/22787
2025-11-06 10:00:59,425 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/31809
2025-11-06 10:00:59,426 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/4esq/004cd1/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-06 10:00:59,426 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/4esq/004cd1/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/4esq/004cd1/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_a3ufy0uc.log --grpc-port=1763 --mon-port=5621 --ic-port=1320
2025-11-06 10:00:59,426 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:1763/1, disk_size 68719476736
2025-11-06 10:00:59,426 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/4esq/004cd1/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-06 10:00:59,427 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/4esq/004cd1/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/4esq/004cd1/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_a3ufy0uc.log --grpc-port=1763 --mon-port=5621 --ic-port=1320
2025-11-06 10:00:59,428 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/4esq/004cd1/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/4esq/004cd1/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/4esq/004cd1/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_a3ufy0uc.log', '--grpc-port=1763', '--mon-port=5621', '--ic-port=1320')' in '/home/runner/.ya/build/build_root/4esq/004cd1/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-06 10:00:59,431 - DEBUG - ya.test - execute: Command pid: 777449
2025-11-06 10:00:59,431 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:1763/1
2025-11-06 10:00:59,433 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.30
2025-11-06 10:00:59,434 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.30
2025-11-06 10:00:59,434 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/4esq/004cd1/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-06 10:00:59,435 - DEBUG - ya.test - execute: Command pid: 777465
2025-11-06 10:00:59,915 - DEBUG - ya.test - _save_outputs: Command (pid 777465) rc: 0
2025-11-06 10:00:59,916 - DEBUG - ya.test - _save_outputs: Command (pid 777465) elapsed time (sec): 0.4791243076324463
2025-11-06 10:00:59,916 - DEBUG - ya.test - _save_outputs: Command (pid 777465) idrss: 0
2025-11-06 10:00:59,916 - DEBUG - ya.test - _save_outputs: Command (pid 777465) inblock: 0
2025-11-06 10:00:59,916 - DEBUG - ya.test - _save_outputs: Command (pid 777465) isrss: 0
2025-11-06 10:00:59,916 - DEBUG - ya.test - _save_outputs: Command (pid 777465) ixrss: 0
2025-11-06 10:00:59,916 - DEBUG - ya.test - _save_outputs: Command (pid 777465) majflt: 0
2025-11-06 10:00:59,917 - DEBUG - ya.test - _save_outputs: Command (pid 777465) maxrss: 538764
2025-11-06 10:00:59,917 - DEBUG - ya.test - _save_outputs: Command (pid 777465) minflt: 16133
2025-11-06 10:00:59,917 - DEBUG - ya.test - _save_outputs: Command (pid 777465) msgrcv: 0
2025-11-06 10:00:59,917 - DEBUG - ya.test - _save_outputs: Command (pid 777465) msgsnd: 0
2025-11-06 10:00:59,917 - DEBUG - ya.test - _save_outputs: Command (pid 777465) nivcsw: 15
2025-11-06 10:00:59,917 - DEBUG - ya.test - _save_outputs: Command (pid 777465) nsignals: 0
2025-11-06 10:00:59,918 - DEBUG - ya.test - _save_outputs: Command (pid 777465) nswap: 0
2025-11-06 10:00:59,918 - DEBUG - ya.test - _save_outputs: Command (pid 777465) nvcsw: 13
2025-11-06 10:00:59,918 - DEBUG - ya.test - _save_outputs: Command (pid 777465) oublock: 8
2025-11-06 10:00:59,918 - DEBUG - ya.test - _save_outputs: Command (pid 777465) stime: 0.328554
2025-11-06 10:00:59,918 - DEBUG - ya.test - _save_outputs: Command (pid 777465) utime: 0.096162
2025-11-06 10:00:59,918 - DEBUG - ya.test - _save_outputs: Command (pid 777465) wtime: 0.481
2025-11-06 10:00:59,919 - DEBUG - ya.test - _save_outputs: Command (pid 777465) output:
Git info:
    Commit: 609b3b9504bd064e40414654c1f6284791b6a66c
    Branch: 
    Author: Alek5andr-Kotov <akotov@ydb.tech>
    Summary: Merge 5af363c204fa18a6cbd8ab64fd547c3e99f1eee6 into 5ddc18e8b9ca9bdb9f539a0a3efaaf4e958f00d3

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-ar5i2wnyyy
    Host information: 
        Linux ghrun-ar5i2wnyyy 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-06 10:00:59,919 - DEBUG - ya.test - _save_outputs: Command (pid 777465) errors:

2025-11-06 10:00:59,919 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 609b3b9504bd064e40414654c1f6284791b6a66c
    Branch: 
    Author: Alek5andr-Kotov <akotov@ydb.tech>
    Summary: Merge 5af363c204fa18a6cbd8ab64fd547c3e99f1eee6 into 5ddc18e8b9ca9bdb9f539a0a3efaaf4e958f00d3
2025-11-06 10:01:01,751 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/4esq/004cd1/ydb/apps/ydbd/ydbd
2025-11-06 10:01:01,752 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/4esq/004cd1/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:1763', '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: 1320\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-06 10:01:01,753 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.31
2025-11-06 10:01:01,754 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.31
2025-11-06 10:01:01,754 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/4esq/004cd1/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:1763', '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: 1320\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-06 10:01:01,755 - DEBUG - ya.test - execute: Command pid: 781829
2025-11-06 10:01:02,240 - DEBUG - ya.test - _save_outputs: Command (pid 781829) rc: 0
2025-11-06 10:01:02,241 - DEBUG - ya.test - _save_outputs: Command (pid 781829) elapsed time (sec): 0.484036922454834
2025-11-06 10:01:02,241 - DEBUG - ya.test - _save_outputs: Command (pid 781829) idrss: 0
2025-11-06 10:01:02,241 - DEBUG - ya.test - _save_outputs: Command (pid 781829) inblock: 0
2025-11-06 10:01:02,241 - DEBUG - ya.test - _save_outputs: Command (pid 781829) isrss: 0
2025-11-06 10:01:02,241 - DEBUG - ya.test - _save_outputs: Command (pid 781829) ixrss: 0
2025-11-06 10:01:02,242 - DEBUG - ya.test - _save_outputs: Command (pid 781829) majflt: 0
2025-11-06 10:01:02,242 - DEBUG - ya.test - _save_outputs: Command (pid 781829) maxrss: 547172
2025-11-06 10:01:02,242 - DEBUG - ya.test - _save_outputs: Command (pid 781829) minflt: 18278
2025-11-06 10:01:02,242 - DEBUG - ya.test - _save_outputs: Command (pid 781829) msgrcv: 0
2025-11-06 10:01:02,242 - DEBUG - ya.test - _save_outputs: Command (pid 781829) msgsnd: 0
2025-11-06 10:01:02,242 - DEBUG - ya.test - _save_outputs: Command (pid 781829) nivcsw: 24
2025-11-06 10:01:02,243 - DEBUG - ya.test - _save_outputs: Command (pid 781829) nsignals: 0
2025-11-06 10:01:02,243 - DEBUG - ya.test - _save_outputs: Command (pid 781829) nswap: 0
2025-11-06 10:01:02,243 - DEBUG - ya.test - _save_outputs: Command (pid 781829) nvcsw: 118
2025-11-06 10:01:02,243 - DEBUG - ya.test - _save_outputs: Command (pid 781829) oublock: 8
2025-11-06 10:01:02,243 - DEBUG - ya.test - _save_outputs: Command (pid 781829) stime: 0.259494
2025-11-06 10:01:02,243 - DEBUG - ya.test - _save_outputs: Command (pid 781829) utime: 0.141984
2025-11-06 10:01:02,243 - DEBUG - ya.test - _save_outputs: Command (pid 781829) wtime: 0.485
2025-11-06 10:01:02,244 - DEBUG - ya.test - _save_outputs: Command (pid 781829) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 4

2025-11-06 10:01:02,244 - DEBUG - ya.test - _save_outputs: Command (pid 781829) errors:

2025-11-06 10:01:02,245 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/4esq/004cd1/ydb/apps/ydbd/ydbd
2025-11-06 10:01:02,245 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/4esq/004cd1/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:1763', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']
2025-11-06 10:01:02,246 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.32
2025-11-06 10:01:02,247 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.32
2025-11-06 10:01:02,247 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/4esq/004cd1/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:1763', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-06 10:01:02,255 - DEBUG - ya.test - execute: Command pid: 782735
2025-11-06 10:01:02,696 - DEBUG - ya.test - _save_outputs: Command (pid 782735) rc: 0
2025-11-06 10:01:02,696 - DEBUG - ya.test - _save_outputs: Command (pid 782735) elapsed time (sec): 0.4405965805053711
2025-11-06 10:01:02,697 - DEBUG - ya.test - _save_outputs: Command (pid 782735) idrss: 0
2025-11-06 10:01:02,697 - DEBUG - ya.test - _save_outputs: Command (pid 782735) inblock: 0
2025-11-06 10:01:02,697 - DEBUG - ya.test - _save_outputs: Command (pid 782735) isrss: 0
2025-11-06 10:01:02,697 - DEBUG - ya.test - _save_outputs: Command (pid 782735) ixrss: 0
2025-11-06 10:01:02,697 - DEBUG - ya.test - _save_outputs: Command (pid 782735) majflt: 0
2025-11-06 10:01:02,698 - DEBUG - ya.test - _save_outputs: Command (pid 782735) maxrss: 547176
2025-11-06 10:01:02,698 - DEBUG - ya.test - _save_outputs: Command (pid 782735) minflt: 18275
2025-11-06 10:01:02,698 - DEBUG - ya.test - _save_outputs: Command (pid 782735) msgrcv: 0
2025-11-06 10:01:02,698 - DEBUG - ya.test - _save_outputs: Command (pid 782735) msgsnd: 0
2025-11-06 10:01:02,698 - DEBUG - ya.test - _save_outputs: Command (pid 782735) nivcsw: 67
2025-11-06 10:01:02,699 - DEBUG - ya.test - _save_outputs: Command (pid 782735) nsignals: 0
2025-11-06 10:01:02,699 - DEBUG - ya.test - _save_outputs: Command (pid 782735) nswap: 0
2025-11-06 10:01:02,699 - DEBUG - ya.test - _save_outputs: Command (pid 782735) nvcsw: 103
2025-11-06 10:01:02,699 - DEBUG - ya.test - _save_outputs: Command (pid 782735) oublock: 8
2025-11-06 10:01:02,699 - DEBUG - ya.test - _save_outputs: Command (pid 782735) stime: 0.263812
2025-11-06 10:01:02,700 - DEBUG - ya.test - _save_outputs: Command (pid 782735) utime: 0.114187
2025-11-06 10:01:02,700 - DEBUG - ya.test - _save_outputs: Command (pid 782735) wtime: 0.448
2025-11-06 10:01:02,700 - DEBUG - ya.test - _save_outputs: Command (pid 782735) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-06 10:01:02,700 - DEBUG - ya.test - _save_outputs: Command (pid 782735) errors:

2025-11-06 10:01:02,701 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-06 10:01:02,719 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-11-06 10:01:02,730 - 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-06 10:01:02,731 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: create_database
2025-11-06 10:01:03,244 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/4esq/004cd1/ydb/apps/ydbd/ydbd
2025-11-06 10:01:03,245 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/22743
2025-11-06 10:01:03,245 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/3503
2025-11-06 10:01:03,245 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/12785
2025-11-06 10:01:03,246 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/8954
2025-11-06 10:01:03,246 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/20185
2025-11-06 10:01:03,247 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/4esq/004cd1/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-06 10:01:03,247 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/4esq/004cd1/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:1763 --tenant=/Root/users/database --log-file-name=/home/runner/.ya/build/build_root/4esq/004cd1/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_6qpo_opc.log --grpc-port=22743 --mon-port=3503 --ic-port=12785
2025-11-06 10:01:03,247 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/4esq/004cd1/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-06 10:01:03,247 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/4esq/004cd1/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:1763 --tenant=/Root/users/database --log-file-name=/home/runner/.ya/build/build_root/4esq/004cd1/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_6qpo_opc.log --grpc-port=22743 --mon-port=3503 --ic-port=12785
2025-11-06 10:01:03,249 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/4esq/004cd1/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/4esq/004cd1/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:1763', '--tenant=/Root/users/database', '--log-file-name=/home/runner/.ya/build/build_root/4esq/004cd1/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_6qpo_opc.log', '--grpc-port=22743', '--mon-port=3503', '--ic-port=12785')' in '/home/runner/.ya/build/build_root/4esq/004cd1/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-06 10:01:03,251 - DEBUG - ya.test - execute: Command pid: 784579
2025-11-06 10:01:03,251 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:22743/1
2025-11-06 10:01:03,253 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.33
2025-11-06 10:01:03,254 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.33
2025-11-06 10:01:03,254 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/4esq/004cd1/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-06 10:01:03,255 - DEBUG - ya.test - execute: Command pid: 784583
2025-11-06 10:01:03,666 - DEBUG - ya.test - _save_outputs: Command (pid 784583) rc: 0
2025-11-06 10:01:03,666 - DEBUG - ya.test - _save_outputs: Command (pid 784583) elapsed time (sec): 0.41007375717163086
2025-11-06 10:01:03,666 - DEBUG - ya.test - _save_outputs: Command (pid 784583) idrss: 0
2025-11-06 10:01:03,666 - DEBUG - ya.test - _save_outputs: Command (pid 784583) inblock: 0
2025-11-06 10:01:03,666 - DEBUG - ya.test - _save_outputs: Command (pid 784583) isrss: 0
2025-11-06 10:01:03,667 - DEBUG - ya.test - _save_outputs: Command (pid 784583) ixrss: 0
2025-11-06 10:01:03,667 - DEBUG - ya.test - _save_outputs: Command (pid 784583) majflt: 0
2025-11-06 10:01:03,667 - DEBUG - ya.test - _save_outputs: Command (pid 784583) maxrss: 538764
2025-11-06 10:01:03,667 - DEBUG - ya.test - _save_outputs: Command (pid 784583) minflt: 20251
2025-11-06 10:01:03,667 - DEBUG - ya.test - _save_outputs: Command (pid 784583) msgrcv: 0
2025-11-06 10:01:03,667 - DEBUG - ya.test - _save_outputs: Command (pid 784583) msgsnd: 0
2025-11-06 10:01:03,668 - DEBUG - ya.test - _save_outputs: Command (pid 784583) nivcsw: 9
2025-11-06 10:01:03,668 - DEBUG - ya.test - _save_outputs: Command (pid 784583) nsignals: 0
2025-11-06 10:01:03,668 - DEBUG - ya.test - _save_outputs: Command (pid 784583) nswap: 0
2025-11-06 10:01:03,668 - DEBUG - ya.test - _save_outputs: Command (pid 784583) nvcsw: 19
2025-11-06 10:01:03,668 - DEBUG - ya.test - _save_outputs: Command (pid 784583) oublock: 8
2025-11-06 10:01:03,668 - DEBUG - ya.test - _save_outputs: Command (pid 784583) stime: 0.220127
2025-11-06 10:01:03,668 - DEBUG - ya.test - _save_outputs: Command (pid 784583) utime: 0.13758399999999998
2025-11-06 10:01:03,669 - DEBUG - ya.test - _save_outputs: Command (pid 784583) wtime: 0.411
2025-11-06 10:01:03,669 - DEBUG - ya.test - _save_outputs: Command (pid 784583) output:
Git info:
    Commit: 609b3b9504bd064e40414654c1f6284791b6a66c
    Branch: 
    Author: Alek5andr-Kotov <akotov@ydb.tech>
    Summary: Merge 5af363c204fa18a6cbd8ab64fd547c3e99f1eee6 into 5ddc18e8b9ca9bdb9f539a0a3efaaf4e958f00d3

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-ar5i2wnyyy
    Host information: 
        Linux ghrun-ar5i2wnyyy 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-06 10:01:03,669 - DEBUG - ya.test - _save_outputs: Command (pid 784583) errors:

2025-11-06 10:01:03,669 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 609b3b9504bd064e40414654c1f6284791b6a66c
    Branch: 
    Author: Alek5andr-Kotov <akotov@ydb.tech>
    Summary: Merge 5af363c204fa18a6cbd8ab64fd547c3e99f1eee6 into 5ddc18e8b9ca9bdb9f539a0a3efaaf4e958f00d3
2025-11-06 10:01:03,670 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-06 10:01:03,672 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-06 10:01:03,672 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-06 10:01:03,674 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: create table one
2025-11-06 10:01:03,676 - DEBUG - ydb.table.SessionPool - subscribe: Active session queue is empty, subscribe waiter for a session
2025-11-06 10:01:03,676 - DEBUG - ydb.table.SessionPool - subscribe: Subscribe waiter <Future at 0x7f491452c5b0 state=pending>
2025-11-06 10:01:03,676 - DEBUG - ydb.table.SessionPool - subscribe: Session pool is not large enough (active_count < size: 0 < 1). will create a new session.
2025-11-06 10:01:03,677 - DEBUG - ydb.table.SessionPool - _create: Created session <ydb.table.Session object at 0x7f491452c1a0>
2025-11-06 10:01:03,677 - DEBUG - ydb.table.SessionPool - _prepare: Preparing session <ydb.table.Session object at 0x7f491452c1a0>
2025-11-06 10:01:03,677 - 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-06 10:01:03,680 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/users/database
2025-11-06 10:01:03,680 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 2435d5d4-0324-4a08-93b8-24074214603b, localhost:1763): creating call state
2025-11-06 10:01:03,681 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 2435d5d4-0324-4a08-93b8-24074214603b, localhost:1763): request = { database: "/Root/users/database" }
2025-11-06 10:01:03,683 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 2435d5d4-0324-4a08-93b8-24074214603b, localhost:1763): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-11-06 10:01:03,683 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root/users/database. Endpoint: "localhost:1763". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-11-06 10:01:03,683 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:1763
2025-11-06 10:01:05,051 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-06 10:01:05,052 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-06 10:01:05,058 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/users/database
2025-11-06 10:01:05,059 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 03bc92e7-b21e-452c-818d-f890cdefc67e, localhost:1763): creating call state
2025-11-06 10:01:05,059 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 03bc92e7-b21e-452c-818d-f890cdefc67e, localhost:1763): request = { database: "/Root/users/database" }
2025-11-06 10:01:05,062 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 03bc92e7-b21e-452c-818d-f890cdefc67e, localhost:1763): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-ar5i2wnyyy.auto.internal" port: 22743 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-06 10:01:05,063 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root/users/database: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-ar5i2wnyyy.auto.internal:22743, location , ssl: False>]>
2025-11-06 10:01:05,063 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-06 10:01:05,070 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:1763
2025-11-06 10:01:05,071 - DEBUG - ydb.table.SessionPool - _prepare: Preparing session <ydb.table.Session object at 0x7f491452c1a0>
2025-11-06 10:01:05,072 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 6e7f691c-6e12-4328-b585-b40571bf7843, ghrun-ar5i2wnyyy.auto.internal:22743): creating call state
2025-11-06 10:01:05,072 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 6e7f691c-6e12-4328-b585-b40571bf7843, ghrun-ar5i2wnyyy.auto.internal:22743): request = { operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-11-06 10:01:05,075 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, 6e7f691c-6e12-4328-b585-b40571bf7843, ghrun-ar5i2wnyyy.auto.internal:22743): on response callback started
2025-11-06 10:01:05,076 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 6e7f691c-6e12-4328-b585-b40571bf7843, ghrun-ar5i2wnyyy.auto.internal:22743): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=50000&id=Nzg5NTIwMjMtNTQ5MzA0YjItMTcwZTA4NzEtNjZmOGUwODk=" } } } }
2025-11-06 10:01:05,076 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f491452c1a0>
2025-11-06 10:01:05,076 - DEBUG - ydb.table.SessionPool - put: Replying to waiter with a session <ydb.table.Session object at 0x7f491452c1a0>
2025-11-06 10:01:05,077 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, ddcbef4f-7dfa-46d1-8122-f4205c4f91ec, ghrun-ar5i2wnyyy.auto.internal:22743): creating call state
2025-11-06 10:01:05,077 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, 6e7f691c-6e12-4328-b585-b40571bf7843, ghrun-ar5i2wnyyy.auto.internal:22743): on response callback success
2025-11-06 10:01:05,078 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, ddcbef4f-7dfa-46d1-8122-f4205c4f91ec, ghrun-ar5i2wnyyy.auto.internal:22743): request = { session_id: "ydb://session/3?node_id=50000&id=Nzg5NTIwMjMtNTQ5MzA0YjItMTcwZTA4NzEtNjZmOGUwODk=" 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-06 10:01:05,126 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, ddcbef4f-7dfa-46d1-8122-f4205c4f91ec, ghrun-ar5i2wnyyy.auto.internal:22743): response = { operation { ready: true status: SUCCESS } }
2025-11-06 10:01:05,126 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f491452c1a0>
2025-11-06 10:01:05,126 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: create table two
2025-11-06 10:01:05,127 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 11c027c9-9b89-4941-a724-077248e6ea89, ghrun-ar5i2wnyyy.auto.internal:22743): creating call state
2025-11-06 10:01:05,127 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 11c027c9-9b89-4941-a724-077248e6ea89, ghrun-ar5i2wnyyy.auto.internal:22743): request = { session_id: "ydb://session/3?node_id=50000&id=Nzg5NTIwMjMtNTQ5MzA0YjItMTcwZTA4NzEtNjZmOGUwODk=" 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-06 10:01:05,158 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 11c027c9-9b89-4941-a724-077248e6ea89, ghrun-ar5i2wnyyy.auto.internal:22743): response = { operation { ready: true status: SUCCESS } }
2025-11-06 10:01:05,159 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f491452c1a0>
2025-11-06 10:01:05,159 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: write_some_data
2025-11-06 10:01:05,160 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 95d0c7a4-683d-4efd-a2af-743fd9dfd36e, ghrun-ar5i2wnyyy.auto.internal:22743): creating call state
2025-11-06 10:01:05,161 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 95d0c7a4-683d-4efd-a2af-743fd9dfd36e, ghrun-ar5i2wnyyy.auto.internal:22743): request = { session_id: "ydb://session/3?node_id=50000&id=Nzg5NTIwMjMtNTQ5MzA0YjItMTcwZTA4NzEtNjZmOGUwODk=" 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-06 10:01:05,351 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 95d0c7a4-683d-4efd-a2af-743fd9dfd36e, ghrun-ar5i2wnyyy.auto.internal:22743): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-11-06 10:01:05,352 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f491452c1a0>
2025-11-06 10:01:05,353 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: read_some_data
2025-11-06 10:01:05,353 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 2803505a-608f-43c4-a642-10565de3217e, ghrun-ar5i2wnyyy.auto.internal:22743): creating call state
2025-11-06 10:01:05,354 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 2803505a-608f-43c4-a642-10565de3217e, ghrun-ar5i2wnyyy.auto.internal:22743): request = { session_id: "ydb://session/3?node_id=50000&id=Nzg5NTIwMjMtNTQ5MzA0YjItMTcwZTA4NzEtNjZmOGUwODk=" 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-06 10:01:05,393 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 2803505a-608f-43c4-a642-10565de3217e, ghrun-ar5i2wnyyy.auto.internal:22743): 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-06 10:01:05,394 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f491452c1a0>
2025-11-06 10:01:05,395 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: drop table two
2025-11-06 10:01:05,395 - DEBUG - ydb.connection - _prepare_call: RpcState(DropTable, 6a7a5f73-7d74-4bdb-bbba-90e32195a81b, ghrun-ar5i2wnyyy.auto.internal:22743): creating call state
2025-11-06 10:01:05,396 - DEBUG - ydb.connection - _log_request: RpcState(DropTable, 6a7a5f73-7d74-4bdb-bbba-90e32195a81b, ghrun-ar5i2wnyyy.auto.internal:22743): request = { session_id: "ydb://session/3?node_id=50000&id=Nzg5NTIwMjMtNTQ5MzA0YjItMTcwZTA4NzEtNjZmOGUwODk=" path: "/Root/users/database/table_for_rm" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-06 10:01:05,425 - DEBUG - ydb.connection - _log_response: RpcState(DropTable, 6a7a5f73-7d74-4bdb-bbba-90e32195a81b, ghrun-ar5i2wnyyy.auto.internal:22743): response = { operation { ready: true status: SUCCESS } }
2025-11-06 10:01:05,425 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f491452c1a0>
2025-11-06 10:01:05,426 - DEBUG - ydb.table.SessionPool - stop: Requested session pool stop.
2025-11-06 10:01:05,426 - DEBUG - ydb.table.SessionPool - stop: Session pool is under stop, cancelling all in flight waiters.
2025-11-06 10:01:05,426 - DEBUG - ydb.table.SessionPool - stop: Destroying sessions in active queue
2025-11-06 10:01:05,427 - DEBUG - ydb.table.SessionPool - _destroy: Requested session destroy: <ydb.table.Session object at 0x7f491452c1a0>, reason: session-pool-terminated
2025-11-06 10:01:05,427 - DEBUG - ydb.table.SessionPool - _destroy: Session <ydb.table.Session object at 0x7f491452c1a0> is no longer active. Current active count 0.
2025-11-06 10:01:05,427 - DEBUG - ydb.connection - _prepare_call: RpcState(DeleteSession, aebf28e9-aa1d-4460-bd59-91a47a26fd10, ghrun-ar5i2wnyyy.auto.internal:22743): creating call state
2025-11-06 10:01:05,428 - DEBUG - ydb.connection - _log_request: RpcState(DeleteSession, aebf28e9-aa1d-4460-bd59-91a47a26fd10, ghrun-ar5i2wnyyy.auto.internal:22743): request = { session_id: "ydb://session/3?node_id=50000&id=Nzg5NTIwMjMtNTQ5MzA0YjItMTcwZTA4NzEtNjZmOGUwODk=" operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-11-06 10:01:05,426 - DEBUG - ydb.table.SessionPool - _terminate_event: Terminated session pool.
2025-11-06 10:01:05,434 - DEBUG - ydb.connection - _on_response_callback: RpcState(DeleteSession, aebf28e9-aa1d-4460-bd59-91a47a26fd10, ghrun-ar5i2wnyyy.auto.internal:22743): on response callback started
2025-11-06 10:01:05,435 - DEBUG - ydb.connection - _log_response: RpcState(DeleteSession, aebf28e9-aa1d-4460-bd59-91a47a26fd10, ghrun-ar5i2wnyyy.auto.internal:22743): response = { operation { ready: true status: SUCCESS } }
2025-11-06 10:01:05,435 - DEBUG - ydb.connection - _on_response_callback: RpcState(DeleteSession, aebf28e9-aa1d-4460-bd59-91a47a26fd10, ghrun-ar5i2wnyyy.auto.internal:22743): on response callback success
2025-11-06 10:01:05,436 - DEBUG - ydb.table.SessionPool - _destroy: Sent delete on session <ydb.table.Session object at 0x7f491452c1a0>
2025-11-06 10:01:05,436 - DEBUG - ydb.table.SessionPool - stop: Destroyed active sessions
2025-11-06 10:01:05,436 - DEBUG - ydb.topic - close: Close topic client
2025-11-06 10:01:05,436 - DEBUG - ydb.topic - close: Topic client was closed
2025-11-06 10:01:05,437 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:1763
2025-11-06 10:01:05,437 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-ar5i2wnyyy.auto.internal:22743
2025-11-06 10:01:05,438 - INFO - ydb.pool.Discovery - run: Successfully terminated discovery process
2025-11-06 10:01:05,438 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: remove_database
2025-11-06 10:01:05,438 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - remove_database: /Root/users/database
2025-11-06 10:01:05,439 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_send_op: /Root/users/database: send console operation, token None
2025-11-06 10:01:05,443 - 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=1762423265441505&action=2"
    }
  }
}
Status {
  Code: STATUS_CODE_UNSPECIFIED
}

2025-11-06 10:01:05,443 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/users/database: wait console operation done
2025-11-06 10:01:05,947 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/users/database: console operation done
2025-11-06 10:01:05,947 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/users/database: wait tenant gone
2025-11-06 10:01:05,950 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/users/database: tenant gone
2025-11-06 10:01:06,952 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:22743/1
2025-11-06 10:01:06,953 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: done 0
2025-11-06 10:01:06,953 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: create_database
2025-11-06 10:01:07,463 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/4esq/004cd1/ydb/apps/ydbd/ydbd
2025-11-06 10:01:07,464 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/32173
2025-11-06 10:01:07,464 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/3713
2025-11-06 10:01:07,464 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/7170
2025-11-06 10:01:07,465 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/14362
2025-11-06 10:01:07,465 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/32138
2025-11-06 10:01:07,466 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/4esq/004cd1/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-06 10:01:07,466 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/4esq/004cd1/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:1763 --tenant=/Root/users/database --log-file-name=/home/runner/.ya/build/build_root/4esq/004cd1/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_skyi1rk6.log --grpc-port=32173 --mon-port=3713 --ic-port=7170
2025-11-06 10:01:07,467 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/4esq/004cd1/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-06 10:01:07,467 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/4esq/004cd1/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:1763 --tenant=/Root/users/database --log-file-name=/home/runner/.ya/build/build_root/4esq/004cd1/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_skyi1rk6.log --grpc-port=32173 --mon-port=3713 --ic-port=7170
2025-11-06 10:01:07,469 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/4esq/004cd1/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/4esq/004cd1/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:1763', '--tenant=/Root/users/database', '--log-file-name=/home/runner/.ya/build/build_root/4esq/004cd1/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_skyi1rk6.log', '--grpc-port=32173', '--mon-port=3713', '--ic-port=7170')' in '/home/runner/.ya/build/build_root/4esq/004cd1/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-06 10:01:07,471 - DEBUG - ya.test - execute: Command pid: 791820
2025-11-06 10:01:07,471 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:32173/2
2025-11-06 10:01:07,472 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.34
2025-11-06 10:01:07,473 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.34
2025-11-06 10:01:07,474 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/4esq/004cd1/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-06 10:01:07,474 - DEBUG - ya.test - execute: Command pid: 791823
2025-11-06 10:01:07,906 - DEBUG - ya.test - _save_outputs: Command (pid 791823) rc: 0
2025-11-06 10:01:07,906 - DEBUG - ya.test - _save_outputs: Command (pid 791823) elapsed time (sec): 0.4309840202331543
2025-11-06 10:01:07,906 - DEBUG - ya.test - _save_outputs: Command (pid 791823) idrss: 0
2025-11-06 10:01:07,907 - DEBUG - ya.test - _save_outputs: Command (pid 791823) inblock: 0
2025-11-06 10:01:07,907 - DEBUG - ya.test - _save_outputs: Command (pid 791823) isrss: 0
2025-11-06 10:01:07,907 - DEBUG - ya.test - _save_outputs: Command (pid 791823) ixrss: 0
2025-11-06 10:01:07,907 - DEBUG - ya.test - _save_outputs: Command (pid 791823) majflt: 0
2025-11-06 10:01:07,907 - DEBUG - ya.test - _save_outputs: Command (pid 791823) maxrss: 538764
2025-11-06 10:01:07,907 - DEBUG - ya.test - _save_outputs: Command (pid 791823) minflt: 16131
2025-11-06 10:01:07,907 - DEBUG - ya.test - _save_outputs: Command (pid 791823) msgrcv: 0
2025-11-06 10:01:07,907 - DEBUG - ya.test - _save_outputs: Command (pid 791823) msgsnd: 0
2025-11-06 10:01:07,907 - DEBUG - ya.test - _save_outputs: Command (pid 791823) nivcsw: 22
2025-11-06 10:01:07,907 - DEBUG - ya.test - _save_outputs: Command (pid 791823) nsignals: 0
2025-11-06 10:01:07,908 - DEBUG - ya.test - _save_outputs: Command (pid 791823) nswap: 0
2025-11-06 10:01:07,908 - DEBUG - ya.test - _save_outputs: Command (pid 791823) nvcsw: 12
2025-11-06 10:01:07,908 - DEBUG - ya.test - _save_outputs: Command (pid 791823) oublock: 8
2025-11-06 10:01:07,908 - DEBUG - ya.test - _save_outputs: Command (pid 791823) stime: 0.279205
2025-11-06 10:01:07,908 - DEBUG - ya.test - _save_outputs: Command (pid 791823) utime: 0.102244
2025-11-06 10:01:07,908 - DEBUG - ya.test - _save_outputs: Command (pid 791823) wtime: 0.432
2025-11-06 10:01:07,908 - DEBUG - ya.test - _save_outputs: Command (pid 791823) output:
Git info:
    Commit: 609b3b9504bd064e40414654c1f6284791b6a66c
    Branch: 
    Author: Alek5andr-Kotov <akotov@ydb.tech>
    Summary: Merge 5af363c204fa18a6cbd8ab64fd547c3e99f1eee6 into 5ddc18e8b9ca9bdb9f539a0a3efaaf4e958f00d3

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-ar5i2wnyyy
    Host information: 
        Linux ghrun-ar5i2wnyyy 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-06 10:01:07,908 - DEBUG - ya.test - _save_outputs: Command (pid 791823) errors:

2025-11-06 10:01:07,909 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 2 version:
Git info:
    Commit: 609b3b9504bd064e40414654c1f6284791b6a66c
    Branch: 
    Author: Alek5andr-Kotov <akotov@ydb.tech>
    Summary: Merge 5af363c204fa18a6cbd8ab64fd547c3e99f1eee6 into 5ddc18e8b9ca9bdb9f539a0a3efaaf4e958f00d3
2025-11-06 10:01:07,909 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-06 10:01:07,911 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-06 10:01:07,912 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-06 10:01:07,912 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: create table one
2025-11-06 10:01:07,915 - DEBUG - ydb.table.SessionPool - subscribe: Active session queue is empty, subscribe waiter for a session
2025-11-06 10:01:07,915 - DEBUG - ydb.table.SessionPool - subscribe: Subscribe waiter <Future at 0x7f48fef1d0a0 state=pending>
2025-11-06 10:01:07,916 - DEBUG - ydb.table.SessionPool - subscribe: Session pool is not large enough (active_count < size: 0 < 1). will create a new session.
2025-11-06 10:01:07,916 - DEBUG - ydb.table.SessionPool - _create: Created session <ydb.table.Session object at 0x7f48fef1d370>
2025-11-06 10:01:07,916 - DEBUG - ydb.table.SessionPool - _prepare: Preparing session <ydb.table.Session object at 0x7f48fef1d370>
2025-11-06 10:01:07,917 - 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-06 10:01:07,920 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/users/database
2025-11-06 10:01:07,920 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 2c66c5a8-f8df-4748-b3a1-6b987964aa4a, localhost:1763): creating call state
2025-11-06 10:01:07,920 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 2c66c5a8-f8df-4748-b3a1-6b987964aa4a, localhost:1763): request = { database: "/Root/users/database" }
2025-11-06 10:01:07,922 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 2c66c5a8-f8df-4748-b3a1-6b987964aa4a, localhost:1763): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-11-06 10:01:07,923 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root/users/database. Endpoint: "localhost:1763". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-11-06 10:01:07,923 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:1763
2025-11-06 10:01:09,649 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-06 10:01:09,650 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-06 10:01:09,660 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/users/database
2025-11-06 10:01:09,661 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, e8084667-e530-4491-9f5f-b3995750e843, localhost:1763): creating call state
2025-11-06 10:01:09,661 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, e8084667-e530-4491-9f5f-b3995750e843, localhost:1763): request = { database: "/Root/users/database" }
2025-11-06 10:01:09,663 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, e8084667-e530-4491-9f5f-b3995750e843, localhost:1763): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-ar5i2wnyyy.auto.internal" port: 32173 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-06 10:01:09,664 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root/users/database: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-ar5i2wnyyy.auto.internal:32173, location , ssl: False>]>
2025-11-06 10:01:09,664 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-06 10:01:09,685 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:1763
2025-11-06 10:01:09,685 - DEBUG - ydb.table.SessionPool - _prepare: Preparing session <ydb.table.Session object at 0x7f48fef1d370>
2025-11-06 10:01:09,686 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 3d69e9f2-50d3-41cf-964b-d58dc578425f, ghrun-ar5i2wnyyy.auto.internal:32173): creating call state
2025-11-06 10:01:09,686 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 3d69e9f2-50d3-41cf-964b-d58dc578425f, ghrun-ar5i2wnyyy.auto.internal:32173): request = { operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-11-06 10:01:09,690 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, 3d69e9f2-50d3-41cf-964b-d58dc578425f, ghrun-ar5i2wnyyy.auto.internal:32173): on response callback started
2025-11-06 10:01:09,691 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 3d69e9f2-50d3-41cf-964b-d58dc578425f, ghrun-ar5i2wnyyy.auto.internal:32173): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=50001&id=YjFmMzA3YTgtZTY2MzBiZmQtODA4NDlkNGMtNjkyZmRmYWY=" } } } }
2025-11-06 10:01:09,691 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f48fef1d370>
2025-11-06 10:01:09,691 - DEBUG - ydb.table.SessionPool - put: Replying to waiter with a session <ydb.table.Session object at 0x7f48fef1d370>
2025-11-06 10:01:09,691 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, 3d69e9f2-50d3-41cf-964b-d58dc578425f, ghrun-ar5i2wnyyy.auto.internal:32173): on response callback success
2025-11-06 10:01:09,696 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, a74c0b35-84ae-4415-a8a0-5b37fa689fd7, ghrun-ar5i2wnyyy.auto.internal:32173): creating call state
2025-11-06 10:01:09,697 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, a74c0b35-84ae-4415-a8a0-5b37fa689fd7, ghrun-ar5i2wnyyy.auto.internal:32173): request = { session_id: "ydb://session/3?node_id=50001&id=YjFmMzA3YTgtZTY2MzBiZmQtODA4NDlkNGMtNjkyZmRmYWY=" 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-06 10:01:09,737 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, a74c0b35-84ae-4415-a8a0-5b37fa689fd7, ghrun-ar5i2wnyyy.auto.internal:32173): response = { operation { ready: true status: SUCCESS } }
2025-11-06 10:01:09,737 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f48fef1d370>
2025-11-06 10:01:09,737 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: create table two
2025-11-06 10:01:09,738 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 8e2f5f99-8ede-473d-811e-91314bd9bacc, ghrun-ar5i2wnyyy.auto.internal:32173): creating call state
2025-11-06 10:01:09,739 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 8e2f5f99-8ede-473d-811e-91314bd9bacc, ghrun-ar5i2wnyyy.auto.internal:32173): request = { session_id: "ydb://session/3?node_id=50001&id=YjFmMzA3YTgtZTY2MzBiZmQtODA4NDlkNGMtNjkyZmRmYWY=" 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-06 10:01:09,783 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 8e2f5f99-8ede-473d-811e-91314bd9bacc, ghrun-ar5i2wnyyy.auto.internal:32173): response = { operation { ready: true status: SUCCESS } }
2025-11-06 10:01:09,783 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f48fef1d370>
2025-11-06 10:01:09,784 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: write_some_data
2025-11-06 10:01:09,784 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 4179ace6-e367-49e2-8737-e99e73e9c719, ghrun-ar5i2wnyyy.auto.internal:32173): creating call state
2025-11-06 10:01:09,785 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 4179ace6-e367-49e2-8737-e99e73e9c719, ghrun-ar5i2wnyyy.auto.internal:32173): request = { session_id: "ydb://session/3?node_id=50001&id=YjFmMzA3YTgtZTY2MzBiZmQtODA4NDlkNGMtNjkyZmRmYWY=" 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-06 10:01:09,812 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 4179ace6-e367-49e2-8737-e99e73e9c719, ghrun-ar5i2wnyyy.auto.internal:32173): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-11-06 10:01:09,813 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f48fef1d370>
2025-11-06 10:01:09,813 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: read_some_data
2025-11-06 10:01:09,814 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, d89ffe34-652c-42c3-badb-3dd48a2ed2ba, ghrun-ar5i2wnyyy.auto.internal:32173): creating call state
2025-11-06 10:01:09,814 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, d89ffe34-652c-42c3-badb-3dd48a2ed2ba, ghrun-ar5i2wnyyy.auto.internal:32173): request = { session_id: "ydb://session/3?node_id=50001&id=YjFmMzA3YTgtZTY2MzBiZmQtODA4NDlkNGMtNjkyZmRmYWY=" 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-06 10:01:09,853 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, d89ffe34-652c-42c3-badb-3dd48a2ed2ba, ghrun-ar5i2wnyyy.auto.internal:32173): 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-06 10:01:09,855 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f48fef1d370>
2025-11-06 10:01:09,857 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: drop table two
2025-11-06 10:01:09,858 - DEBUG - ydb.connection - _prepare_call: RpcState(DropTable, 5982463d-5952-4bdf-a9d5-14cb776d74fd, ghrun-ar5i2wnyyy.auto.internal:32173): creating call state
2025-11-06 10:01:09,858 - DEBUG - ydb.connection - _log_request: RpcState(DropTable, 5982463d-5952-4bdf-a9d5-14cb776d74fd, ghrun-ar5i2wnyyy.auto.internal:32173): request = { session_id: "ydb://session/3?node_id=50001&id=YjFmMzA3YTgtZTY2MzBiZmQtODA4NDlkNGMtNjkyZmRmYWY=" path: "/Root/users/database/table_for_rm" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-06 10:01:09,882 - DEBUG - ydb.connection - _log_response: RpcState(DropTable, 5982463d-5952-4bdf-a9d5-14cb776d74fd, ghrun-ar5i2wnyyy.auto.internal:32173): response = { operation { ready: true status: SUCCESS } }
2025-11-06 10:01:09,882 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f48fef1d370>
2025-11-06 10:01:09,883 - DEBUG - ydb.table.SessionPool - stop: Requested session pool stop.
2025-11-06 10:01:09,883 - DEBUG - ydb.table.SessionPool - stop: Session pool is under stop, cancelling all in flight waiters.
2025-11-06 10:01:09,883 - DEBUG - ydb.table.SessionPool - _terminate_event: Terminated session pool.
2025-11-06 10:01:09,884 - DEBUG - ydb.table.SessionPool - stop: Destroying sessions in active queue
2025-11-06 10:01:09,884 - DEBUG - ydb.table.SessionPool - _destroy: Requested session destroy: <ydb.table.Session object at 0x7f48fef1d370>, reason: session-pool-terminated
2025-11-06 10:01:09,885 - DEBUG - ydb.table.SessionPool - _destroy: Session <ydb.table.Session object at 0x7f48fef1d370> is no longer active. Current active count 0.
2025-11-06 10:01:09,885 - DEBUG - ydb.connection - _prepare_call: RpcState(DeleteSession, 99a6ee29-4b48-4733-8da4-6e422ec020eb, ghrun-ar5i2wnyyy.auto.internal:32173): creating call state
2025-11-06 10:01:09,885 - DEBUG - ydb.connection - _log_request: RpcState(DeleteSession, 99a6ee29-4b48-4733-8da4-6e422ec020eb, ghrun-ar5i2wnyyy.auto.internal:32173): request = { session_id: "ydb://session/3?node_id=50001&id=YjFmMzA3YTgtZTY2MzBiZmQtODA4NDlkNGMtNjkyZmRmYWY=" operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-11-06 10:01:09,892 - DEBUG - ydb.table.SessionPool - _destroy: Sent delete on session <ydb.table.Session object at 0x7f48fef1d370>
2025-11-06 10:01:09,893 - DEBUG - ydb.table.SessionPool - stop: Destroyed active sessions
2025-11-06 10:01:09,893 - DEBUG - ydb.connection - _on_response_callback: RpcState(DeleteSession, 99a6ee29-4b48-4733-8da4-6e422ec020eb, ghrun-ar5i2wnyyy.auto.internal:32173): on response callback started
2025-11-06 10:01:09,893 - DEBUG - ydb.topic - close: Close topic client
2025-11-06 10:01:09,894 - DEBUG - ydb.connection - _log_response: RpcState(DeleteSession, 99a6ee29-4b48-4733-8da4-6e422ec020eb, ghrun-ar5i2wnyyy.auto.internal:32173): response = { operation { ready: true status: SUCCESS } }
2025-11-06 10:01:09,894 - DEBUG - ydb.topic - close: Topic client was closed
2025-11-06 10:01:09,895 - DEBUG - ydb.connection - _on_response_callback: RpcState(DeleteSession, 99a6ee29-4b48-4733-8da4-6e422ec020eb, ghrun-ar5i2wnyyy.auto.internal:32173): on response callback success
2025-11-06 10:01:09,895 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:1763
2025-11-06 10:01:09,895 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-ar5i2wnyyy.auto.internal:32173
2025-11-06 10:01:09,897 - INFO - ydb.pool.Discovery - run: Successfully terminated discovery process
2025-11-06 10:01:09,897 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: remove_database
2025-11-06 10:01:09,898 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - remove_database: /Root/users/database
2025-11-06 10:01:09,898 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_send_op: /Root/users/database: send console operation, token None
2025-11-06 10:01:09,906 - 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=1762423269900557&action=2"
    }
  }
}
Status {
  Code: STATUS_CODE_UNSPECIFIED
}

2025-11-06 10:01:09,907 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/users/database: wait console operation done
2025-11-06 10:01:10,410 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/users/database: console operation done
2025-11-06 10:01:10,411 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/users/database: wait tenant gone
2025-11-06 10:01:10,413 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/users/database: tenant gone
2025-11-06 10:01:11,414 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:32173/2
2025-11-06 10:01:11,414 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: done 1
2025-11-06 10:01:11,414 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: create_database
2025-11-06 10:01:11,930 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/4esq/004cd1/ydb/apps/ydbd/ydbd
2025-11-06 10:01:11,931 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/14785
2025-11-06 10:01:11,931 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/18869
2025-11-06 10:01:11,931 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/16890
2025-11-06 10:01:11,932 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/6515
2025-11-06 10:01:11,932 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/5739
2025-11-06 10:01:11,933 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/4esq/004cd1/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-06 10:01:11,933 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/4esq/004cd1/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:1763 --tenant=/Root/users/database --log-file-name=/home/runner/.ya/build/build_root/4esq/004cd1/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_0jq5uq1y.log --grpc-port=14785 --mon-port=18869 --ic-port=16890
2025-11-06 10:01:11,933 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/4esq/004cd1/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-06 10:01:11,933 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/4esq/004cd1/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:1763 --tenant=/Root/users/database --log-file-name=/home/runner/.ya/build/build_root/4esq/004cd1/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_0jq5uq1y.log --grpc-port=14785 --mon-port=18869 --ic-port=16890
2025-11-06 10:01:11,934 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/4esq/004cd1/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/4esq/004cd1/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:1763', '--tenant=/Root/users/database', '--log-file-name=/home/runner/.ya/build/build_root/4esq/004cd1/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_0jq5uq1y.log', '--grpc-port=14785', '--mon-port=18869', '--ic-port=16890')' in '/home/runner/.ya/build/build_root/4esq/004cd1/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-06 10:01:11,936 - DEBUG - ya.test - execute: Command pid: 800970
2025-11-06 10:01:11,936 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:14785/3
2025-11-06 10:01:11,938 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.35
2025-11-06 10:01:11,939 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.35
2025-11-06 10:01:11,939 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/4esq/004cd1/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-06 10:01:11,940 - DEBUG - ya.test - execute: Command pid: 800996
2025-11-06 10:01:12,314 - DEBUG - ya.test - _save_outputs: Command (pid 800996) rc: 0
2025-11-06 10:01:12,314 - DEBUG - ya.test - _save_outputs: Command (pid 800996) elapsed time (sec): 0.3732888698577881
2025-11-06 10:01:12,315 - DEBUG - ya.test - _save_outputs: Command (pid 800996) idrss: 0
2025-11-06 10:01:12,315 - DEBUG - ya.test - _save_outputs: Command (pid 800996) inblock: 0
2025-11-06 10:01:12,315 - DEBUG - ya.test - _save_outputs: Command (pid 800996) isrss: 0
2025-11-06 10:01:12,315 - DEBUG - ya.test - _save_outputs: Command (pid 800996) ixrss: 0
2025-11-06 10:01:12,315 - DEBUG - ya.test - _save_outputs: Command (pid 800996) majflt: 0
2025-11-06 10:01:12,316 - DEBUG - ya.test - _save_outputs: Command (pid 800996) maxrss: 538828
2025-11-06 10:01:12,316 - DEBUG - ya.test - _save_outputs: Command (pid 800996) minflt: 17460
2025-11-06 10:01:12,316 - DEBUG - ya.test - _save_outputs: Command (pid 800996) msgrcv: 0
2025-11-06 10:01:12,316 - DEBUG - ya.test - _save_outputs: Command (pid 800996) msgsnd: 0
2025-11-06 10:01:12,316 - DEBUG - ya.test - _save_outputs: Command (pid 800996) nivcsw: 15
2025-11-06 10:01:12,316 - DEBUG - ya.test - _save_outputs: Command (pid 800996) nsignals: 0
2025-11-06 10:01:12,317 - DEBUG - ya.test - _save_outputs: Command (pid 800996) nswap: 0
2025-11-06 10:01:12,317 - DEBUG - ya.test - _save_outputs: Command (pid 800996) nvcsw: 17
2025-11-06 10:01:12,317 - DEBUG - ya.test - _save_outputs: Command (pid 800996) oublock: 8
2025-11-06 10:01:12,317 - DEBUG - ya.test - _save_outputs: Command (pid 800996) stime: 0.213286
2025-11-06 10:01:12,317 - DEBUG - ya.test - _save_outputs: Command (pid 800996) utime: 0.110785
2025-11-06 10:01:12,317 - DEBUG - ya.test - _save_outputs: Command (pid 800996) wtime: 0.374
2025-11-06 10:01:12,318 - DEBUG - ya.test - _save_outputs: Command (pid 800996) output:
Git info:
    Commit: 609b3b9504bd064e40414654c1f6284791b6a66c
    Branch: 
    Author: Alek5andr-Kotov <akotov@ydb.tech>
    Summary: Merge 5af363c204fa18a6cbd8ab64fd547c3e99f1eee6 into 5ddc18e8b9ca9bdb9f539a0a3efaaf4e958f00d3

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-ar5i2wnyyy
    Host information: 
        Linux ghrun-ar5i2wnyyy 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-06 10:01:12,318 - DEBUG - ya.test - _save_outputs: Command (pid 800996) errors:

2025-11-06 10:01:12,318 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 3 version:
Git info:
    Commit: 609b3b9504bd064e40414654c1f6284791b6a66c
    Branch: 
    Author: Alek5andr-Kotov <akotov@ydb.tech>
    Summary: Merge 5af363c204fa18a6cbd8ab64fd547c3e99f1eee6 into 5ddc18e8b9ca9bdb9f539a0a3efaaf4e958f00d3
2025-11-06 10:01:12,319 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-06 10:01:12,321 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-06 10:01:12,322 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-06 10:01:12,322 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: create table one
2025-11-06 10:01:12,325 - DEBUG - ydb.table.SessionPool - subscribe: Active session queue is empty, subscribe waiter for a session
2025-11-06 10:01:12,326 - DEBUG - ydb.table.SessionPool - subscribe: Subscribe waiter <Future at 0x7f49148212d0 state=pending>
2025-11-06 10:01:12,326 - DEBUG - ydb.table.SessionPool - subscribe: Session pool is not large enough (active_count < size: 0 < 1). will create a new session.
2025-11-06 10:01:12,326 - DEBUG - ydb.table.SessionPool - _create: Created session <ydb.table.Session object at 0x7f4914820b50>
2025-11-06 10:01:12,327 - DEBUG - ydb.table.SessionPool - _prepare: Preparing session <ydb.table.Session object at 0x7f4914820b50>
2025-11-06 10:01:12,327 - 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-06 10:01:12,329 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/users/database
2025-11-06 10:01:12,329 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 13de99c4-cf97-4564-a8dd-0c76ccd59657, localhost:1763): creating call state
2025-11-06 10:01:12,332 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 13de99c4-cf97-4564-a8dd-0c76ccd59657, localhost:1763): request = { database: "/Root/users/database" }
2025-11-06 10:01:12,334 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 13de99c4-cf97-4564-a8dd-0c76ccd59657, localhost:1763): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-11-06 10:01:12,334 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root/users/database. Endpoint: "localhost:1763". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-11-06 10:01:12,334 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:1763
2025-11-06 10:01:13,759 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-06 10:01:13,759 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-06 10:01:13,765 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/users/database
2025-11-06 10:01:13,765 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, a97047c8-0f53-421f-b1e3-b13bc9324ee9, localhost:1763): creating call state
2025-11-06 10:01:13,766 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, a97047c8-0f53-421f-b1e3-b13bc9324ee9, localhost:1763): request = { database: "/Root/users/database" }
2025-11-06 10:01:13,768 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, a97047c8-0f53-421f-b1e3-b13bc9324ee9, localhost:1763): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-ar5i2wnyyy.auto.internal" port: 14785 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-06 10:01:13,769 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root/users/database: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-ar5i2wnyyy.auto.internal:14785, location , ssl: False>]>
2025-11-06 10:01:13,769 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-06 10:01:13,776 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:1763
2025-11-06 10:01:13,776 - DEBUG - ydb.table.SessionPool - _prepare: Preparing session <ydb.table.Session object at 0x7f4914820b50>
2025-11-06 10:01:13,777 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 3086e3ee-ea3f-4b73-876d-3d02149227c8, ghrun-ar5i2wnyyy.auto.internal:14785): creating call state
2025-11-06 10:01:13,777 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 3086e3ee-ea3f-4b73-876d-3d02149227c8, ghrun-ar5i2wnyyy.auto.internal:14785): request = { operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-11-06 10:01:13,780 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, 3086e3ee-ea3f-4b73-876d-3d02149227c8, ghrun-ar5i2wnyyy.auto.internal:14785): on response callback started
2025-11-06 10:01:13,780 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 3086e3ee-ea3f-4b73-876d-3d02149227c8, ghrun-ar5i2wnyyy.auto.internal:14785): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=50002&id=Mjc3NDhhZjYtNDZkNDQ4My0yMzkyZjAzZS0xYTE3ODZiZQ==" } } } }
2025-11-06 10:01:13,781 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f4914820b50>
2025-11-06 10:01:13,781 - DEBUG - ydb.table.SessionPool - put: Replying to waiter with a session <ydb.table.Session object at 0x7f4914820b50>
2025-11-06 10:01:13,781 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, 3086e3ee-ea3f-4b73-876d-3d02149227c8, ghrun-ar5i2wnyyy.auto.internal:14785): on response callback success
2025-11-06 10:01:13,781 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, cd93e28a-bcaf-46bb-82a8-db1675b5b744, ghrun-ar5i2wnyyy.auto.internal:14785): creating call state
2025-11-06 10:01:13,782 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, cd93e28a-bcaf-46bb-82a8-db1675b5b744, ghrun-ar5i2wnyyy.auto.internal:14785): request = { session_id: "ydb://session/3?node_id=50002&id=Mjc3NDhhZjYtNDZkNDQ4My0yMzkyZjAzZS0xYTE3ODZiZQ==" 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-06 10:01:13,827 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, cd93e28a-bcaf-46bb-82a8-db1675b5b744, ghrun-ar5i2wnyyy.auto.internal:14785): response = { operation { ready: true status: SUCCESS } }
2025-11-06 10:01:13,828 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f4914820b50>
2025-11-06 10:01:13,828 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: create table two
2025-11-06 10:01:13,829 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 34e6ca91-96dd-4c8e-8f59-aac7bfd8f731, ghrun-ar5i2wnyyy.auto.internal:14785): creating call state
2025-11-06 10:01:13,829 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 34e6ca91-96dd-4c8e-8f59-aac7bfd8f731, ghrun-ar5i2wnyyy.auto.internal:14785): request = { session_id: "ydb://session/3?node_id=50002&id=Mjc3NDhhZjYtNDZkNDQ4My0yMzkyZjAzZS0xYTE3ODZiZQ==" 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-06 10:01:13,868 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 34e6ca91-96dd-4c8e-8f59-aac7bfd8f731, ghrun-ar5i2wnyyy.auto.internal:14785): response = { operation { ready: true status: SUCCESS } }
2025-11-06 10:01:13,869 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f4914820b50>
2025-11-06 10:01:13,869 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: write_some_data
2025-11-06 10:01:13,870 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 2b5e9820-efaf-41fb-81ca-e92d4552e19d, ghrun-ar5i2wnyyy.auto.internal:14785): creating call state
2025-11-06 10:01:13,870 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 2b5e9820-efaf-41fb-81ca-e92d4552e19d, ghrun-ar5i2wnyyy.auto.internal:14785): request = { session_id: "ydb://session/3?node_id=50002&id=Mjc3NDhhZjYtNDZkNDQ4My0yMzkyZjAzZS0xYTE3ODZiZQ==" 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-06 10:01:14,001 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 2b5e9820-efaf-41fb-81ca-e92d4552e19d, ghrun-ar5i2wnyyy.auto.internal:14785): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-11-06 10:01:14,002 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f4914820b50>
2025-11-06 10:01:14,002 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: read_some_data
2025-11-06 10:01:14,002 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 0a808a7a-0903-43fa-921c-cdabd77251f1, ghrun-ar5i2wnyyy.auto.internal:14785): creating call state
2025-11-06 10:01:14,003 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 0a808a7a-0903-43fa-921c-cdabd77251f1, ghrun-ar5i2wnyyy.auto.internal:14785): request = { session_id: "ydb://session/3?node_id=50002&id=Mjc3NDhhZjYtNDZkNDQ4My0yMzkyZjAzZS0xYTE3ODZiZQ==" 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-06 10:01:14,042 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 0a808a7a-0903-43fa-921c-cdabd77251f1, ghrun-ar5i2wnyyy.auto.internal:14785): 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-06 10:01:14,042 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f4914820b50>
2025-11-06 10:01:14,043 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: drop table two
2025-11-06 10:01:14,043 - DEBUG - ydb.connection - _prepare_call: RpcState(DropTable, d8e9b7d7-274a-4927-b7af-a35b50f3cbe2, ghrun-ar5i2wnyyy.auto.internal:14785): creating call state
2025-11-06 10:01:14,044 - DEBUG - ydb.connection - _log_request: RpcState(DropTable, d8e9b7d7-274a-4927-b7af-a35b50f3cbe2, ghrun-ar5i2wnyyy.auto.internal:14785): request = { session_id: "ydb://session/3?node_id=50002&id=Mjc3NDhhZjYtNDZkNDQ4My0yMzkyZjAzZS0xYTE3ODZiZQ==" path: "/Root/users/database/table_for_rm" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-06 10:01:14,074 - DEBUG - ydb.connection - _log_response: RpcState(DropTable, d8e9b7d7-274a-4927-b7af-a35b50f3cbe2, ghrun-ar5i2wnyyy.auto.internal:14785): response = { operation { ready: true status: SUCCESS } }
2025-11-06 10:01:14,075 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f4914820b50>
2025-11-06 10:01:14,075 - DEBUG - ydb.table.SessionPool - stop: Requested session pool stop.
2025-11-06 10:01:14,075 - DEBUG - ydb.table.SessionPool - stop: Session pool is under stop, cancelling all in flight waiters.
2025-11-06 10:01:14,075 - DEBUG - ydb.table.SessionPool - _terminate_event: Terminated session pool.
2025-11-06 10:01:14,075 - DEBUG - ydb.table.SessionPool - stop: Destroying sessions in active queue
2025-11-06 10:01:14,076 - DEBUG - ydb.table.SessionPool - _destroy: Requested session destroy: <ydb.table.Session object at 0x7f4914820b50>, reason: session-pool-terminated
2025-11-06 10:01:14,076 - DEBUG - ydb.table.SessionPool - _destroy: Session <ydb.table.Session object at 0x7f4914820b50> is no longer active. Current active count 0.
2025-11-06 10:01:14,076 - DEBUG - ydb.connection - _prepare_call: RpcState(DeleteSession, 7096eb94-6a7a-434e-aea6-74c88e12ecea, ghrun-ar5i2wnyyy.auto.internal:14785): creating call state
2025-11-06 10:01:14,077 - DEBUG - ydb.connection - _log_request: RpcState(DeleteSession, 7096eb94-6a7a-434e-aea6-74c88e12ecea, ghrun-ar5i2wnyyy.auto.internal:14785): request = { session_id: "ydb://session/3?node_id=50002&id=Mjc3NDhhZjYtNDZkNDQ4My0yMzkyZjAzZS0xYTE3ODZiZQ==" operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-11-06 10:01:14,078 - DEBUG - ydb.table.SessionPool - _destroy: Sent delete on session <ydb.table.Session object at 0x7f4914820b50>
2025-11-06 10:01:14,078 - DEBUG - ydb.table.SessionPool - stop: Destroyed active sessions
2025-11-06 10:01:14,078 - DEBUG - ydb.topic - close: Close topic client
2025-11-06 10:01:14,079 - DEBUG - ydb.connection - _on_response_callback: RpcState(DeleteSession, 7096eb94-6a7a-434e-aea6-74c88e12ecea, ghrun-ar5i2wnyyy.auto.internal:14785): on response callback started
2025-11-06 10:01:14,079 - DEBUG - ydb.topic - close: Topic client was closed
2025-11-06 10:01:14,079 - DEBUG - ydb.connection - _log_response: RpcState(DeleteSession, 7096eb94-6a7a-434e-aea6-74c88e12ecea, ghrun-ar5i2wnyyy.auto.internal:14785): response = { operation { ready: true status: SUCCESS } }
2025-11-06 10:01:14,080 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:1763
2025-11-06 10:01:14,080 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-ar5i2wnyyy.auto.internal:14785
2025-11-06 10:01:14,081 - DEBUG - ydb.connection - _on_response_callback: RpcState(DeleteSession, 7096eb94-6a7a-434e-aea6-74c88e12ecea, ghrun-ar5i2wnyyy.auto.internal:14785): on response callback success
2025-11-06 10:01:14,082 - INFO - ydb.pool.Discovery - run: Successfully terminated discovery process
2025-11-06 10:01:14,083 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: remove_database
2025-11-06 10:01:14,083 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - remove_database: /Root/users/database
2025-11-06 10:01:14,083 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_send_op: /Root/users/database: send console operation, token None
2025-11-06 10:01:14,088 - 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=1762423274086088&action=2"
    }
  }
}
Status {
  Code: STATUS_CODE_UNSPECIFIED
}

2025-11-06 10:01:14,088 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/users/database: wait console operation done
2025-11-06 10:01:14,592 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/users/database: console operation done
2025-11-06 10:01:14,592 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/users/database: wait tenant gone
2025-11-06 10:01:14,595 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/users/database: tenant gone
2025-11-06 10:01:15,595 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:14785/3
2025-11-06 10:01:15,596 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: done 2
2025-11-06 10:01:15,596 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: create_database
2025-11-06 10:01:16,106 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/4esq/004cd1/ydb/apps/ydbd/ydbd
2025-11-06 10:01:16,107 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/13164
2025-11-06 10:01:16,107 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/11115
2025-11-06 10:01:16,107 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/9033
2025-11-06 10:01:16,108 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/14562
2025-11-06 10:01:16,108 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/3765
2025-11-06 10:01:16,108 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/4esq/004cd1/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-06 10:01:16,109 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/4esq/004cd1/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:1763 --tenant=/Root/users/database --log-file-name=/home/runner/.ya/build/build_root/4esq/004cd1/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_suctflng.log --grpc-port=13164 --mon-port=11115 --ic-port=9033
2025-11-06 10:01:16,109 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/4esq/004cd1/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-06 10:01:16,109 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/4esq/004cd1/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:1763 --tenant=/Root/users/database --log-file-name=/home/runner/.ya/build/build_root/4esq/004cd1/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_suctflng.log --grpc-port=13164 --mon-port=11115 --ic-port=9033
2025-11-06 10:01:16,110 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/4esq/004cd1/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/4esq/004cd1/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:1763', '--tenant=/Root/users/database', '--log-file-name=/home/runner/.ya/build/build_root/4esq/004cd1/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_suctflng.log', '--grpc-port=13164', '--mon-port=11115', '--ic-port=9033')' in '/home/runner/.ya/build/build_root/4esq/004cd1/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-06 10:01:16,111 - DEBUG - ya.test - execute: Command pid: 808411
2025-11-06 10:01:16,112 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:13164/4
2025-11-06 10:01:16,113 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.36
2025-11-06 10:01:16,114 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.36
2025-11-06 10:01:16,114 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/4esq/004cd1/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-06 10:01:16,115 - DEBUG - ya.test - execute: Command pid: 808414
2025-11-06 10:01:16,487 - DEBUG - ya.test - _save_outputs: Command (pid 808414) rc: 0
2025-11-06 10:01:16,488 - DEBUG - ya.test - _save_outputs: Command (pid 808414) elapsed time (sec): 0.371903657913208
2025-11-06 10:01:16,488 - DEBUG - ya.test - _save_outputs: Command (pid 808414) idrss: 0
2025-11-06 10:01:16,488 - DEBUG - ya.test - _save_outputs: Command (pid 808414) inblock: 0
2025-11-06 10:01:16,488 - DEBUG - ya.test - _save_outputs: Command (pid 808414) isrss: 0
2025-11-06 10:01:16,488 - DEBUG - ya.test - _save_outputs: Command (pid 808414) ixrss: 0
2025-11-06 10:01:16,489 - DEBUG - ya.test - _save_outputs: Command (pid 808414) majflt: 1
2025-11-06 10:01:16,489 - DEBUG - ya.test - _save_outputs: Command (pid 808414) maxrss: 538800
2025-11-06 10:01:16,489 - DEBUG - ya.test - _save_outputs: Command (pid 808414) minflt: 16428
2025-11-06 10:01:16,489 - DEBUG - ya.test - _save_outputs: Command (pid 808414) msgrcv: 0
2025-11-06 10:01:16,489 - DEBUG - ya.test - _save_outputs: Command (pid 808414) msgsnd: 0
2025-11-06 10:01:16,489 - DEBUG - ya.test - _save_outputs: Command (pid 808414) nivcsw: 8
2025-11-06 10:01:16,489 - DEBUG - ya.test - _save_outputs: Command (pid 808414) nsignals: 0
2025-11-06 10:01:16,490 - DEBUG - ya.test - _save_outputs: Command (pid 808414) nswap: 0
2025-11-06 10:01:16,490 - DEBUG - ya.test - _save_outputs: Command (pid 808414) nvcsw: 16
2025-11-06 10:01:16,490 - DEBUG - ya.test - _save_outputs: Command (pid 808414) oublock: 8
2025-11-06 10:01:16,490 - DEBUG - ya.test - _save_outputs: Command (pid 808414) stime: 0.22098299999999998
2025-11-06 10:01:16,490 - DEBUG - ya.test - _save_outputs: Command (pid 808414) utime: 0.102599
2025-11-06 10:01:16,490 - DEBUG - ya.test - _save_outputs: Command (pid 808414) wtime: 0.373
2025-11-06 10:01:16,490 - DEBUG - ya.test - _save_outputs: Command (pid 808414) output:
Git info:
    Commit: 609b3b9504bd064e40414654c1f6284791b6a66c
    Branch: 
    Author: Alek5andr-Kotov <akotov@ydb.tech>
    Summary: Merge 5af363c204fa18a6cbd8ab64fd547c3e99f1eee6 into 5ddc18e8b9ca9bdb9f539a0a3efaaf4e958f00d3

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-ar5i2wnyyy
    Host information: 
        Linux ghrun-ar5i2wnyyy 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-06 10:01:16,490 - DEBUG - ya.test - _save_outputs: Command (pid 808414) errors:

2025-11-06 10:01:16,491 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 4 version:
Git info:
    Commit: 609b3b9504bd064e40414654c1f6284791b6a66c
    Branch: 
    Author: Alek5andr-Kotov <akotov@ydb.tech>
    Summary: Merge 5af363c204fa18a6cbd8ab64fd547c3e99f1eee6 into 5ddc18e8b9ca9bdb9f539a0a3efaaf4e958f00d3
2025-11-06 10:01:16,491 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-06 10:01:16,493 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-06 10:01:16,494 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: create table one
2025-11-06 10:01:16,494 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-06 10:01:16,494 - DEBUG - ydb.table.SessionPool - subscribe: Active session queue is empty, subscribe waiter for a session
2025-11-06 10:01:16,497 - DEBUG - ydb.table.SessionPool - subscribe: Subscribe waiter <Future at 0x7f4912989820 state=pending>
2025-11-06 10:01:16,498 - DEBUG - ydb.table.SessionPool - subscribe: Session pool is not large enough (active_count < size: 0 < 1). will create a new session.
2025-11-06 10:01:16,498 - DEBUG - ydb.table.SessionPool - _create: Created session <ydb.table.Session object at 0x7f4912989f00>
2025-11-06 10:01:16,498 - DEBUG - ydb.table.SessionPool - _prepare: Preparing session <ydb.table.Session object at 0x7f4912989f00>
2025-11-06 10:01:16,499 - 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-06 10:01:16,500 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/users/database
2025-11-06 10:01:16,500 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, b8eebc2c-c02f-4d18-b289-71c6dc55848f, localhost:1763): creating call state
2025-11-06 10:01:16,500 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, b8eebc2c-c02f-4d18-b289-71c6dc55848f, localhost:1763): request = { database: "/Root/users/database" }
2025-11-06 10:01:16,502 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, b8eebc2c-c02f-4d18-b289-71c6dc55848f, localhost:1763): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-11-06 10:01:16,503 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root/users/database. Endpoint: "localhost:1763". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-11-06 10:01:16,503 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:1763
2025-11-06 10:01:18,672 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-06 10:01:18,673 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-06 10:01:18,677 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/users/database
2025-11-06 10:01:18,678 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 7fd26970-5eb1-457b-83b5-cf9a7bc30a39, localhost:1763): creating call state
2025-11-06 10:01:18,678 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 7fd26970-5eb1-457b-83b5-cf9a7bc30a39, localhost:1763): request = { database: "/Root/users/database" }
2025-11-06 10:01:18,680 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 7fd26970-5eb1-457b-83b5-cf9a7bc30a39, localhost:1763): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-ar5i2wnyyy.auto.internal" port: 13164 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-06 10:01:18,681 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root/users/database: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-ar5i2wnyyy.auto.internal:13164, location , ssl: False>]>
2025-11-06 10:01:18,681 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-06 10:01:18,687 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:1763
2025-11-06 10:01:18,688 - DEBUG - ydb.table.SessionPool - _prepare: Preparing session <ydb.table.Session object at 0x7f4912989f00>
2025-11-06 10:01:18,689 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, e15bc68a-7026-40ad-b830-a27641bae349, ghrun-ar5i2wnyyy.auto.internal:13164): creating call state
2025-11-06 10:01:18,689 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, e15bc68a-7026-40ad-b830-a27641bae349, ghrun-ar5i2wnyyy.auto.internal:13164): request = { operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-11-06 10:01:18,692 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, e15bc68a-7026-40ad-b830-a27641bae349, ghrun-ar5i2wnyyy.auto.internal:13164): on response callback started
2025-11-06 10:01:18,692 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, e15bc68a-7026-40ad-b830-a27641bae349, ghrun-ar5i2wnyyy.auto.internal:13164): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=50003&id=Yjk0Y2EzOWYtNDY2MDI3OGYtMjk3OWM2M2ItNWY1OTljYTI=" } } } }
2025-11-06 10:01:18,692 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f4912989f00>
2025-11-06 10:01:18,693 - DEBUG - ydb.table.SessionPool - put: Replying to waiter with a session <ydb.table.Session object at 0x7f4912989f00>
2025-11-06 10:01:18,693 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, e15bc68a-7026-40ad-b830-a27641bae349, ghrun-ar5i2wnyyy.auto.internal:13164): on response callback success
2025-11-06 10:01:18,693 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, d35a8933-b2d5-415a-8aa1-438bda4a171f, ghrun-ar5i2wnyyy.auto.internal:13164): creating call state
2025-11-06 10:01:18,694 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, d35a8933-b2d5-415a-8aa1-438bda4a171f, ghrun-ar5i2wnyyy.auto.internal:13164): request = { session_id: "ydb://session/3?node_id=50003&id=Yjk0Y2EzOWYtNDY2MDI3OGYtMjk3OWM2M2ItNWY1OTljYTI=" 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-06 10:01:18,730 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, d35a8933-b2d5-415a-8aa1-438bda4a171f, ghrun-ar5i2wnyyy.auto.internal:13164): response = { operation { ready: true status: SUCCESS } }
2025-11-06 10:01:18,731 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f4912989f00>
2025-11-06 10:01:18,731 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: create table two
2025-11-06 10:01:18,731 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, ca2e638c-822e-4d44-be23-92e8a9a373f7, ghrun-ar5i2wnyyy.auto.internal:13164): creating call state
2025-11-06 10:01:18,732 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, ca2e638c-822e-4d44-be23-92e8a9a373f7, ghrun-ar5i2wnyyy.auto.internal:13164): request = { session_id: "ydb://session/3?node_id=50003&id=Yjk0Y2EzOWYtNDY2MDI3OGYtMjk3OWM2M2ItNWY1OTljYTI=" 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-06 10:01:18,756 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, ca2e638c-822e-4d44-be23-92e8a9a373f7, ghrun-ar5i2wnyyy.auto.internal:13164): response = { operation { ready: true status: SUCCESS } }
2025-11-06 10:01:18,756 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f4912989f00>
2025-11-06 10:01:18,756 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: write_some_data
2025-11-06 10:01:18,757 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 89ff5f41-a37d-47a5-a6d3-708ca78fb316, ghrun-ar5i2wnyyy.auto.internal:13164): creating call state
2025-11-06 10:01:18,758 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 89ff5f41-a37d-47a5-a6d3-708ca78fb316, ghrun-ar5i2wnyyy.auto.internal:13164): request = { session_id: "ydb://session/3?node_id=50003&id=Yjk0Y2EzOWYtNDY2MDI3OGYtMjk3OWM2M2ItNWY1OTljYTI=" 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-06 10:01:18,789 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 89ff5f41-a37d-47a5-a6d3-708ca78fb316, ghrun-ar5i2wnyyy.auto.internal:13164): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-11-06 10:01:18,790 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f4912989f00>
2025-11-06 10:01:18,790 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: read_some_data
2025-11-06 10:01:18,791 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 454eb14f-c7b7-4d87-a5c9-906c3c3a686c, ghrun-ar5i2wnyyy.auto.internal:13164): creating call state
2025-11-06 10:01:18,791 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 454eb14f-c7b7-4d87-a5c9-906c3c3a686c, ghrun-ar5i2wnyyy.auto.internal:13164): request = { session_id: "ydb://session/3?node_id=50003&id=Yjk0Y2EzOWYtNDY2MDI3OGYtMjk3OWM2M2ItNWY1OTljYTI=" 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-06 10:01:18,830 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 454eb14f-c7b7-4d87-a5c9-906c3c3a686c, ghrun-ar5i2wnyyy.auto.internal:13164): 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-06 10:01:18,831 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f4912989f00>
2025-11-06 10:01:18,831 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: drop table two
2025-11-06 10:01:18,832 - DEBUG - ydb.connection - _prepare_call: RpcState(DropTable, 1c5e0bfc-fe19-4839-81ff-aa9c91cb9e39, ghrun-ar5i2wnyyy.auto.internal:13164): creating call state
2025-11-06 10:01:18,832 - DEBUG - ydb.connection - _log_request: RpcState(DropTable, 1c5e0bfc-fe19-4839-81ff-aa9c91cb9e39, ghrun-ar5i2wnyyy.auto.internal:13164): request = { session_id: "ydb://session/3?node_id=50003&id=Yjk0Y2EzOWYtNDY2MDI3OGYtMjk3OWM2M2ItNWY1OTljYTI=" path: "/Root/users/database/table_for_rm" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-06 10:01:18,858 - DEBUG - ydb.connection - _log_response: RpcState(DropTable, 1c5e0bfc-fe19-4839-81ff-aa9c91cb9e39, ghrun-ar5i2wnyyy.auto.internal:13164): response = { operation { ready: true status: SUCCESS } }
2025-11-06 10:01:18,868 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f4912989f00>
2025-11-06 10:01:18,868 - DEBUG - ydb.table.SessionPool - stop: Requested session pool stop.
2025-11-06 10:01:18,868 - DEBUG - ydb.table.SessionPool - stop: Session pool is under stop, cancelling all in flight waiters.
2025-11-06 10:01:18,869 - DEBUG - ydb.table.SessionPool - stop: Destroying sessions in active queue
2025-11-06 10:01:18,869 - DEBUG - ydb.table.SessionPool - _destroy: Requested session destroy: <ydb.table.Session object at 0x7f4912989f00>, reason: session-pool-terminated
2025-11-06 10:01:18,869 - DEBUG - ydb.table.SessionPool - _terminate_event: Terminated session pool.
2025-11-06 10:01:18,869 - DEBUG - ydb.table.SessionPool - _destroy: Session <ydb.table.Session object at 0x7f4912989f00> is no longer active. Current active count 0.
2025-11-06 10:01:18,870 - DEBUG - ydb.connection - _prepare_call: RpcState(DeleteSession, 35aac0e2-752b-4226-894e-a0c62089f592, ghrun-ar5i2wnyyy.auto.internal:13164): creating call state
2025-11-06 10:01:18,871 - DEBUG - ydb.connection - _log_request: RpcState(DeleteSession, 35aac0e2-752b-4226-894e-a0c62089f592, ghrun-ar5i2wnyyy.auto.internal:13164): request = { session_id: "ydb://session/3?node_id=50003&id=Yjk0Y2EzOWYtNDY2MDI3OGYtMjk3OWM2M2ItNWY1OTljYTI=" operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-11-06 10:01:18,872 - DEBUG - ydb.table.SessionPool - _destroy: Sent delete on session <ydb.table.Session object at 0x7f4912989f00>
2025-11-06 10:01:18,873 - DEBUG - ydb.table.SessionPool - stop: Destroyed active sessions
2025-11-06 10:01:18,873 - DEBUG - ydb.connection - _on_response_callback: RpcState(DeleteSession, 35aac0e2-752b-4226-894e-a0c62089f592, ghrun-ar5i2wnyyy.auto.internal:13164): on response callback started
2025-11-06 10:01:18,874 - DEBUG - ydb.topic - close: Close topic client
2025-11-06 10:01:18,875 - DEBUG - ydb.connection - _log_response: RpcState(DeleteSession, 35aac0e2-752b-4226-894e-a0c62089f592, ghrun-ar5i2wnyyy.auto.internal:13164): response = { operation { ready: true status: SUCCESS } }
2025-11-06 10:01:18,875 - DEBUG - ydb.topic - close: Topic client was closed
2025-11-06 10:01:18,875 - DEBUG - ydb.connection - _on_response_callback: RpcState(DeleteSession, 35aac0e2-752b-4226-894e-a0c62089f592, ghrun-ar5i2wnyyy.auto.internal:13164): on response callback success
2025-11-06 10:01:18,876 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:1763
2025-11-06 10:01:18,881 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-ar5i2wnyyy.auto.internal:13164
2025-11-06 10:01:18,890 - INFO - ydb.pool.Discovery - run: Successfully terminated discovery process
2025-11-06 10:01:18,891 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: remove_database
2025-11-06 10:01:18,891 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - remove_database: /Root/users/database
2025-11-06 10:01:18,891 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_send_op: /Root/users/database: send console operation, token None
2025-11-06 10:01:18,896 - 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=1762423278894498&action=2"
    }
  }
}
Status {
  Code: STATUS_CODE_UNSPECIFIED
}

2025-11-06 10:01:18,897 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/users/database: wait console operation done
2025-11-06 10:01:19,402 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/users/database: console operation done
2025-11-06 10:01:19,402 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/users/database: wait tenant gone
2025-11-06 10:01:19,405 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/users/database: tenant gone
2025-11-06 10:01:20,405 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:13164/4
2025-11-06 10:01:20,406 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: done 3
2025-11-06 10:01:20,407 - INFO - ya.test - pytest_runtest_teardown: Test teardown
