2025-11-01 16:45:45,214 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 16:45:45,214 - INFO - ya.test - pytest_runtest_setup: test_create_and_drop_the_same_tenant2[enable_alter_database_create_hive_first--false]
2025-11-01 16:45:45,214 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 16:45:45,215 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-01 16:45:45,215 - INFO - ydb.tests.library.fixtures - ydb_cluster: destroy ydb_cluster for __tests__.test_dynamic_tenants
2025-11-01 16:45:46,216 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:65199/1
2025-11-01 16:45:46,222 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/63442
2025-11-01 16:45:46,222 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/26680
2025-11-01 16:45:46,222 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/15680
2025-11-01 16:45:46,223 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/15077
2025-11-01 16:45:46,223 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/7193
2025-11-01 16:45:46,223 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/19110
2025-11-01 16:45:46,223 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/22926
2025-11-01 16:45:46,223 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/31894
2025-11-01 16:45:46,223 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/32279
2025-11-01 16:45:46,223 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/29328
2025-11-01 16:45:46,224 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/16014
2025-11-01 16:45:46,224 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/7564
2025-11-01 16:45:46,224 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/14452
2025-11-01 16:45:46,224 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/29760
2025-11-01 16:45:46,224 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/3225
2025-11-01 16:45:46,224 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/28611
2025-11-01 16:45:46,224 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/62068
2025-11-01 16:45:46,224 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/30075
2025-11-01 16:45:46,224 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/14486
2025-11-01 16:45:46,225 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/1921
2025-11-01 16:45:46,225 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/3267
2025-11-01 16:45:46,225 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/8519
2025-11-01 16:45:46,225 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/4707
2025-11-01 16:45:46,225 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/29326
2025-11-01 16:45:46,226 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/11096
2025-11-01 16:45:46,226 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/22189
2025-11-01 16:45:46,229 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/2128
2025-11-01 16:45:46,235 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/24885
2025-11-01 16:45:46,235 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/5071
2025-11-01 16:45:46,236 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/62513
2025-11-01 16:45:46,241 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/17863
2025-11-01 16:45:46,241 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/19068
2025-11-01 16:45:46,242 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/14631
2025-11-01 16:45:46,242 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/15839
2025-11-01 16:45:46,242 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/17598
2025-11-01 16:45:46,242 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/8664
2025-11-01 16:45:46,243 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/17036
2025-11-01 16:45:46,243 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/14268
2025-11-01 16:45:46,255 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/26595
2025-11-01 16:45:46,255 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/29022
2025-11-01 16:45:46,256 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/19918
2025-11-01 16:45:46,257 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/27012
2025-11-01 16:45:46,257 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/62150
2025-11-01 16:45:46,258 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/65199
2025-11-01 16:45:46,258 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/63108
2025-11-01 16:45:46,390 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/q6a6/0023f4/ydb/apps/ydbd/ydbd
2025-11-01 16:45:46,391 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/10936
2025-11-01 16:45:46,393 - INFO - ydb.tests.library.fixtures - ydb_cluster: setup ydb_cluster for __tests__.test_dynamic_tenants
2025-11-01 16:45:46,393 - INFO - ydb.tests.library.fixtures - ydb_cluster: setup ydb_cluster as local
2025-11-01 16:45:46,394 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/q6a6/0023f4/r3tmp/kikimr_cluster_fanz5d1v
2025-11-01 16:45:46,467 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/q6a6/0023f4/ydb/apps/ydbd/ydbd
2025-11-01 16:45:46,468 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/6120
2025-11-01 16:45:46,471 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/22411
2025-11-01 16:45:46,472 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/19161
2025-11-01 16:45:46,488 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/64039
2025-11-01 16:45:46,490 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/q6a6/0023f4/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/kikimr_configs"
2025-11-01 16:45:46,490 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/q6a6/0023f4/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/q6a6/0023f4/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_gdpw20ex.log --grpc-port=6120 --mon-port=22411 --ic-port=10936
2025-11-01 16:45:46,490 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:6120/1, disk_size 68719476736
2025-11-01 16:45:46,491 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/q6a6/0023f4/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/kikimr_configs"
2025-11-01 16:45:46,494 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/q6a6/0023f4/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/q6a6/0023f4/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_gdpw20ex.log --grpc-port=6120 --mon-port=22411 --ic-port=10936
2025-11-01 16:45:46,499 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/q6a6/0023f4/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/q6a6/0023f4/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/q6a6/0023f4/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_gdpw20ex.log', '--grpc-port=6120', '--mon-port=22411', '--ic-port=10936')' in '/home/runner/.ya/build/build_root/q6a6/0023f4/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/node_1' (no wait)
2025-11-01 16:45:46,505 - DEBUG - ya.test - execute: Command pid: 3047330
2025-11-01 16:45:46,506 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:6120/1
2025-11-01 16:45:46,507 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.27
2025-11-01 16:45:46,508 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.27
2025-11-01 16:45:46,508 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/q6a6/0023f4/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 16:45:46,510 - DEBUG - ya.test - execute: Command pid: 3047331
2025-11-01 16:45:46,997 - DEBUG - ya.test - _save_outputs: Command (pid 3047331) rc: 0
2025-11-01 16:45:46,997 - DEBUG - ya.test - _save_outputs: Command (pid 3047331) elapsed time (sec): 0.4863252639770508
2025-11-01 16:45:46,997 - DEBUG - ya.test - _save_outputs: Command (pid 3047331) idrss: 0
2025-11-01 16:45:46,998 - DEBUG - ya.test - _save_outputs: Command (pid 3047331) inblock: 0
2025-11-01 16:45:46,998 - DEBUG - ya.test - _save_outputs: Command (pid 3047331) isrss: 0
2025-11-01 16:45:46,998 - DEBUG - ya.test - _save_outputs: Command (pid 3047331) ixrss: 0
2025-11-01 16:45:46,999 - DEBUG - ya.test - _save_outputs: Command (pid 3047331) majflt: 0
2025-11-01 16:45:47,001 - DEBUG - ya.test - _save_outputs: Command (pid 3047331) maxrss: 538512
2025-11-01 16:45:47,002 - DEBUG - ya.test - _save_outputs: Command (pid 3047331) minflt: 16132
2025-11-01 16:45:47,002 - DEBUG - ya.test - _save_outputs: Command (pid 3047331) msgrcv: 0
2025-11-01 16:45:47,002 - DEBUG - ya.test - _save_outputs: Command (pid 3047331) msgsnd: 0
2025-11-01 16:45:47,002 - DEBUG - ya.test - _save_outputs: Command (pid 3047331) nivcsw: 117
2025-11-01 16:45:47,002 - DEBUG - ya.test - _save_outputs: Command (pid 3047331) nsignals: 0
2025-11-01 16:45:47,003 - DEBUG - ya.test - _save_outputs: Command (pid 3047331) nswap: 0
2025-11-01 16:45:47,003 - DEBUG - ya.test - _save_outputs: Command (pid 3047331) nvcsw: 21
2025-11-01 16:45:47,003 - DEBUG - ya.test - _save_outputs: Command (pid 3047331) oublock: 8
2025-11-01 16:45:47,003 - DEBUG - ya.test - _save_outputs: Command (pid 3047331) stime: 0.265335
2025-11-01 16:45:47,003 - DEBUG - ya.test - _save_outputs: Command (pid 3047331) utime: 0.117253
2025-11-01 16:45:47,003 - DEBUG - ya.test - _save_outputs: Command (pid 3047331) wtime: 0.488
2025-11-01 16:45:47,003 - DEBUG - ya.test - _save_outputs: Command (pid 3047331) output:
Git info:
    Commit: 34ddad56c8a7bb530ecf731d374c04f98d3d2aca
    Branch: 
    Author: azevaykin <145343289+azevaykin@users.noreply.github.com>
    Summary: Merge f53a17d638f4ee7a8f08354cd76c33a88c4925c5 into 5dbd26ce2068671edb74bb9f072505a44ea73d1e

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

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

2025-11-01 16:45:47,004 - DEBUG - ya.test - _save_outputs: Command (pid 3047331) errors:

2025-11-01 16:45:47,004 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 34ddad56c8a7bb530ecf731d374c04f98d3d2aca
    Branch: 
    Author: azevaykin <145343289+azevaykin@users.noreply.github.com>
    Summary: Merge f53a17d638f4ee7a8f08354cd76c33a88c4925c5 into 5dbd26ce2068671edb74bb9f072505a44ea73d1e
2025-11-01 16:45:48,919 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/q6a6/0023f4/ydb/apps/ydbd/ydbd
2025-11-01 16:45:48,920 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/q6a6/0023f4/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:6120', '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: 10936\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-01 16:45:48,921 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.28
2025-11-01 16:45:48,922 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.28
2025-11-01 16:45:48,922 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/q6a6/0023f4/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:6120', '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: 10936\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-01 16:45:48,926 - DEBUG - ya.test - execute: Command pid: 3048925
2025-11-01 16:45:49,753 - DEBUG - ya.test - _save_outputs: Command (pid 3048925) rc: 0
2025-11-01 16:45:49,754 - DEBUG - ya.test - _save_outputs: Command (pid 3048925) elapsed time (sec): 0.8261442184448242
2025-11-01 16:45:49,757 - DEBUG - ya.test - _save_outputs: Command (pid 3048925) idrss: 0
2025-11-01 16:45:49,758 - DEBUG - ya.test - _save_outputs: Command (pid 3048925) inblock: 0
2025-11-01 16:45:49,759 - DEBUG - ya.test - _save_outputs: Command (pid 3048925) isrss: 0
2025-11-01 16:45:49,759 - DEBUG - ya.test - _save_outputs: Command (pid 3048925) ixrss: 0
2025-11-01 16:45:49,763 - DEBUG - ya.test - _save_outputs: Command (pid 3048925) majflt: 0
2025-11-01 16:45:49,765 - DEBUG - ya.test - _save_outputs: Command (pid 3048925) maxrss: 546808
2025-11-01 16:45:49,766 - DEBUG - ya.test - _save_outputs: Command (pid 3048925) minflt: 18970
2025-11-01 16:45:49,766 - DEBUG - ya.test - _save_outputs: Command (pid 3048925) msgrcv: 0
2025-11-01 16:45:49,766 - DEBUG - ya.test - _save_outputs: Command (pid 3048925) msgsnd: 0
2025-11-01 16:45:49,766 - DEBUG - ya.test - _save_outputs: Command (pid 3048925) nivcsw: 159
2025-11-01 16:45:49,770 - DEBUG - ya.test - _save_outputs: Command (pid 3048925) nsignals: 0
2025-11-01 16:45:49,771 - DEBUG - ya.test - _save_outputs: Command (pid 3048925) nswap: 0
2025-11-01 16:45:49,771 - DEBUG - ya.test - _save_outputs: Command (pid 3048925) nvcsw: 130
2025-11-01 16:45:49,771 - DEBUG - ya.test - _save_outputs: Command (pid 3048925) oublock: 8
2025-11-01 16:45:49,771 - DEBUG - ya.test - _save_outputs: Command (pid 3048925) stime: 0.479093
2025-11-01 16:45:49,771 - DEBUG - ya.test - _save_outputs: Command (pid 3048925) utime: 0.129604
2025-11-01 16:45:49,773 - DEBUG - ya.test - _save_outputs: Command (pid 3048925) wtime: 0.83
2025-11-01 16:45:49,775 - DEBUG - ya.test - _save_outputs: Command (pid 3048925) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 4

2025-11-01 16:45:49,775 - DEBUG - ya.test - _save_outputs: Command (pid 3048925) errors:

2025-11-01 16:45:49,776 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/q6a6/0023f4/ydb/apps/ydbd/ydbd
2025-11-01 16:45:49,776 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/q6a6/0023f4/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:6120', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']
2025-11-01 16:45:49,778 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.29
2025-11-01 16:45:49,779 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.29
2025-11-01 16:45:49,779 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/q6a6/0023f4/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:6120', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-01 16:45:49,780 - DEBUG - ya.test - execute: Command pid: 3049393
2025-11-01 16:45:50,373 - DEBUG - ya.test - _save_outputs: Command (pid 3049393) rc: 0
2025-11-01 16:45:50,373 - DEBUG - ya.test - _save_outputs: Command (pid 3049393) elapsed time (sec): 0.5914440155029297
2025-11-01 16:45:50,373 - DEBUG - ya.test - _save_outputs: Command (pid 3049393) idrss: 0
2025-11-01 16:45:50,373 - DEBUG - ya.test - _save_outputs: Command (pid 3049393) inblock: 0
2025-11-01 16:45:50,374 - DEBUG - ya.test - _save_outputs: Command (pid 3049393) isrss: 0
2025-11-01 16:45:50,379 - DEBUG - ya.test - _save_outputs: Command (pid 3049393) ixrss: 0
2025-11-01 16:45:50,380 - DEBUG - ya.test - _save_outputs: Command (pid 3049393) majflt: 0
2025-11-01 16:45:50,380 - DEBUG - ya.test - _save_outputs: Command (pid 3049393) maxrss: 546976
2025-11-01 16:45:50,380 - DEBUG - ya.test - _save_outputs: Command (pid 3049393) minflt: 18273
2025-11-01 16:45:50,380 - DEBUG - ya.test - _save_outputs: Command (pid 3049393) msgrcv: 0
2025-11-01 16:45:50,381 - DEBUG - ya.test - _save_outputs: Command (pid 3049393) msgsnd: 0
2025-11-01 16:45:50,381 - DEBUG - ya.test - _save_outputs: Command (pid 3049393) nivcsw: 116
2025-11-01 16:45:50,381 - DEBUG - ya.test - _save_outputs: Command (pid 3049393) nsignals: 0
2025-11-01 16:45:50,381 - DEBUG - ya.test - _save_outputs: Command (pid 3049393) nswap: 0
2025-11-01 16:45:50,381 - DEBUG - ya.test - _save_outputs: Command (pid 3049393) nvcsw: 107
2025-11-01 16:45:50,381 - DEBUG - ya.test - _save_outputs: Command (pid 3049393) oublock: 8
2025-11-01 16:45:50,381 - DEBUG - ya.test - _save_outputs: Command (pid 3049393) stime: 0.28392999999999996
2025-11-01 16:45:50,382 - DEBUG - ya.test - _save_outputs: Command (pid 3049393) utime: 0.134078
2025-11-01 16:45:50,382 - DEBUG - ya.test - _save_outputs: Command (pid 3049393) wtime: 0.593
2025-11-01 16:45:50,382 - DEBUG - ya.test - _save_outputs: Command (pid 3049393) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-01 16:45:50,387 - DEBUG - ya.test - _save_outputs: Command (pid 3049393) errors:

2025-11-01 16:45:50,388 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-01 16:45:50,425 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-11-01 16:45:50,453 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_dynamic_tenants.py, test_name: test_create_and_drop_the_same_tenant2[enable_alter_database_create_hive_first--false])
2025-11-01 16:45:50,475 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: create_database
2025-11-01 16:45:50,988 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/q6a6/0023f4/ydb/apps/ydbd/ydbd
2025-11-01 16:45:50,989 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/19629
2025-11-01 16:45:50,989 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/7150
2025-11-01 16:45:50,990 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/3858
2025-11-01 16:45:50,990 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/11221
2025-11-01 16:45:50,990 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/29656
2025-11-01 16:45:51,013 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/q6a6/0023f4/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/kikimr_configs"
2025-11-01 16:45:51,013 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/q6a6/0023f4/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:6120 --tenant=/Root/users/database --log-file-name=/home/runner/.ya/build/build_root/q6a6/0023f4/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_ioa4svs6.log --grpc-port=19629 --mon-port=7150 --ic-port=3858
2025-11-01 16:45:51,013 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/q6a6/0023f4/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/kikimr_configs"
2025-11-01 16:45:51,014 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/q6a6/0023f4/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:6120 --tenant=/Root/users/database --log-file-name=/home/runner/.ya/build/build_root/q6a6/0023f4/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_ioa4svs6.log --grpc-port=19629 --mon-port=7150 --ic-port=3858
2025-11-01 16:45:51,017 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/q6a6/0023f4/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/q6a6/0023f4/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:6120', '--tenant=/Root/users/database', '--log-file-name=/home/runner/.ya/build/build_root/q6a6/0023f4/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_ioa4svs6.log', '--grpc-port=19629', '--mon-port=7150', '--ic-port=3858')' in '/home/runner/.ya/build/build_root/q6a6/0023f4/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/slot_1' (no wait)
2025-11-01 16:45:51,027 - DEBUG - ya.test - execute: Command pid: 3050098
2025-11-01 16:45:51,027 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:19629/1
2025-11-01 16:45:51,034 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.30
2025-11-01 16:45:51,036 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.30
2025-11-01 16:45:51,039 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/q6a6/0023f4/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 16:45:51,049 - DEBUG - ya.test - execute: Command pid: 3050104
2025-11-01 16:45:51,526 - DEBUG - ya.test - _save_outputs: Command (pid 3050104) rc: 0
2025-11-01 16:45:51,530 - DEBUG - ya.test - _save_outputs: Command (pid 3050104) elapsed time (sec): 0.47556209564208984
2025-11-01 16:45:51,531 - DEBUG - ya.test - _save_outputs: Command (pid 3050104) idrss: 0
2025-11-01 16:45:51,531 - DEBUG - ya.test - _save_outputs: Command (pid 3050104) inblock: 0
2025-11-01 16:45:51,531 - DEBUG - ya.test - _save_outputs: Command (pid 3050104) isrss: 0
2025-11-01 16:45:51,531 - DEBUG - ya.test - _save_outputs: Command (pid 3050104) ixrss: 0
2025-11-01 16:45:51,531 - DEBUG - ya.test - _save_outputs: Command (pid 3050104) majflt: 0
2025-11-01 16:45:51,532 - DEBUG - ya.test - _save_outputs: Command (pid 3050104) maxrss: 538512
2025-11-01 16:45:51,533 - DEBUG - ya.test - _save_outputs: Command (pid 3050104) minflt: 16131
2025-11-01 16:45:51,534 - DEBUG - ya.test - _save_outputs: Command (pid 3050104) msgrcv: 0
2025-11-01 16:45:51,534 - DEBUG - ya.test - _save_outputs: Command (pid 3050104) msgsnd: 0
2025-11-01 16:45:51,534 - DEBUG - ya.test - _save_outputs: Command (pid 3050104) nivcsw: 116
2025-11-01 16:45:51,534 - DEBUG - ya.test - _save_outputs: Command (pid 3050104) nsignals: 0
2025-11-01 16:45:51,535 - DEBUG - ya.test - _save_outputs: Command (pid 3050104) nswap: 0
2025-11-01 16:45:51,535 - DEBUG - ya.test - _save_outputs: Command (pid 3050104) nvcsw: 20
2025-11-01 16:45:51,535 - DEBUG - ya.test - _save_outputs: Command (pid 3050104) oublock: 8
2025-11-01 16:45:51,535 - DEBUG - ya.test - _save_outputs: Command (pid 3050104) stime: 0.233044
2025-11-01 16:45:51,535 - DEBUG - ya.test - _save_outputs: Command (pid 3050104) utime: 0.11332199999999999
2025-11-01 16:45:51,535 - DEBUG - ya.test - _save_outputs: Command (pid 3050104) wtime: 0.486
2025-11-01 16:45:51,536 - DEBUG - ya.test - _save_outputs: Command (pid 3050104) output:
Git info:
    Commit: 34ddad56c8a7bb530ecf731d374c04f98d3d2aca
    Branch: 
    Author: azevaykin <145343289+azevaykin@users.noreply.github.com>
    Summary: Merge f53a17d638f4ee7a8f08354cd76c33a88c4925c5 into 5dbd26ce2068671edb74bb9f072505a44ea73d1e

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

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

2025-11-01 16:45:51,536 - DEBUG - ya.test - _save_outputs: Command (pid 3050104) errors:

2025-11-01 16:45:51,537 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 34ddad56c8a7bb530ecf731d374c04f98d3d2aca
    Branch: 
    Author: azevaykin <145343289+azevaykin@users.noreply.github.com>
    Summary: Merge f53a17d638f4ee7a8f08354cd76c33a88c4925c5 into 5dbd26ce2068671edb74bb9f072505a44ea73d1e
2025-11-01 16:45:51,538 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 16:45:51,545 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 16:45:51,546 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: create table one
2025-11-01 16:45:51,547 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 16:45:51,550 - DEBUG - ydb.table.SessionPool - subscribe: Active session queue is empty, subscribe waiter for a session
2025-11-01 16:45:51,553 - DEBUG - ydb.table.SessionPool - subscribe: Subscribe waiter <Future at 0x7fb5d6643710 state=pending>
2025-11-01 16:45:51,553 - DEBUG - ydb.table.SessionPool - subscribe: Session pool is not large enough (active_count < size: 0 < 1). will create a new session.
2025-11-01 16:45:51,553 - DEBUG - ydb.table.SessionPool - _create: Created session <ydb.table.Session object at 0x7fb5d669a720>
2025-11-01 16:45:51,555 - DEBUG - ydb.table.SessionPool - _prepare: Preparing session <ydb.table.Session object at 0x7fb5d669a720>
2025-11-01 16:45:51,556 - ERROR - ydb.table.SessionPool - _on_session_create: Failed to create session. Put event to a delayed queue. Reason: Couldn't find valid connection
2025-11-01 16:45:51,560 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/users/database
2025-11-01 16:45:51,565 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, f4359ed5-e77c-448c-85d6-49e1179ef593, localhost:6120): creating call state
2025-11-01 16:45:51,565 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, f4359ed5-e77c-448c-85d6-49e1179ef593, localhost:6120): request = { database: "/Root/users/database" }
2025-11-01 16:45:51,579 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, f4359ed5-e77c-448c-85d6-49e1179ef593, localhost:6120): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-11-01 16:45:51,580 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root/users/database. Endpoint: "localhost:6120". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-11-01 16:45:51,581 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6120
2025-11-01 16:45:53,718 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 16:45:53,719 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 16:45:53,743 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/users/database
2025-11-01 16:45:53,753 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, c1e61745-340c-41c4-9285-a654d05744d8, localhost:6120): creating call state
2025-11-01 16:45:53,760 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, c1e61745-340c-41c4-9285-a654d05744d8, localhost:6120): request = { database: "/Root/users/database" }
2025-11-01 16:45:53,769 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, c1e61745-340c-41c4-9285-a654d05744d8, localhost:6120): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-tvlw7frnpa.auto.internal" port: 19629 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" node_id: 50000 } self_location: "1" } } } }
2025-11-01 16:45:53,769 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root/users/database: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-tvlw7frnpa.auto.internal:19629, location , ssl: False>]>
2025-11-01 16:45:53,770 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 16:45:53,784 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6120
2025-11-01 16:45:53,784 - DEBUG - ydb.table.SessionPool - _prepare: Preparing session <ydb.table.Session object at 0x7fb5d669a720>
2025-11-01 16:45:53,790 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, c078d084-b240-45db-b8c2-3a1584e54e49, ghrun-tvlw7frnpa.auto.internal:19629): creating call state
2025-11-01 16:45:53,790 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, c078d084-b240-45db-b8c2-3a1584e54e49, ghrun-tvlw7frnpa.auto.internal:19629): request = { operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-11-01 16:45:53,796 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, c078d084-b240-45db-b8c2-3a1584e54e49, ghrun-tvlw7frnpa.auto.internal:19629): on response callback started
2025-11-01 16:45:53,797 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, c078d084-b240-45db-b8c2-3a1584e54e49, ghrun-tvlw7frnpa.auto.internal:19629): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=50000&id=NzBhMDliNjItODRiMjE3MWQtZTE2NDg4MGUtY2NkMzlkMzA=" } } } }
2025-11-01 16:45:53,798 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fb5d669a720>
2025-11-01 16:45:53,798 - DEBUG - ydb.table.SessionPool - put: Replying to waiter with a session <ydb.table.Session object at 0x7fb5d669a720>
2025-11-01 16:45:53,798 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, c078d084-b240-45db-b8c2-3a1584e54e49, ghrun-tvlw7frnpa.auto.internal:19629): on response callback success
2025-11-01 16:45:53,800 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 27d4a182-d78f-484e-991e-7c5837c19c20, ghrun-tvlw7frnpa.auto.internal:19629): creating call state
2025-11-01 16:45:53,809 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 27d4a182-d78f-484e-991e-7c5837c19c20, ghrun-tvlw7frnpa.auto.internal:19629): request = { session_id: "ydb://session/3?node_id=50000&id=NzBhMDliNjItODRiMjE3MWQtZTE2NDg4MGUtY2NkMzlkMzA=" path: "/Root/users/database/table" columns { name: "id" type { optional_type { item { type_id: UINT64 } } } } columns { name: "value" type { optional_type { item { type_id: UTF8 } } } } primary_key: "id" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:45:53,906 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 27d4a182-d78f-484e-991e-7c5837c19c20, ghrun-tvlw7frnpa.auto.internal:19629): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:45:53,920 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fb5d669a720>
2025-11-01 16:45:53,920 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: create table two
2025-11-01 16:45:53,921 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 40098913-26bb-4c54-8d48-1ccd295661b6, ghrun-tvlw7frnpa.auto.internal:19629): creating call state
2025-11-01 16:45:53,932 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 40098913-26bb-4c54-8d48-1ccd295661b6, ghrun-tvlw7frnpa.auto.internal:19629): request = { session_id: "ydb://session/3?node_id=50000&id=NzBhMDliNjItODRiMjE3MWQtZTE2NDg4MGUtY2NkMzlkMzA=" path: "/Root/users/database/table_for_rm" columns { name: "id" type { optional_type { item { type_id: UINT64 } } } } columns { name: "value" type { optional_type { item { type_id: UTF8 } } } } primary_key: "id" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:45:54,084 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 40098913-26bb-4c54-8d48-1ccd295661b6, ghrun-tvlw7frnpa.auto.internal:19629): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:45:54,085 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fb5d669a720>
2025-11-01 16:45:54,085 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: write_some_data
2025-11-01 16:45:54,086 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, af37b953-2b50-45cf-b520-fde99237de08, ghrun-tvlw7frnpa.auto.internal:19629): creating call state
2025-11-01 16:45:54,087 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, af37b953-2b50-45cf-b520-fde99237de08, ghrun-tvlw7frnpa.auto.internal:19629): request = { session_id: "ydb://session/3?node_id=50000&id=NzBhMDliNjItODRiMjE3MWQtZTE2NDg4MGUtY2NkMzlkMzA=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "\n                        upsert into table (id, value)\n                        values (1u, \"/Root/users/database_0\");\n                        upsert into table_for_rm (id, value)\n                        values (2u, \"/Root/users/database_0\");\n                        " } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:45:54,175 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, af37b953-2b50-45cf-b520-fde99237de08, ghrun-tvlw7frnpa.auto.internal:19629): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-11-01 16:45:54,215 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fb5d669a720>
2025-11-01 16:45:54,217 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: read_some_data
2025-11-01 16:45:54,218 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 54b235c0-b3bc-45a8-a42c-191b8b7032d7, ghrun-tvlw7frnpa.auto.internal:19629): creating call state
2025-11-01 16:45:54,221 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 54b235c0-b3bc-45a8-a42c-191b8b7032d7, ghrun-tvlw7frnpa.auto.internal:19629): request = { session_id: "ydb://session/3?node_id=50000&id=NzBhMDliNjItODRiMjE3MWQtZTE2NDg4MGUtY2NkMzlkMzA=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "\n                        select id, value FROM table;\n                        select id, value FROM table_for_rm;\n                        " } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:45:54,269 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 54b235c0-b3bc-45a8-a42c-191b8b7032d7, ghrun-tvlw7frnpa.auto.internal:19629): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { result_sets { columns { name: "id" type { optional_type { item { type_id: UINT64 } } } } columns { name: "value" type { optional_type { item { type_id: UTF8 } } } } rows { items { uint64_value: 1 } items { text_value: "/Root/users/database_0" } } format: FORMAT_VALUE } result_sets { columns { name: "id" type { optional_type { item { type_id: UINT64 } } } } columns { name: "value" type { optional_type { item { type_id: UTF8 } } } } rows { items { uint64_value: 2 } items { text_value: "/Root/users/database_0" } } format: FORMAT_VALUE } tx_meta { } } } } }
2025-11-01 16:45:54,270 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fb5d669a720>
2025-11-01 16:45:54,270 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: drop table two
2025-11-01 16:45:54,271 - DEBUG - ydb.connection - _prepare_call: RpcState(DropTable, e223bfd5-c076-43a4-b51d-96fc99f5e424, ghrun-tvlw7frnpa.auto.internal:19629): creating call state
2025-11-01 16:45:54,271 - DEBUG - ydb.connection - _log_request: RpcState(DropTable, e223bfd5-c076-43a4-b51d-96fc99f5e424, ghrun-tvlw7frnpa.auto.internal:19629): request = { session_id: "ydb://session/3?node_id=50000&id=NzBhMDliNjItODRiMjE3MWQtZTE2NDg4MGUtY2NkMzlkMzA=" path: "/Root/users/database/table_for_rm" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:45:54,331 - DEBUG - ydb.connection - _log_response: RpcState(DropTable, e223bfd5-c076-43a4-b51d-96fc99f5e424, ghrun-tvlw7frnpa.auto.internal:19629): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:45:54,342 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fb5d669a720>
2025-11-01 16:45:54,351 - DEBUG - ydb.table.SessionPool - stop: Requested session pool stop.
2025-11-01 16:45:54,356 - DEBUG - ydb.table.SessionPool - stop: Session pool is under stop, cancelling all in flight waiters.
2025-11-01 16:45:54,356 - DEBUG - ydb.table.SessionPool - _terminate_event: Terminated session pool.
2025-11-01 16:45:54,376 - DEBUG - ydb.table.SessionPool - stop: Destroying sessions in active queue
2025-11-01 16:45:54,385 - DEBUG - ydb.table.SessionPool - _destroy: Requested session destroy: <ydb.table.Session object at 0x7fb5d669a720>, reason: session-pool-terminated
2025-11-01 16:45:54,385 - DEBUG - ydb.table.SessionPool - _destroy: Session <ydb.table.Session object at 0x7fb5d669a720> is no longer active. Current active count 0.
2025-11-01 16:45:54,387 - DEBUG - ydb.connection - _prepare_call: RpcState(DeleteSession, 4e784454-73d2-41ef-9b91-e3e4cd4e6e9f, ghrun-tvlw7frnpa.auto.internal:19629): creating call state
2025-11-01 16:45:54,387 - DEBUG - ydb.connection - _log_request: RpcState(DeleteSession, 4e784454-73d2-41ef-9b91-e3e4cd4e6e9f, ghrun-tvlw7frnpa.auto.internal:19629): request = { session_id: "ydb://session/3?node_id=50000&id=NzBhMDliNjItODRiMjE3MWQtZTE2NDg4MGUtY2NkMzlkMzA=" operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-11-01 16:45:54,397 - DEBUG - ydb.connection - _on_response_callback: RpcState(DeleteSession, 4e784454-73d2-41ef-9b91-e3e4cd4e6e9f, ghrun-tvlw7frnpa.auto.internal:19629): on response callback started
2025-11-01 16:45:54,398 - DEBUG - ydb.connection - _log_response: RpcState(DeleteSession, 4e784454-73d2-41ef-9b91-e3e4cd4e6e9f, ghrun-tvlw7frnpa.auto.internal:19629): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:45:54,408 - DEBUG - ydb.connection - _on_response_callback: RpcState(DeleteSession, 4e784454-73d2-41ef-9b91-e3e4cd4e6e9f, ghrun-tvlw7frnpa.auto.internal:19629): on response callback success
2025-11-01 16:45:54,409 - DEBUG - ydb.table.SessionPool - _destroy: Sent delete on session <ydb.table.Session object at 0x7fb5d669a720>
2025-11-01 16:45:54,409 - DEBUG - ydb.table.SessionPool - stop: Destroyed active sessions
2025-11-01 16:45:54,409 - DEBUG - ydb.topic - close: Close topic client
2025-11-01 16:45:54,409 - DEBUG - ydb.topic - close: Topic client was closed
2025-11-01 16:45:54,410 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6120
2025-11-01 16:45:54,411 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-tvlw7frnpa.auto.internal:19629
2025-11-01 16:45:54,412 - INFO - ydb.pool.Discovery - run: Successfully terminated discovery process
2025-11-01 16:45:54,414 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: remove_database
2025-11-01 16:45:54,415 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - remove_database: /Root/users/database
2025-11-01 16:45:54,415 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_send_op: /Root/users/database: send console operation, token None
2025-11-01 16:45:54,426 - 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=1762015554424191&action=2"
    }
  }
}
Status {
  Code: STATUS_CODE_UNSPECIFIED
}

2025-11-01 16:45:54,441 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/users/database: wait console operation done
2025-11-01 16:45:54,945 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/users/database: console operation done
2025-11-01 16:45:54,945 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/users/database: wait tenant gone
2025-11-01 16:45:54,951 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/users/database: tenant gone
2025-11-01 16:45:55,954 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:19629/1
2025-11-01 16:45:55,957 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: done 0
2025-11-01 16:45:55,958 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: create_database
2025-11-01 16:45:56,480 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/q6a6/0023f4/ydb/apps/ydbd/ydbd
2025-11-01 16:45:56,508 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/8622
2025-11-01 16:45:56,509 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/20033
2025-11-01 16:45:56,509 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/8069
2025-11-01 16:45:56,510 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/10523
2025-11-01 16:45:56,510 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/18830
2025-11-01 16:45:56,512 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/q6a6/0023f4/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/kikimr_configs"
2025-11-01 16:45:56,512 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/q6a6/0023f4/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:6120 --tenant=/Root/users/database --log-file-name=/home/runner/.ya/build/build_root/q6a6/0023f4/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_74atjfww.log --grpc-port=8622 --mon-port=20033 --ic-port=8069
2025-11-01 16:45:56,512 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/q6a6/0023f4/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/kikimr_configs"
2025-11-01 16:45:56,512 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/q6a6/0023f4/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:6120 --tenant=/Root/users/database --log-file-name=/home/runner/.ya/build/build_root/q6a6/0023f4/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_74atjfww.log --grpc-port=8622 --mon-port=20033 --ic-port=8069
2025-11-01 16:45:56,513 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/q6a6/0023f4/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/q6a6/0023f4/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:6120', '--tenant=/Root/users/database', '--log-file-name=/home/runner/.ya/build/build_root/q6a6/0023f4/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_74atjfww.log', '--grpc-port=8622', '--mon-port=20033', '--ic-port=8069')' in '/home/runner/.ya/build/build_root/q6a6/0023f4/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/slot_2' (no wait)
2025-11-01 16:45:56,523 - DEBUG - ya.test - execute: Command pid: 3052812
2025-11-01 16:45:56,557 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:8622/2
2025-11-01 16:45:56,559 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.31
2025-11-01 16:45:56,631 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.31
2025-11-01 16:45:56,631 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/q6a6/0023f4/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 16:45:56,637 - DEBUG - ya.test - execute: Command pid: 3052859
2025-11-01 16:45:57,410 - DEBUG - ya.test - _save_outputs: Command (pid 3052859) rc: 0
2025-11-01 16:45:57,411 - DEBUG - ya.test - _save_outputs: Command (pid 3052859) elapsed time (sec): 0.7730367183685303
2025-11-01 16:45:57,411 - DEBUG - ya.test - _save_outputs: Command (pid 3052859) idrss: 0
2025-11-01 16:45:57,411 - DEBUG - ya.test - _save_outputs: Command (pid 3052859) inblock: 0
2025-11-01 16:45:57,411 - DEBUG - ya.test - _save_outputs: Command (pid 3052859) isrss: 0
2025-11-01 16:45:57,411 - DEBUG - ya.test - _save_outputs: Command (pid 3052859) ixrss: 0
2025-11-01 16:45:57,412 - DEBUG - ya.test - _save_outputs: Command (pid 3052859) majflt: 0
2025-11-01 16:45:57,412 - DEBUG - ya.test - _save_outputs: Command (pid 3052859) maxrss: 538512
2025-11-01 16:45:57,412 - DEBUG - ya.test - _save_outputs: Command (pid 3052859) minflt: 16130
2025-11-01 16:45:57,412 - DEBUG - ya.test - _save_outputs: Command (pid 3052859) msgrcv: 0
2025-11-01 16:45:57,412 - DEBUG - ya.test - _save_outputs: Command (pid 3052859) msgsnd: 0
2025-11-01 16:45:57,412 - DEBUG - ya.test - _save_outputs: Command (pid 3052859) nivcsw: 114
2025-11-01 16:45:57,412 - DEBUG - ya.test - _save_outputs: Command (pid 3052859) nsignals: 0
2025-11-01 16:45:57,448 - DEBUG - ya.test - _save_outputs: Command (pid 3052859) nswap: 0
2025-11-01 16:45:57,449 - DEBUG - ya.test - _save_outputs: Command (pid 3052859) nvcsw: 18
2025-11-01 16:45:57,449 - DEBUG - ya.test - _save_outputs: Command (pid 3052859) oublock: 8
2025-11-01 16:45:57,450 - DEBUG - ya.test - _save_outputs: Command (pid 3052859) stime: 0.261731
2025-11-01 16:45:57,450 - DEBUG - ya.test - _save_outputs: Command (pid 3052859) utime: 0.11071199999999999
2025-11-01 16:45:57,452 - DEBUG - ya.test - _save_outputs: Command (pid 3052859) wtime: 0.779
2025-11-01 16:45:57,452 - DEBUG - ya.test - _save_outputs: Command (pid 3052859) output:
Git info:
    Commit: 34ddad56c8a7bb530ecf731d374c04f98d3d2aca
    Branch: 
    Author: azevaykin <145343289+azevaykin@users.noreply.github.com>
    Summary: Merge f53a17d638f4ee7a8f08354cd76c33a88c4925c5 into 5dbd26ce2068671edb74bb9f072505a44ea73d1e

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

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

2025-11-01 16:45:57,452 - DEBUG - ya.test - _save_outputs: Command (pid 3052859) errors:

2025-11-01 16:45:57,452 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 2 version:
Git info:
    Commit: 34ddad56c8a7bb530ecf731d374c04f98d3d2aca
    Branch: 
    Author: azevaykin <145343289+azevaykin@users.noreply.github.com>
    Summary: Merge f53a17d638f4ee7a8f08354cd76c33a88c4925c5 into 5dbd26ce2068671edb74bb9f072505a44ea73d1e
2025-11-01 16:45:57,453 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 16:45:57,455 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 16:45:57,456 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 16:45:57,463 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/users/database
2025-11-01 16:45:57,511 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 3eeaf554-c728-4a2f-8df2-8a8cc6abac75, localhost:6120): creating call state
2025-11-01 16:45:57,513 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 3eeaf554-c728-4a2f-8df2-8a8cc6abac75, localhost:6120): request = { database: "/Root/users/database" }
2025-11-01 16:45:57,470 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: create table one
2025-11-01 16:45:57,520 - DEBUG - ydb.table.SessionPool - subscribe: Active session queue is empty, subscribe waiter for a session
2025-11-01 16:45:57,520 - DEBUG - ydb.table.SessionPool - subscribe: Subscribe waiter <Future at 0x7fb5d668c100 state=pending>
2025-11-01 16:45:57,520 - DEBUG - ydb.table.SessionPool - subscribe: Session pool is not large enough (active_count < size: 0 < 1). will create a new session.
2025-11-01 16:45:57,521 - DEBUG - ydb.table.SessionPool - _create: Created session <ydb.table.Session object at 0x7fb5d665bbc0>
2025-11-01 16:45:57,521 - DEBUG - ydb.table.SessionPool - _prepare: Preparing session <ydb.table.Session object at 0x7fb5d665bbc0>
2025-11-01 16:45:57,521 - ERROR - ydb.table.SessionPool - _on_session_create: Failed to create session. Put event to a delayed queue. Reason: Couldn't find valid connection
2025-11-01 16:45:57,524 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 3eeaf554-c728-4a2f-8df2-8a8cc6abac75, localhost:6120): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-tvlw7frnpa.auto.internal" port: 8622 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" node_id: 50001 } self_location: "1" } } } }
2025-11-01 16:45:57,543 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root/users/database: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-tvlw7frnpa.auto.internal:8622, location , ssl: False>]>
2025-11-01 16:45:57,577 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 16:45:57,587 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6120
2025-11-01 16:45:57,587 - DEBUG - ydb.table.SessionPool - _prepare: Preparing session <ydb.table.Session object at 0x7fb5d665bbc0>
2025-11-01 16:45:57,603 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, acc496e2-0950-4bfb-90ad-38834bf87f3e, ghrun-tvlw7frnpa.auto.internal:8622): creating call state
2025-11-01 16:45:57,604 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, acc496e2-0950-4bfb-90ad-38834bf87f3e, ghrun-tvlw7frnpa.auto.internal:8622): request = { operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-11-01 16:45:57,779 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, acc496e2-0950-4bfb-90ad-38834bf87f3e, ghrun-tvlw7frnpa.auto.internal:8622): on response callback started
2025-11-01 16:45:57,780 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, acc496e2-0950-4bfb-90ad-38834bf87f3e, ghrun-tvlw7frnpa.auto.internal:8622): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=50001&id=ZGI2NDBlNmEtNjQyZTRlYTUtODhmODU0MGEtODY0MGYyY2Q=" } } } }
2025-11-01 16:45:57,780 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fb5d665bbc0>
2025-11-01 16:45:57,787 - DEBUG - ydb.table.SessionPool - put: Replying to waiter with a session <ydb.table.Session object at 0x7fb5d665bbc0>
2025-11-01 16:45:57,787 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, acc496e2-0950-4bfb-90ad-38834bf87f3e, ghrun-tvlw7frnpa.auto.internal:8622): on response callback success
2025-11-01 16:45:57,788 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 2de0c510-899e-49eb-a3b1-0f83ebc2349a, ghrun-tvlw7frnpa.auto.internal:8622): creating call state
2025-11-01 16:45:57,789 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 2de0c510-899e-49eb-a3b1-0f83ebc2349a, ghrun-tvlw7frnpa.auto.internal:8622): request = { session_id: "ydb://session/3?node_id=50001&id=ZGI2NDBlNmEtNjQyZTRlYTUtODhmODU0MGEtODY0MGYyY2Q=" path: "/Root/users/database/table" columns { name: "id" type { optional_type { item { type_id: UINT64 } } } } columns { name: "value" type { optional_type { item { type_id: UTF8 } } } } primary_key: "id" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:45:57,797 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 2de0c510-899e-49eb-a3b1-0f83ebc2349a, ghrun-tvlw7frnpa.auto.internal:8622): response = { operation { ready: true status: UNAVAILABLE issues { message: "Schemeshard not available" severity: 1 } } }
2025-11-01 16:45:57,825 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fb5d665bbc0>
2025-11-01 16:45:57,919 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, ee65bc04-6bc9-423e-9cf0-a9063e1a40e2, ghrun-tvlw7frnpa.auto.internal:8622): creating call state
2025-11-01 16:45:57,924 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, ee65bc04-6bc9-423e-9cf0-a9063e1a40e2, ghrun-tvlw7frnpa.auto.internal:8622): request = { session_id: "ydb://session/3?node_id=50001&id=ZGI2NDBlNmEtNjQyZTRlYTUtODhmODU0MGEtODY0MGYyY2Q=" path: "/Root/users/database/table" columns { name: "id" type { optional_type { item { type_id: UINT64 } } } } columns { name: "value" type { optional_type { item { type_id: UTF8 } } } } primary_key: "id" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:45:57,933 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, ee65bc04-6bc9-423e-9cf0-a9063e1a40e2, ghrun-tvlw7frnpa.auto.internal:8622): response = { operation { ready: true status: UNAVAILABLE issues { message: "Schemeshard not available" severity: 1 } } }
2025-11-01 16:45:57,936 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fb5d665bbc0>
2025-11-01 16:45:58,034 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 0b6715ae-22b0-4f08-9d2a-d0f7fe879fde, ghrun-tvlw7frnpa.auto.internal:8622): creating call state
2025-11-01 16:45:58,041 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 0b6715ae-22b0-4f08-9d2a-d0f7fe879fde, ghrun-tvlw7frnpa.auto.internal:8622): request = { session_id: "ydb://session/3?node_id=50001&id=ZGI2NDBlNmEtNjQyZTRlYTUtODhmODU0MGEtODY0MGYyY2Q=" path: "/Root/users/database/table" columns { name: "id" type { optional_type { item { type_id: UINT64 } } } } columns { name: "value" type { optional_type { item { type_id: UTF8 } } } } primary_key: "id" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:45:58,161 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 0b6715ae-22b0-4f08-9d2a-d0f7fe879fde, ghrun-tvlw7frnpa.auto.internal:8622): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:45:58,162 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fb5d665bbc0>
2025-11-01 16:45:58,162 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: create table two
2025-11-01 16:45:58,163 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 95abacb6-642a-42ae-bb9b-47fc0e77172a, ghrun-tvlw7frnpa.auto.internal:8622): creating call state
2025-11-01 16:45:58,163 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 95abacb6-642a-42ae-bb9b-47fc0e77172a, ghrun-tvlw7frnpa.auto.internal:8622): request = { session_id: "ydb://session/3?node_id=50001&id=ZGI2NDBlNmEtNjQyZTRlYTUtODhmODU0MGEtODY0MGYyY2Q=" path: "/Root/users/database/table_for_rm" columns { name: "id" type { optional_type { item { type_id: UINT64 } } } } columns { name: "value" type { optional_type { item { type_id: UTF8 } } } } primary_key: "id" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:45:58,215 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 95abacb6-642a-42ae-bb9b-47fc0e77172a, ghrun-tvlw7frnpa.auto.internal:8622): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:45:58,216 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fb5d665bbc0>
2025-11-01 16:45:58,216 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: write_some_data
2025-11-01 16:45:58,238 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 2a5349db-aec1-4a26-88b7-239020f05b8d, ghrun-tvlw7frnpa.auto.internal:8622): creating call state
2025-11-01 16:45:58,239 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 2a5349db-aec1-4a26-88b7-239020f05b8d, ghrun-tvlw7frnpa.auto.internal:8622): request = { session_id: "ydb://session/3?node_id=50001&id=ZGI2NDBlNmEtNjQyZTRlYTUtODhmODU0MGEtODY0MGYyY2Q=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "\n                        upsert into table (id, value)\n                        values (1u, \"/Root/users/database_1\");\n                        upsert into table_for_rm (id, value)\n                        values (2u, \"/Root/users/database_1\");\n                        " } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:45:58,446 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 2a5349db-aec1-4a26-88b7-239020f05b8d, ghrun-tvlw7frnpa.auto.internal:8622): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-11-01 16:45:58,457 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fb5d665bbc0>
2025-11-01 16:45:58,457 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: read_some_data
2025-11-01 16:45:58,458 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, e2dbfa63-24b6-4962-a00d-7fc844d27faf, ghrun-tvlw7frnpa.auto.internal:8622): creating call state
2025-11-01 16:45:58,459 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, e2dbfa63-24b6-4962-a00d-7fc844d27faf, ghrun-tvlw7frnpa.auto.internal:8622): request = { session_id: "ydb://session/3?node_id=50001&id=ZGI2NDBlNmEtNjQyZTRlYTUtODhmODU0MGEtODY0MGYyY2Q=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "\n                        select id, value FROM table;\n                        select id, value FROM table_for_rm;\n                        " } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:45:58,544 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, e2dbfa63-24b6-4962-a00d-7fc844d27faf, ghrun-tvlw7frnpa.auto.internal:8622): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { result_sets { columns { name: "id" type { optional_type { item { type_id: UINT64 } } } } columns { name: "value" type { optional_type { item { type_id: UTF8 } } } } rows { items { uint64_value: 1 } items { text_value: "/Root/users/database_1" } } format: FORMAT_VALUE } result_sets { columns { name: "id" type { optional_type { item { type_id: UINT64 } } } } columns { name: "value" type { optional_type { item { type_id: UTF8 } } } } rows { items { uint64_value: 2 } items { text_value: "/Root/users/database_1" } } format: FORMAT_VALUE } tx_meta { } } } } }
2025-11-01 16:45:58,545 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fb5d665bbc0>
2025-11-01 16:45:58,545 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: drop table two
2025-11-01 16:45:58,546 - DEBUG - ydb.connection - _prepare_call: RpcState(DropTable, b0cfa547-5c29-4d7f-99bd-1394d8dc25cf, ghrun-tvlw7frnpa.auto.internal:8622): creating call state
2025-11-01 16:45:58,546 - DEBUG - ydb.connection - _log_request: RpcState(DropTable, b0cfa547-5c29-4d7f-99bd-1394d8dc25cf, ghrun-tvlw7frnpa.auto.internal:8622): request = { session_id: "ydb://session/3?node_id=50001&id=ZGI2NDBlNmEtNjQyZTRlYTUtODhmODU0MGEtODY0MGYyY2Q=" path: "/Root/users/database/table_for_rm" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:45:58,621 - DEBUG - ydb.connection - _log_response: RpcState(DropTable, b0cfa547-5c29-4d7f-99bd-1394d8dc25cf, ghrun-tvlw7frnpa.auto.internal:8622): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:45:58,628 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fb5d665bbc0>
2025-11-01 16:45:58,629 - DEBUG - ydb.table.SessionPool - stop: Requested session pool stop.
2025-11-01 16:45:58,629 - DEBUG - ydb.table.SessionPool - stop: Session pool is under stop, cancelling all in flight waiters.
2025-11-01 16:45:58,629 - DEBUG - ydb.table.SessionPool - stop: Destroying sessions in active queue
2025-11-01 16:45:58,629 - DEBUG - ydb.table.SessionPool - _destroy: Requested session destroy: <ydb.table.Session object at 0x7fb5d665bbc0>, reason: session-pool-terminated
2025-11-01 16:45:58,629 - DEBUG - ydb.table.SessionPool - _destroy: Session <ydb.table.Session object at 0x7fb5d665bbc0> is no longer active. Current active count 0.
2025-11-01 16:45:58,630 - DEBUG - ydb.connection - _prepare_call: RpcState(DeleteSession, 82c0976e-8484-4734-b6a2-3f251c87eeaa, ghrun-tvlw7frnpa.auto.internal:8622): creating call state
2025-11-01 16:45:58,630 - DEBUG - ydb.table.SessionPool - _terminate_event: Terminated session pool.
2025-11-01 16:45:58,642 - DEBUG - ydb.connection - _log_request: RpcState(DeleteSession, 82c0976e-8484-4734-b6a2-3f251c87eeaa, ghrun-tvlw7frnpa.auto.internal:8622): request = { session_id: "ydb://session/3?node_id=50001&id=ZGI2NDBlNmEtNjQyZTRlYTUtODhmODU0MGEtODY0MGYyY2Q=" operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-11-01 16:45:58,659 - DEBUG - ydb.connection - _on_response_callback: RpcState(DeleteSession, 82c0976e-8484-4734-b6a2-3f251c87eeaa, ghrun-tvlw7frnpa.auto.internal:8622): on response callback started
2025-11-01 16:45:58,667 - DEBUG - ydb.connection - _log_response: RpcState(DeleteSession, 82c0976e-8484-4734-b6a2-3f251c87eeaa, ghrun-tvlw7frnpa.auto.internal:8622): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:45:58,687 - DEBUG - ydb.connection - _on_response_callback: RpcState(DeleteSession, 82c0976e-8484-4734-b6a2-3f251c87eeaa, ghrun-tvlw7frnpa.auto.internal:8622): on response callback success
2025-11-01 16:45:58,688 - DEBUG - ydb.table.SessionPool - _destroy: Sent delete on session <ydb.table.Session object at 0x7fb5d665bbc0>
2025-11-01 16:45:58,688 - DEBUG - ydb.table.SessionPool - stop: Destroyed active sessions
2025-11-01 16:45:58,688 - DEBUG - ydb.topic - close: Close topic client
2025-11-01 16:45:58,689 - DEBUG - ydb.topic - close: Topic client was closed
2025-11-01 16:45:58,689 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6120
2025-11-01 16:45:58,689 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-tvlw7frnpa.auto.internal:8622
2025-11-01 16:45:58,690 - INFO - ydb.pool.Discovery - run: Successfully terminated discovery process
2025-11-01 16:45:58,692 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: remove_database
2025-11-01 16:45:58,711 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - remove_database: /Root/users/database
2025-11-01 16:45:58,711 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_send_op: /Root/users/database: send console operation, token None
2025-11-01 16:45:58,720 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_send_op: /Root/users/database: response from console: RemoveTenantResponse {
  Response {
    operation {
      id: "ydb://cmsrequest/5?tenant=/Root/users/database&cmstid=72057594037936131&txid=1762015558716851&action=2"
    }
  }
}
Status {
  Code: STATUS_CODE_UNSPECIFIED
}

2025-11-01 16:45:58,744 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/users/database: wait console operation done
2025-11-01 16:45:59,264 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/users/database: console operation done
2025-11-01 16:45:59,266 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/users/database: wait tenant gone
2025-11-01 16:45:59,273 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/users/database: tenant gone
2025-11-01 16:46:00,302 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:8622/2
2025-11-01 16:46:00,303 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: done 1
2025-11-01 16:46:00,303 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: create_database
2025-11-01 16:46:00,830 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/q6a6/0023f4/ydb/apps/ydbd/ydbd
2025-11-01 16:46:00,837 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/22361
2025-11-01 16:46:00,850 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/61542
2025-11-01 16:46:00,870 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/9409
2025-11-01 16:46:00,871 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/14111
2025-11-01 16:46:00,872 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/64187
2025-11-01 16:46:00,873 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/q6a6/0023f4/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/kikimr_configs"
2025-11-01 16:46:00,875 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/q6a6/0023f4/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:6120 --tenant=/Root/users/database --log-file-name=/home/runner/.ya/build/build_root/q6a6/0023f4/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_x_4m_8sy.log --grpc-port=22361 --mon-port=61542 --ic-port=9409
2025-11-01 16:46:00,875 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/q6a6/0023f4/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/kikimr_configs"
2025-11-01 16:46:00,875 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/q6a6/0023f4/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:6120 --tenant=/Root/users/database --log-file-name=/home/runner/.ya/build/build_root/q6a6/0023f4/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_x_4m_8sy.log --grpc-port=22361 --mon-port=61542 --ic-port=9409
2025-11-01 16:46:00,880 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/q6a6/0023f4/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/q6a6/0023f4/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:6120', '--tenant=/Root/users/database', '--log-file-name=/home/runner/.ya/build/build_root/q6a6/0023f4/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_x_4m_8sy.log', '--grpc-port=22361', '--mon-port=61542', '--ic-port=9409')' in '/home/runner/.ya/build/build_root/q6a6/0023f4/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/slot_3' (no wait)
2025-11-01 16:46:00,881 - DEBUG - ya.test - execute: Command pid: 3054048
2025-11-01 16:46:00,882 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:22361/3
2025-11-01 16:46:00,907 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.32
2025-11-01 16:46:00,912 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.32
2025-11-01 16:46:00,913 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/q6a6/0023f4/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 16:46:00,919 - DEBUG - ya.test - execute: Command pid: 3054056
2025-11-01 16:46:01,835 - DEBUG - ya.test - _save_outputs: Command (pid 3054056) rc: 0
2025-11-01 16:46:01,835 - DEBUG - ya.test - _save_outputs: Command (pid 3054056) elapsed time (sec): 0.8991036415100098
2025-11-01 16:46:01,836 - DEBUG - ya.test - _save_outputs: Command (pid 3054056) idrss: 0
2025-11-01 16:46:01,836 - DEBUG - ya.test - _save_outputs: Command (pid 3054056) inblock: 0
2025-11-01 16:46:01,842 - DEBUG - ya.test - _save_outputs: Command (pid 3054056) isrss: 0
2025-11-01 16:46:01,844 - DEBUG - ya.test - _save_outputs: Command (pid 3054056) ixrss: 0
2025-11-01 16:46:01,845 - DEBUG - ya.test - _save_outputs: Command (pid 3054056) majflt: 0
2025-11-01 16:46:01,845 - DEBUG - ya.test - _save_outputs: Command (pid 3054056) maxrss: 538512
2025-11-01 16:46:01,845 - DEBUG - ya.test - _save_outputs: Command (pid 3054056) minflt: 16131
2025-11-01 16:46:01,845 - DEBUG - ya.test - _save_outputs: Command (pid 3054056) msgrcv: 0
2025-11-01 16:46:01,845 - DEBUG - ya.test - _save_outputs: Command (pid 3054056) msgsnd: 0
2025-11-01 16:46:01,845 - DEBUG - ya.test - _save_outputs: Command (pid 3054056) nivcsw: 95
2025-11-01 16:46:01,846 - DEBUG - ya.test - _save_outputs: Command (pid 3054056) nsignals: 0
2025-11-01 16:46:01,846 - DEBUG - ya.test - _save_outputs: Command (pid 3054056) nswap: 0
2025-11-01 16:46:01,846 - DEBUG - ya.test - _save_outputs: Command (pid 3054056) nvcsw: 19
2025-11-01 16:46:01,846 - DEBUG - ya.test - _save_outputs: Command (pid 3054056) oublock: 8
2025-11-01 16:46:01,846 - DEBUG - ya.test - _save_outputs: Command (pid 3054056) stime: 0.252685
2025-11-01 16:46:01,846 - DEBUG - ya.test - _save_outputs: Command (pid 3054056) utime: 0.10951999999999999
2025-11-01 16:46:01,847 - DEBUG - ya.test - _save_outputs: Command (pid 3054056) wtime: 0.905
2025-11-01 16:46:01,847 - DEBUG - ya.test - _save_outputs: Command (pid 3054056) output:
Git info:
    Commit: 34ddad56c8a7bb530ecf731d374c04f98d3d2aca
    Branch: 
    Author: azevaykin <145343289+azevaykin@users.noreply.github.com>
    Summary: Merge f53a17d638f4ee7a8f08354cd76c33a88c4925c5 into 5dbd26ce2068671edb74bb9f072505a44ea73d1e

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

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

2025-11-01 16:46:01,849 - DEBUG - ya.test - _save_outputs: Command (pid 3054056) errors:

2025-11-01 16:46:01,853 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 3 version:
Git info:
    Commit: 34ddad56c8a7bb530ecf731d374c04f98d3d2aca
    Branch: 
    Author: azevaykin <145343289+azevaykin@users.noreply.github.com>
    Summary: Merge f53a17d638f4ee7a8f08354cd76c33a88c4925c5 into 5dbd26ce2068671edb74bb9f072505a44ea73d1e
2025-11-01 16:46:01,853 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 16:46:01,856 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 16:46:01,857 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: create table one
2025-11-01 16:46:01,858 - DEBUG - ydb.table.SessionPool - subscribe: Active session queue is empty, subscribe waiter for a session
2025-11-01 16:46:01,858 - DEBUG - ydb.table.SessionPool - subscribe: Subscribe waiter <Future at 0x7fb5ef843990 state=pending>
2025-11-01 16:46:01,859 - DEBUG - ydb.table.SessionPool - subscribe: Session pool is not large enough (active_count < size: 0 < 1). will create a new session.
2025-11-01 16:46:01,859 - DEBUG - ydb.table.SessionPool - _create: Created session <ydb.table.Session object at 0x7fb5ef843620>
2025-11-01 16:46:01,859 - DEBUG - ydb.table.SessionPool - _prepare: Preparing session <ydb.table.Session object at 0x7fb5ef843620>
2025-11-01 16:46:01,857 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 16:46:01,860 - ERROR - ydb.table.SessionPool - _on_session_create: Failed to create session. Put event to a delayed queue. Reason: Couldn't find valid connection
2025-11-01 16:46:01,867 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/users/database
2025-11-01 16:46:01,868 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 28ca40a5-9085-4b0a-9140-77d800ee95ac, localhost:6120): creating call state
2025-11-01 16:46:01,868 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 28ca40a5-9085-4b0a-9140-77d800ee95ac, localhost:6120): request = { database: "/Root/users/database" }
2025-11-01 16:46:01,870 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 28ca40a5-9085-4b0a-9140-77d800ee95ac, localhost:6120): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { self_location: "1" } } } }
2025-11-01 16:46:01,871 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root/users/database: DiscoveryResult <self_location: 1, endpoints []>
2025-11-01 16:46:01,871 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6120
2025-11-01 16:46:03,438 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 16:46:03,438 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 16:46:03,486 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/users/database
2025-11-01 16:46:03,487 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 9b08a550-0484-458f-ba7a-82326d467769, localhost:6120): creating call state
2025-11-01 16:46:03,487 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 9b08a550-0484-458f-ba7a-82326d467769, localhost:6120): request = { database: "/Root/users/database" }
2025-11-01 16:46:03,495 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 9b08a550-0484-458f-ba7a-82326d467769, localhost:6120): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-tvlw7frnpa.auto.internal" port: 22361 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" node_id: 50002 } self_location: "1" } } } }
2025-11-01 16:46:03,496 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root/users/database: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-tvlw7frnpa.auto.internal:22361, location , ssl: False>]>
2025-11-01 16:46:03,526 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 16:46:03,559 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6120
2025-11-01 16:46:03,559 - DEBUG - ydb.table.SessionPool - _prepare: Preparing session <ydb.table.Session object at 0x7fb5ef843620>
2025-11-01 16:46:03,560 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, fad23218-a974-4689-80bb-324a1dc153a8, ghrun-tvlw7frnpa.auto.internal:22361): creating call state
2025-11-01 16:46:03,566 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, fad23218-a974-4689-80bb-324a1dc153a8, ghrun-tvlw7frnpa.auto.internal:22361): request = { operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-11-01 16:46:03,581 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, fad23218-a974-4689-80bb-324a1dc153a8, ghrun-tvlw7frnpa.auto.internal:22361): on response callback started
2025-11-01 16:46:03,581 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, fad23218-a974-4689-80bb-324a1dc153a8, ghrun-tvlw7frnpa.auto.internal:22361): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=50002&id=NDgwNTY2ZTktYmQ3OWIzOWEtMzkyNGJhYTEtZTExMTc5NWE=" } } } }
2025-11-01 16:46:03,582 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fb5ef843620>
2025-11-01 16:46:03,582 - DEBUG - ydb.table.SessionPool - put: Replying to waiter with a session <ydb.table.Session object at 0x7fb5ef843620>
2025-11-01 16:46:03,583 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, fad23218-a974-4689-80bb-324a1dc153a8, ghrun-tvlw7frnpa.auto.internal:22361): on response callback success
2025-11-01 16:46:03,587 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 14387cbc-9d81-41cb-baf1-020234e52937, ghrun-tvlw7frnpa.auto.internal:22361): creating call state
2025-11-01 16:46:03,591 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 14387cbc-9d81-41cb-baf1-020234e52937, ghrun-tvlw7frnpa.auto.internal:22361): request = { session_id: "ydb://session/3?node_id=50002&id=NDgwNTY2ZTktYmQ3OWIzOWEtMzkyNGJhYTEtZTExMTc5NWE=" path: "/Root/users/database/table" columns { name: "id" type { optional_type { item { type_id: UINT64 } } } } columns { name: "value" type { optional_type { item { type_id: UTF8 } } } } primary_key: "id" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:46:03,688 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 14387cbc-9d81-41cb-baf1-020234e52937, ghrun-tvlw7frnpa.auto.internal:22361): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:46:03,720 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fb5ef843620>
2025-11-01 16:46:03,720 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: create table two
2025-11-01 16:46:03,721 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 4c24d5a1-67bc-400c-a95e-0cb8be8fecab, ghrun-tvlw7frnpa.auto.internal:22361): creating call state
2025-11-01 16:46:03,722 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 4c24d5a1-67bc-400c-a95e-0cb8be8fecab, ghrun-tvlw7frnpa.auto.internal:22361): request = { session_id: "ydb://session/3?node_id=50002&id=NDgwNTY2ZTktYmQ3OWIzOWEtMzkyNGJhYTEtZTExMTc5NWE=" path: "/Root/users/database/table_for_rm" columns { name: "id" type { optional_type { item { type_id: UINT64 } } } } columns { name: "value" type { optional_type { item { type_id: UTF8 } } } } primary_key: "id" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:46:03,765 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 4c24d5a1-67bc-400c-a95e-0cb8be8fecab, ghrun-tvlw7frnpa.auto.internal:22361): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:46:03,767 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fb5ef843620>
2025-11-01 16:46:03,768 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: write_some_data
2025-11-01 16:46:03,768 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, a6263107-f748-495e-9af3-49f93f26acd1, ghrun-tvlw7frnpa.auto.internal:22361): creating call state
2025-11-01 16:46:03,772 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, a6263107-f748-495e-9af3-49f93f26acd1, ghrun-tvlw7frnpa.auto.internal:22361): request = { session_id: "ydb://session/3?node_id=50002&id=NDgwNTY2ZTktYmQ3OWIzOWEtMzkyNGJhYTEtZTExMTc5NWE=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "\n                        upsert into table (id, value)\n                        values (1u, \"/Root/users/database_2\");\n                        upsert into table_for_rm (id, value)\n                        values (2u, \"/Root/users/database_2\");\n                        " } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:46:03,810 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, a6263107-f748-495e-9af3-49f93f26acd1, ghrun-tvlw7frnpa.auto.internal:22361): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-11-01 16:46:03,811 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fb5ef843620>
2025-11-01 16:46:03,812 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: read_some_data
2025-11-01 16:46:03,818 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 70bbecf4-062d-4141-8893-2e7312248133, ghrun-tvlw7frnpa.auto.internal:22361): creating call state
2025-11-01 16:46:03,821 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 70bbecf4-062d-4141-8893-2e7312248133, ghrun-tvlw7frnpa.auto.internal:22361): request = { session_id: "ydb://session/3?node_id=50002&id=NDgwNTY2ZTktYmQ3OWIzOWEtMzkyNGJhYTEtZTExMTc5NWE=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "\n                        select id, value FROM table;\n                        select id, value FROM table_for_rm;\n                        " } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:46:03,860 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 70bbecf4-062d-4141-8893-2e7312248133, ghrun-tvlw7frnpa.auto.internal:22361): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { result_sets { columns { name: "id" type { optional_type { item { type_id: UINT64 } } } } columns { name: "value" type { optional_type { item { type_id: UTF8 } } } } rows { items { uint64_value: 1 } items { text_value: "/Root/users/database_2" } } format: FORMAT_VALUE } result_sets { columns { name: "id" type { optional_type { item { type_id: UINT64 } } } } columns { name: "value" type { optional_type { item { type_id: UTF8 } } } } rows { items { uint64_value: 2 } items { text_value: "/Root/users/database_2" } } format: FORMAT_VALUE } tx_meta { } } } } }
2025-11-01 16:46:03,875 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fb5ef843620>
2025-11-01 16:46:03,876 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: drop table two
2025-11-01 16:46:03,900 - DEBUG - ydb.connection - _prepare_call: RpcState(DropTable, 372cf7ce-8a42-4c0a-8a6e-95ee36f0e11f, ghrun-tvlw7frnpa.auto.internal:22361): creating call state
2025-11-01 16:46:03,901 - DEBUG - ydb.connection - _log_request: RpcState(DropTable, 372cf7ce-8a42-4c0a-8a6e-95ee36f0e11f, ghrun-tvlw7frnpa.auto.internal:22361): request = { session_id: "ydb://session/3?node_id=50002&id=NDgwNTY2ZTktYmQ3OWIzOWEtMzkyNGJhYTEtZTExMTc5NWE=" path: "/Root/users/database/table_for_rm" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:46:03,945 - DEBUG - ydb.connection - _log_response: RpcState(DropTable, 372cf7ce-8a42-4c0a-8a6e-95ee36f0e11f, ghrun-tvlw7frnpa.auto.internal:22361): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:46:03,946 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fb5ef843620>
2025-11-01 16:46:03,946 - DEBUG - ydb.table.SessionPool - stop: Requested session pool stop.
2025-11-01 16:46:03,946 - DEBUG - ydb.table.SessionPool - stop: Session pool is under stop, cancelling all in flight waiters.
2025-11-01 16:46:03,949 - DEBUG - ydb.table.SessionPool - stop: Destroying sessions in active queue
2025-11-01 16:46:03,949 - DEBUG - ydb.table.SessionPool - _destroy: Requested session destroy: <ydb.table.Session object at 0x7fb5ef843620>, reason: session-pool-terminated
2025-11-01 16:46:03,949 - DEBUG - ydb.table.SessionPool - _destroy: Session <ydb.table.Session object at 0x7fb5ef843620> is no longer active. Current active count 0.
2025-11-01 16:46:03,950 - DEBUG - ydb.connection - _prepare_call: RpcState(DeleteSession, 0afe3434-eab5-401f-b198-e0074e2ed8e8, ghrun-tvlw7frnpa.auto.internal:22361): creating call state
2025-11-01 16:46:03,957 - DEBUG - ydb.connection - _log_request: RpcState(DeleteSession, 0afe3434-eab5-401f-b198-e0074e2ed8e8, ghrun-tvlw7frnpa.auto.internal:22361): request = { session_id: "ydb://session/3?node_id=50002&id=NDgwNTY2ZTktYmQ3OWIzOWEtMzkyNGJhYTEtZTExMTc5NWE=" operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-11-01 16:46:03,947 - DEBUG - ydb.table.SessionPool - _terminate_event: Terminated session pool.
2025-11-01 16:46:03,964 - DEBUG - ydb.connection - _on_response_callback: RpcState(DeleteSession, 0afe3434-eab5-401f-b198-e0074e2ed8e8, ghrun-tvlw7frnpa.auto.internal:22361): on response callback started
2025-11-01 16:46:03,976 - DEBUG - ydb.connection - _log_response: RpcState(DeleteSession, 0afe3434-eab5-401f-b198-e0074e2ed8e8, ghrun-tvlw7frnpa.auto.internal:22361): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:46:03,977 - DEBUG - ydb.connection - _on_response_callback: RpcState(DeleteSession, 0afe3434-eab5-401f-b198-e0074e2ed8e8, ghrun-tvlw7frnpa.auto.internal:22361): on response callback success
2025-11-01 16:46:03,981 - DEBUG - ydb.table.SessionPool - _destroy: Sent delete on session <ydb.table.Session object at 0x7fb5ef843620>
2025-11-01 16:46:03,982 - DEBUG - ydb.table.SessionPool - stop: Destroyed active sessions
2025-11-01 16:46:03,982 - DEBUG - ydb.topic - close: Close topic client
2025-11-01 16:46:03,982 - DEBUG - ydb.topic - close: Topic client was closed
2025-11-01 16:46:03,982 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6120
2025-11-01 16:46:03,986 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-tvlw7frnpa.auto.internal:22361
2025-11-01 16:46:04,030 - INFO - ydb.pool.Discovery - run: Successfully terminated discovery process
2025-11-01 16:46:04,059 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: remove_database
2025-11-01 16:46:04,059 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - remove_database: /Root/users/database
2025-11-01 16:46:04,059 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_send_op: /Root/users/database: send console operation, token None
2025-11-01 16:46:04,066 - 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=1762015564063217&action=2"
    }
  }
}
Status {
  Code: STATUS_CODE_UNSPECIFIED
}

2025-11-01 16:46:04,067 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/users/database: wait console operation done
2025-11-01 16:46:04,575 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/users/database: console operation done
2025-11-01 16:46:04,576 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/users/database: wait tenant gone
2025-11-01 16:46:04,582 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/users/database: tenant gone
2025-11-01 16:46:05,584 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:22361/3
2025-11-01 16:46:05,584 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: done 2
2025-11-01 16:46:05,585 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: create_database
2025-11-01 16:46:06,101 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/q6a6/0023f4/ydb/apps/ydbd/ydbd
2025-11-01 16:46:06,102 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/15031
2025-11-01 16:46:06,102 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/6856
2025-11-01 16:46:06,102 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/25872
2025-11-01 16:46:06,106 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/25202
2025-11-01 16:46:06,106 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/10506
2025-11-01 16:46:06,108 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/q6a6/0023f4/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/kikimr_configs"
2025-11-01 16:46:06,108 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/q6a6/0023f4/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:6120 --tenant=/Root/users/database --log-file-name=/home/runner/.ya/build/build_root/q6a6/0023f4/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_nwn90qpa.log --grpc-port=15031 --mon-port=6856 --ic-port=25872
2025-11-01 16:46:06,108 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/q6a6/0023f4/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/kikimr_configs"
2025-11-01 16:46:06,109 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/q6a6/0023f4/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:6120 --tenant=/Root/users/database --log-file-name=/home/runner/.ya/build/build_root/q6a6/0023f4/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_nwn90qpa.log --grpc-port=15031 --mon-port=6856 --ic-port=25872
2025-11-01 16:46:06,110 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/q6a6/0023f4/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/q6a6/0023f4/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:6120', '--tenant=/Root/users/database', '--log-file-name=/home/runner/.ya/build/build_root/q6a6/0023f4/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_nwn90qpa.log', '--grpc-port=15031', '--mon-port=6856', '--ic-port=25872')' in '/home/runner/.ya/build/build_root/q6a6/0023f4/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_dynamic_tenants.py.test_create_and_drop_the_same_tenant2.enable_alter_database_create_hive_first--false/cluster/slot_4' (no wait)
2025-11-01 16:46:06,149 - DEBUG - ya.test - execute: Command pid: 3056769
2025-11-01 16:46:06,150 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:15031/4
2025-11-01 16:46:06,203 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.33
2025-11-01 16:46:06,277 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.33
2025-11-01 16:46:06,278 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/q6a6/0023f4/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 16:46:06,282 - DEBUG - ya.test - execute: Command pid: 3056773
2025-11-01 16:46:06,856 - DEBUG - ya.test - _save_outputs: Command (pid 3056773) rc: 0
2025-11-01 16:46:06,856 - DEBUG - ya.test - _save_outputs: Command (pid 3056773) elapsed time (sec): 0.5479180812835693
2025-11-01 16:46:06,857 - DEBUG - ya.test - _save_outputs: Command (pid 3056773) idrss: 0
2025-11-01 16:46:06,857 - DEBUG - ya.test - _save_outputs: Command (pid 3056773) inblock: 0
2025-11-01 16:46:06,857 - DEBUG - ya.test - _save_outputs: Command (pid 3056773) isrss: 0
2025-11-01 16:46:06,857 - DEBUG - ya.test - _save_outputs: Command (pid 3056773) ixrss: 0
2025-11-01 16:46:06,857 - DEBUG - ya.test - _save_outputs: Command (pid 3056773) majflt: 0
2025-11-01 16:46:06,858 - DEBUG - ya.test - _save_outputs: Command (pid 3056773) maxrss: 538512
2025-11-01 16:46:06,858 - DEBUG - ya.test - _save_outputs: Command (pid 3056773) minflt: 16131
2025-11-01 16:46:06,858 - DEBUG - ya.test - _save_outputs: Command (pid 3056773) msgrcv: 0
2025-11-01 16:46:06,858 - DEBUG - ya.test - _save_outputs: Command (pid 3056773) msgsnd: 0
2025-11-01 16:46:06,859 - DEBUG - ya.test - _save_outputs: Command (pid 3056773) nivcsw: 109
2025-11-01 16:46:06,859 - DEBUG - ya.test - _save_outputs: Command (pid 3056773) nsignals: 0
2025-11-01 16:46:06,887 - DEBUG - ya.test - _save_outputs: Command (pid 3056773) nswap: 0
2025-11-01 16:46:06,887 - DEBUG - ya.test - _save_outputs: Command (pid 3056773) nvcsw: 14
2025-11-01 16:46:06,887 - DEBUG - ya.test - _save_outputs: Command (pid 3056773) oublock: 8
2025-11-01 16:46:06,887 - DEBUG - ya.test - _save_outputs: Command (pid 3056773) stime: 0.22563799999999998
2025-11-01 16:46:06,888 - DEBUG - ya.test - _save_outputs: Command (pid 3056773) utime: 0.11101699999999999
2025-11-01 16:46:06,888 - DEBUG - ya.test - _save_outputs: Command (pid 3056773) wtime: 0.553
2025-11-01 16:46:06,888 - DEBUG - ya.test - _save_outputs: Command (pid 3056773) output:
Git info:
    Commit: 34ddad56c8a7bb530ecf731d374c04f98d3d2aca
    Branch: 
    Author: azevaykin <145343289+azevaykin@users.noreply.github.com>
    Summary: Merge f53a17d638f4ee7a8f08354cd76c33a88c4925c5 into 5dbd26ce2068671edb74bb9f072505a44ea73d1e

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

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

2025-11-01 16:46:06,888 - DEBUG - ya.test - _save_outputs: Command (pid 3056773) errors:

2025-11-01 16:46:06,889 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 4 version:
Git info:
    Commit: 34ddad56c8a7bb530ecf731d374c04f98d3d2aca
    Branch: 
    Author: azevaykin <145343289+azevaykin@users.noreply.github.com>
    Summary: Merge f53a17d638f4ee7a8f08354cd76c33a88c4925c5 into 5dbd26ce2068671edb74bb9f072505a44ea73d1e
2025-11-01 16:46:06,889 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 16:46:06,893 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 16:46:06,894 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 16:46:06,893 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: create table one
2025-11-01 16:46:06,947 - DEBUG - ydb.table.SessionPool - subscribe: Active session queue is empty, subscribe waiter for a session
2025-11-01 16:46:06,947 - DEBUG - ydb.table.SessionPool - subscribe: Subscribe waiter <Future at 0x7fb5ef92a6d0 state=pending>
2025-11-01 16:46:06,947 - DEBUG - ydb.table.SessionPool - subscribe: Session pool is not large enough (active_count < size: 0 < 1). will create a new session.
2025-11-01 16:46:06,947 - DEBUG - ydb.table.SessionPool - _create: Created session <ydb.table.Session object at 0x7fb5ef92a310>
2025-11-01 16:46:06,948 - DEBUG - ydb.table.SessionPool - _prepare: Preparing session <ydb.table.Session object at 0x7fb5ef92a310>
2025-11-01 16:46:06,948 - ERROR - ydb.table.SessionPool - _on_session_create: Failed to create session. Put event to a delayed queue. Reason: Couldn't find valid connection
2025-11-01 16:46:06,903 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/users/database
2025-11-01 16:46:06,949 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 52fd06a0-cb85-4285-8048-62d11cd10da2, localhost:6120): creating call state
2025-11-01 16:46:06,949 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 52fd06a0-cb85-4285-8048-62d11cd10da2, localhost:6120): request = { database: "/Root/users/database" }
2025-11-01 16:46:06,956 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 52fd06a0-cb85-4285-8048-62d11cd10da2, localhost:6120): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-11-01 16:46:06,958 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root/users/database. Endpoint: "localhost:6120". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-11-01 16:46:07,011 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6120
2025-11-01 16:46:08,520 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 16:46:08,520 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 16:46:08,560 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/users/database
2025-11-01 16:46:08,587 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 1b2fbba2-1363-4997-9020-f69a5dd6cfce, localhost:6120): creating call state
2025-11-01 16:46:08,603 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 1b2fbba2-1363-4997-9020-f69a5dd6cfce, localhost:6120): request = { database: "/Root/users/database" }
2025-11-01 16:46:08,611 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 1b2fbba2-1363-4997-9020-f69a5dd6cfce, localhost:6120): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-tvlw7frnpa.auto.internal" port: 15031 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" node_id: 50003 } self_location: "1" } } } }
2025-11-01 16:46:08,637 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root/users/database: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-tvlw7frnpa.auto.internal:15031, location , ssl: False>]>
2025-11-01 16:46:08,638 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 16:46:08,652 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6120
2025-11-01 16:46:08,652 - DEBUG - ydb.table.SessionPool - _prepare: Preparing session <ydb.table.Session object at 0x7fb5ef92a310>
2025-11-01 16:46:08,671 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 8367bd09-7e24-49ad-b389-2cbfdc0af602, ghrun-tvlw7frnpa.auto.internal:15031): creating call state
2025-11-01 16:46:08,672 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 8367bd09-7e24-49ad-b389-2cbfdc0af602, ghrun-tvlw7frnpa.auto.internal:15031): request = { operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-11-01 16:46:08,696 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, 8367bd09-7e24-49ad-b389-2cbfdc0af602, ghrun-tvlw7frnpa.auto.internal:15031): on response callback started
2025-11-01 16:46:08,696 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 8367bd09-7e24-49ad-b389-2cbfdc0af602, ghrun-tvlw7frnpa.auto.internal:15031): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=50003&id=M2QzMDhmNzEtYzhjMTg3MjQtZjU5OWU5Y2QtNDZlZDMzN2M=" } } } }
2025-11-01 16:46:08,697 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fb5ef92a310>
2025-11-01 16:46:08,697 - DEBUG - ydb.table.SessionPool - put: Replying to waiter with a session <ydb.table.Session object at 0x7fb5ef92a310>
2025-11-01 16:46:08,698 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, 8367bd09-7e24-49ad-b389-2cbfdc0af602, ghrun-tvlw7frnpa.auto.internal:15031): on response callback success
2025-11-01 16:46:08,698 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 2674beb8-3891-45e0-a57c-e0d616f92749, ghrun-tvlw7frnpa.auto.internal:15031): creating call state
2025-11-01 16:46:08,701 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 2674beb8-3891-45e0-a57c-e0d616f92749, ghrun-tvlw7frnpa.auto.internal:15031): request = { session_id: "ydb://session/3?node_id=50003&id=M2QzMDhmNzEtYzhjMTg3MjQtZjU5OWU5Y2QtNDZlZDMzN2M=" path: "/Root/users/database/table" columns { name: "id" type { optional_type { item { type_id: UINT64 } } } } columns { name: "value" type { optional_type { item { type_id: UTF8 } } } } primary_key: "id" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:46:08,759 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 2674beb8-3891-45e0-a57c-e0d616f92749, ghrun-tvlw7frnpa.auto.internal:15031): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:46:08,759 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fb5ef92a310>
2025-11-01 16:46:08,760 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: create table two
2025-11-01 16:46:08,761 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, a7beec95-35b1-453a-9a91-a8aaf481105d, ghrun-tvlw7frnpa.auto.internal:15031): creating call state
2025-11-01 16:46:08,763 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, a7beec95-35b1-453a-9a91-a8aaf481105d, ghrun-tvlw7frnpa.auto.internal:15031): request = { session_id: "ydb://session/3?node_id=50003&id=M2QzMDhmNzEtYzhjMTg3MjQtZjU5OWU5Y2QtNDZlZDMzN2M=" path: "/Root/users/database/table_for_rm" columns { name: "id" type { optional_type { item { type_id: UINT64 } } } } columns { name: "value" type { optional_type { item { type_id: UTF8 } } } } primary_key: "id" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:46:08,817 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, a7beec95-35b1-453a-9a91-a8aaf481105d, ghrun-tvlw7frnpa.auto.internal:15031): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:46:08,818 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fb5ef92a310>
2025-11-01 16:46:08,821 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: write_some_data
2025-11-01 16:46:08,828 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 784396fd-c2f3-46d6-a636-0484ba3fcc10, ghrun-tvlw7frnpa.auto.internal:15031): creating call state
2025-11-01 16:46:08,834 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 784396fd-c2f3-46d6-a636-0484ba3fcc10, ghrun-tvlw7frnpa.auto.internal:15031): request = { session_id: "ydb://session/3?node_id=50003&id=M2QzMDhmNzEtYzhjMTg3MjQtZjU5OWU5Y2QtNDZlZDMzN2M=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "\n                        upsert into table (id, value)\n                        values (1u, \"/Root/users/database_3\");\n                        upsert into table_for_rm (id, value)\n                        values (2u, \"/Root/users/database_3\");\n                        " } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:46:08,903 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 784396fd-c2f3-46d6-a636-0484ba3fcc10, ghrun-tvlw7frnpa.auto.internal:15031): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-11-01 16:46:08,904 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fb5ef92a310>
2025-11-01 16:46:08,904 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: read_some_data
2025-11-01 16:46:08,905 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, d8851228-ab69-4990-92b2-4ecbd7ac1b21, ghrun-tvlw7frnpa.auto.internal:15031): creating call state
2025-11-01 16:46:08,911 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, d8851228-ab69-4990-92b2-4ecbd7ac1b21, ghrun-tvlw7frnpa.auto.internal:15031): request = { session_id: "ydb://session/3?node_id=50003&id=M2QzMDhmNzEtYzhjMTg3MjQtZjU5OWU5Y2QtNDZlZDMzN2M=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "\n                        select id, value FROM table;\n                        select id, value FROM table_for_rm;\n                        " } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:46:08,963 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, d8851228-ab69-4990-92b2-4ecbd7ac1b21, ghrun-tvlw7frnpa.auto.internal:15031): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { result_sets { columns { name: "id" type { optional_type { item { type_id: UINT64 } } } } columns { name: "value" type { optional_type { item { type_id: UTF8 } } } } rows { items { uint64_value: 1 } items { text_value: "/Root/users/database_3" } } format: FORMAT_VALUE } result_sets { columns { name: "id" type { optional_type { item { type_id: UINT64 } } } } columns { name: "value" type { optional_type { item { type_id: UTF8 } } } } rows { items { uint64_value: 2 } items { text_value: "/Root/users/database_3" } } format: FORMAT_VALUE } tx_meta { } } } } }
2025-11-01 16:46:08,964 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fb5ef92a310>
2025-11-01 16:46:08,966 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: drop table two
2025-11-01 16:46:08,967 - DEBUG - ydb.connection - _prepare_call: RpcState(DropTable, fa04959e-fd45-4616-9052-8a30aa31a60e, ghrun-tvlw7frnpa.auto.internal:15031): creating call state
2025-11-01 16:46:08,998 - DEBUG - ydb.connection - _log_request: RpcState(DropTable, fa04959e-fd45-4616-9052-8a30aa31a60e, ghrun-tvlw7frnpa.auto.internal:15031): request = { session_id: "ydb://session/3?node_id=50003&id=M2QzMDhmNzEtYzhjMTg3MjQtZjU5OWU5Y2QtNDZlZDMzN2M=" path: "/Root/users/database/table_for_rm" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:46:09,065 - DEBUG - ydb.connection - _log_response: RpcState(DropTable, fa04959e-fd45-4616-9052-8a30aa31a60e, ghrun-tvlw7frnpa.auto.internal:15031): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:46:09,095 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fb5ef92a310>
2025-11-01 16:46:09,095 - DEBUG - ydb.table.SessionPool - stop: Requested session pool stop.
2025-11-01 16:46:09,095 - DEBUG - ydb.table.SessionPool - stop: Session pool is under stop, cancelling all in flight waiters.
2025-11-01 16:46:09,096 - DEBUG - ydb.table.SessionPool - stop: Destroying sessions in active queue
2025-11-01 16:46:09,096 - DEBUG - ydb.table.SessionPool - _destroy: Requested session destroy: <ydb.table.Session object at 0x7fb5ef92a310>, reason: session-pool-terminated
2025-11-01 16:46:09,096 - DEBUG - ydb.table.SessionPool - _destroy: Session <ydb.table.Session object at 0x7fb5ef92a310> is no longer active. Current active count 0.
2025-11-01 16:46:09,096 - DEBUG - ydb.connection - _prepare_call: RpcState(DeleteSession, 5bfbd476-0ef4-4070-a957-5d4d39271898, ghrun-tvlw7frnpa.auto.internal:15031): creating call state
2025-11-01 16:46:09,097 - DEBUG - ydb.connection - _log_request: RpcState(DeleteSession, 5bfbd476-0ef4-4070-a957-5d4d39271898, ghrun-tvlw7frnpa.auto.internal:15031): request = { session_id: "ydb://session/3?node_id=50003&id=M2QzMDhmNzEtYzhjMTg3MjQtZjU5OWU5Y2QtNDZlZDMzN2M=" operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-11-01 16:46:09,098 - DEBUG - ydb.table.SessionPool - _terminate_event: Terminated session pool.
2025-11-01 16:46:09,103 - DEBUG - ydb.connection - _on_response_callback: RpcState(DeleteSession, 5bfbd476-0ef4-4070-a957-5d4d39271898, ghrun-tvlw7frnpa.auto.internal:15031): on response callback started
2025-11-01 16:46:09,104 - DEBUG - ydb.connection - _log_response: RpcState(DeleteSession, 5bfbd476-0ef4-4070-a957-5d4d39271898, ghrun-tvlw7frnpa.auto.internal:15031): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:46:09,104 - DEBUG - ydb.connection - _on_response_callback: RpcState(DeleteSession, 5bfbd476-0ef4-4070-a957-5d4d39271898, ghrun-tvlw7frnpa.auto.internal:15031): on response callback success
2025-11-01 16:46:09,104 - DEBUG - ydb.table.SessionPool - _destroy: Sent delete on session <ydb.table.Session object at 0x7fb5ef92a310>
2025-11-01 16:46:09,131 - DEBUG - ydb.table.SessionPool - stop: Destroyed active sessions
2025-11-01 16:46:09,131 - DEBUG - ydb.topic - close: Close topic client
2025-11-01 16:46:09,148 - DEBUG - ydb.topic - close: Topic client was closed
2025-11-01 16:46:09,149 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6120
2025-11-01 16:46:09,150 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-tvlw7frnpa.auto.internal:15031
2025-11-01 16:46:09,162 - INFO - ydb.pool.Discovery - run: Successfully terminated discovery process
2025-11-01 16:46:09,167 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: remove_database
2025-11-01 16:46:09,175 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - remove_database: /Root/users/database
2025-11-01 16:46:09,178 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_send_op: /Root/users/database: send console operation, token None
2025-11-01 16:46:09,191 - 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=1762015569187986&action=2"
    }
  }
}
Status {
  Code: STATUS_CODE_UNSPECIFIED
}

2025-11-01 16:46:09,192 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/users/database: wait console operation done
2025-11-01 16:46:09,700 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/users/database: console operation done
2025-11-01 16:46:09,700 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/users/database: wait tenant gone
2025-11-01 16:46:09,704 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/users/database: tenant gone
2025-11-01 16:46:12,731 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:15031/4
2025-11-01 16:46:12,736 - DEBUG - __tests__.test_dynamic_tenants - test_create_and_drop_the_same_tenant2: done 3
2025-11-01 16:46:12,738 - INFO - ya.test - pytest_runtest_teardown: Test teardown
