2025-11-01 20:50:35,184 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 20:50:35,184 - INFO - ya.test - pytest_runtest_setup: test_stop_start[enable_alter_database_create_hive_first--false]
2025-11-01 20:50:35,184 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 20:50:35,184 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-01 20:50:35,259 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/r4xo/00032e/ydb/apps/ydbd/ydbd
2025-11-01 20:50:35,260 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/10513
2025-11-01 20:50:35,261 - INFO - ydb.tests.library.fixtures - ydb_cluster: setup ydb_cluster for __tests__.test_tenants
2025-11-01 20:50:35,261 - INFO - ydb.tests.library.fixtures - ydb_cluster: setup ydb_cluster as local
2025-11-01 20:50:35,262 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/r4xo/00032e/r3tmp/kikimr_cluster_gv02oqpu
2025-11-01 20:50:35,307 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/r4xo/00032e/ydb/apps/ydbd/ydbd
2025-11-01 20:50:35,308 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/20032
2025-11-01 20:50:35,308 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/14742
2025-11-01 20:50:35,309 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/5471
2025-11-01 20:50:35,309 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/19476
2025-11-01 20:50:35,310 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/r4xo/00032e/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_tenants.py.TestTenants.test_stop_start.enable_alter_database_create_hive_first--false/cluster/kikimr_configs"
2025-11-01 20:50:35,310 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/r4xo/00032e/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/r4xo/00032e/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_tenants.py.TestTenants.test_stop_start.enable_alter_database_create_hive_first--false/cluster/node_1/logfile_gror5khe.log --grpc-port=20032 --mon-port=14742 --ic-port=10513
2025-11-01 20:50:35,310 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:20032/1, disk_size 68719476736
2025-11-01 20:50:35,311 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/r4xo/00032e/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_tenants.py.TestTenants.test_stop_start.enable_alter_database_create_hive_first--false/cluster/kikimr_configs"
2025-11-01 20:50:35,311 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/r4xo/00032e/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/r4xo/00032e/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_tenants.py.TestTenants.test_stop_start.enable_alter_database_create_hive_first--false/cluster/node_1/logfile_gror5khe.log --grpc-port=20032 --mon-port=14742 --ic-port=10513
2025-11-01 20:50:35,312 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/r4xo/00032e/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/r4xo/00032e/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_tenants.py.TestTenants.test_stop_start.enable_alter_database_create_hive_first--false/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/r4xo/00032e/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_tenants.py.TestTenants.test_stop_start.enable_alter_database_create_hive_first--false/cluster/node_1/logfile_gror5khe.log', '--grpc-port=20032', '--mon-port=14742', '--ic-port=10513')' in '/home/runner/.ya/build/build_root/r4xo/00032e/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_tenants.py.TestTenants.test_stop_start.enable_alter_database_create_hive_first--false/cluster/node_1' (no wait)
2025-11-01 20:50:35,314 - DEBUG - ya.test - execute: Command pid: 273852
2025-11-01 20:50:35,315 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:20032/1
2025-11-01 20:50:35,316 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-11-01 20:50:35,316 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-11-01 20:50:35,317 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/r4xo/00032e/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 20:50:35,318 - DEBUG - ya.test - execute: Command pid: 273854
2025-11-01 20:50:36,183 - DEBUG - ya.test - _save_outputs: Command (pid 273854) rc: 0
2025-11-01 20:50:36,184 - DEBUG - ya.test - _save_outputs: Command (pid 273854) elapsed time (sec): 0.8651337623596191
2025-11-01 20:50:36,184 - DEBUG - ya.test - _save_outputs: Command (pid 273854) idrss: 0
2025-11-01 20:50:36,184 - DEBUG - ya.test - _save_outputs: Command (pid 273854) inblock: 0
2025-11-01 20:50:36,184 - DEBUG - ya.test - _save_outputs: Command (pid 273854) isrss: 0
2025-11-01 20:50:36,185 - DEBUG - ya.test - _save_outputs: Command (pid 273854) ixrss: 0
2025-11-01 20:50:36,185 - DEBUG - ya.test - _save_outputs: Command (pid 273854) majflt: 0
2025-11-01 20:50:36,185 - DEBUG - ya.test - _save_outputs: Command (pid 273854) maxrss: 538692
2025-11-01 20:50:36,185 - DEBUG - ya.test - _save_outputs: Command (pid 273854) minflt: 16142
2025-11-01 20:50:36,185 - DEBUG - ya.test - _save_outputs: Command (pid 273854) msgrcv: 0
2025-11-01 20:50:36,185 - DEBUG - ya.test - _save_outputs: Command (pid 273854) msgsnd: 0
2025-11-01 20:50:36,186 - DEBUG - ya.test - _save_outputs: Command (pid 273854) nivcsw: 125
2025-11-01 20:50:36,186 - DEBUG - ya.test - _save_outputs: Command (pid 273854) nsignals: 0
2025-11-01 20:50:36,186 - DEBUG - ya.test - _save_outputs: Command (pid 273854) nswap: 0
2025-11-01 20:50:36,186 - DEBUG - ya.test - _save_outputs: Command (pid 273854) nvcsw: 24
2025-11-01 20:50:36,186 - DEBUG - ya.test - _save_outputs: Command (pid 273854) oublock: 8
2025-11-01 20:50:36,186 - DEBUG - ya.test - _save_outputs: Command (pid 273854) stime: 0.498229
2025-11-01 20:50:36,186 - DEBUG - ya.test - _save_outputs: Command (pid 273854) utime: 0.090946
2025-11-01 20:50:36,187 - DEBUG - ya.test - _save_outputs: Command (pid 273854) wtime: 0.866
2025-11-01 20:50:36,187 - DEBUG - ya.test - _save_outputs: Command (pid 273854) output:
Git info:
    Commit: 05d0b84db63541076afbd98f86145cdc7d321216
    Branch: 
    Author: Bulat <bylatgr@gmail.com>
    Summary: Merge 178566593d70f1bd1201a183576bb9dac2870947 into d673dcc87a894a66c7dc98770ee098d1af022f54

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-mjpjznvske
    Host information: 
        Linux ghrun-mjpjznvske 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 20:50:36,187 - DEBUG - ya.test - _save_outputs: Command (pid 273854) errors:

2025-11-01 20:50:36,187 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 05d0b84db63541076afbd98f86145cdc7d321216
    Branch: 
    Author: Bulat <bylatgr@gmail.com>
    Summary: Merge 178566593d70f1bd1201a183576bb9dac2870947 into d673dcc87a894a66c7dc98770ee098d1af022f54
2025-11-01 20:50:38,076 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/r4xo/00032e/ydb/apps/ydbd/ydbd
2025-11-01 20:50:38,077 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/r4xo/00032e/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:20032', '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: 10513\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-01 20:50:38,078 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-11-01 20:50:38,078 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-11-01 20:50:38,078 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/r4xo/00032e/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:20032', '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: 10513\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-01 20:50:38,082 - DEBUG - ya.test - execute: Command pid: 275482
2025-11-01 20:50:38,636 - DEBUG - ya.test - _save_outputs: Command (pid 275482) rc: 0
2025-11-01 20:50:38,636 - DEBUG - ya.test - _save_outputs: Command (pid 275482) elapsed time (sec): 0.5531177520751953
2025-11-01 20:50:38,636 - DEBUG - ya.test - _save_outputs: Command (pid 275482) idrss: 0
2025-11-01 20:50:38,637 - DEBUG - ya.test - _save_outputs: Command (pid 275482) inblock: 0
2025-11-01 20:50:38,637 - DEBUG - ya.test - _save_outputs: Command (pid 275482) isrss: 0
2025-11-01 20:50:38,637 - DEBUG - ya.test - _save_outputs: Command (pid 275482) ixrss: 0
2025-11-01 20:50:38,637 - DEBUG - ya.test - _save_outputs: Command (pid 275482) majflt: 0
2025-11-01 20:50:38,637 - DEBUG - ya.test - _save_outputs: Command (pid 275482) maxrss: 546972
2025-11-01 20:50:38,637 - DEBUG - ya.test - _save_outputs: Command (pid 275482) minflt: 18273
2025-11-01 20:50:38,637 - DEBUG - ya.test - _save_outputs: Command (pid 275482) msgrcv: 0
2025-11-01 20:50:38,637 - DEBUG - ya.test - _save_outputs: Command (pid 275482) msgsnd: 0
2025-11-01 20:50:38,638 - DEBUG - ya.test - _save_outputs: Command (pid 275482) nivcsw: 126
2025-11-01 20:50:38,638 - DEBUG - ya.test - _save_outputs: Command (pid 275482) nsignals: 0
2025-11-01 20:50:38,638 - DEBUG - ya.test - _save_outputs: Command (pid 275482) nswap: 0
2025-11-01 20:50:38,638 - DEBUG - ya.test - _save_outputs: Command (pid 275482) nvcsw: 104
2025-11-01 20:50:38,638 - DEBUG - ya.test - _save_outputs: Command (pid 275482) oublock: 8
2025-11-01 20:50:38,638 - DEBUG - ya.test - _save_outputs: Command (pid 275482) stime: 0.285699
2025-11-01 20:50:38,638 - DEBUG - ya.test - _save_outputs: Command (pid 275482) utime: 0.14587899999999998
2025-11-01 20:50:38,638 - DEBUG - ya.test - _save_outputs: Command (pid 275482) wtime: 0.557
2025-11-01 20:50:38,639 - DEBUG - ya.test - _save_outputs: Command (pid 275482) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 4

2025-11-01 20:50:38,639 - DEBUG - ya.test - _save_outputs: Command (pid 275482) errors:

2025-11-01 20:50:38,644 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/r4xo/00032e/ydb/apps/ydbd/ydbd
2025-11-01 20:50:38,644 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/r4xo/00032e/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:20032', '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 20:50:38,645 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-11-01 20:50:38,646 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-11-01 20:50:38,646 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/r4xo/00032e/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:20032', '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 20:50:38,652 - DEBUG - ya.test - execute: Command pid: 275745
2025-11-01 20:50:39,225 - DEBUG - ya.test - _save_outputs: Command (pid 275745) rc: 0
2025-11-01 20:50:39,226 - DEBUG - ya.test - _save_outputs: Command (pid 275745) elapsed time (sec): 0.5727267265319824
2025-11-01 20:50:39,226 - DEBUG - ya.test - _save_outputs: Command (pid 275745) idrss: 0
2025-11-01 20:50:39,226 - DEBUG - ya.test - _save_outputs: Command (pid 275745) inblock: 0
2025-11-01 20:50:39,226 - DEBUG - ya.test - _save_outputs: Command (pid 275745) isrss: 0
2025-11-01 20:50:39,227 - DEBUG - ya.test - _save_outputs: Command (pid 275745) ixrss: 0
2025-11-01 20:50:39,227 - DEBUG - ya.test - _save_outputs: Command (pid 275745) majflt: 0
2025-11-01 20:50:39,227 - DEBUG - ya.test - _save_outputs: Command (pid 275745) maxrss: 546972
2025-11-01 20:50:39,227 - DEBUG - ya.test - _save_outputs: Command (pid 275745) minflt: 18272
2025-11-01 20:50:39,227 - DEBUG - ya.test - _save_outputs: Command (pid 275745) msgrcv: 0
2025-11-01 20:50:39,227 - DEBUG - ya.test - _save_outputs: Command (pid 275745) msgsnd: 0
2025-11-01 20:50:39,228 - DEBUG - ya.test - _save_outputs: Command (pid 275745) nivcsw: 101
2025-11-01 20:50:39,228 - DEBUG - ya.test - _save_outputs: Command (pid 275745) nsignals: 0
2025-11-01 20:50:39,228 - DEBUG - ya.test - _save_outputs: Command (pid 275745) nswap: 0
2025-11-01 20:50:39,228 - DEBUG - ya.test - _save_outputs: Command (pid 275745) nvcsw: 83
2025-11-01 20:50:39,228 - DEBUG - ya.test - _save_outputs: Command (pid 275745) oublock: 8
2025-11-01 20:50:39,228 - DEBUG - ya.test - _save_outputs: Command (pid 275745) stime: 0.285547
2025-11-01 20:50:39,229 - DEBUG - ya.test - _save_outputs: Command (pid 275745) utime: 0.140065
2025-11-01 20:50:39,229 - DEBUG - ya.test - _save_outputs: Command (pid 275745) wtime: 0.579
2025-11-01 20:50:39,229 - DEBUG - ya.test - _save_outputs: Command (pid 275745) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-01 20:50:39,229 - DEBUG - ya.test - _save_outputs: Command (pid 275745) errors:

2025-11-01 20:50:39,229 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-01 20:50:39,304 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-11-01 20:50:39,321 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_tenants.py::TestTenants, test_name: test_stop_start[enable_alter_database_create_hive_first--false])
2025-11-01 20:50:39,322 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - remove_database: /Root/test_stop_start_enable_alter_database_create_hive_first--false_
2025-11-01 20:50:39,322 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_send_op: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: send console operation, token None
2025-11-01 20:50:39,326 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_send_op: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: response from console: RemoveTenantResponse {
  Response {
    operation {
      ready: true
      status: NOT_FOUND
      issues {
        message: "Database \'/Root/test_stop_start_enable_alter_database_create_hive_first--false_\' doesn\'t exist"
        severity: 1
      }
    }
  }
}
Status {
  Code: NOT_FOUND
  Reason: "Database \'/Root/test_stop_start_enable_alter_database_create_hive_first--false_\' doesn\'t exist"
}

2025-11-01 20:50:39,327 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: wait console operation done
2025-11-01 20:50:39,840 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: console operation done
2025-11-01 20:50:39,840 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: wait tenant gone
2025-11-01 20:50:39,849 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: tenant gone
2025-11-01 20:50:39,849 - DEBUG - ydb.tests.library.fixtures - ydb_database_ctx: create database /Root/test_stop_start_enable_alter_database_create_hive_first--false_: create path and declare internals
2025-11-01 20:50:40,378 - DEBUG - ydb.tests.library.fixtures - ydb_database_ctx: create database /Root/test_stop_start_enable_alter_database_create_hive_first--false_: start nodes and construct internals
2025-11-01 20:50:40,379 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/r4xo/00032e/ydb/apps/ydbd/ydbd
2025-11-01 20:50:40,379 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/62483
2025-11-01 20:50:40,380 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/31160
2025-11-01 20:50:40,380 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/17256
2025-11-01 20:50:40,380 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/18957
2025-11-01 20:50:40,381 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/27775
2025-11-01 20:50:40,381 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/r4xo/00032e/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_tenants.py.TestTenants.test_stop_start.enable_alter_database_create_hive_first--false/cluster/kikimr_configs"
2025-11-01 20:50:40,382 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/r4xo/00032e/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:20032 --tenant=/Root/test_stop_start_enable_alter_database_create_hive_first--false_ --log-file-name=/home/runner/.ya/build/build_root/r4xo/00032e/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_tenants.py.TestTenants.test_stop_start.enable_alter_database_create_hive_first--false/cluster/slot_1/logfile_ql3z4lrs.log --grpc-port=62483 --mon-port=31160 --ic-port=17256
2025-11-01 20:50:40,382 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/r4xo/00032e/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_tenants.py.TestTenants.test_stop_start.enable_alter_database_create_hive_first--false/cluster/kikimr_configs"
2025-11-01 20:50:40,382 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/r4xo/00032e/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:20032 --tenant=/Root/test_stop_start_enable_alter_database_create_hive_first--false_ --log-file-name=/home/runner/.ya/build/build_root/r4xo/00032e/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_tenants.py.TestTenants.test_stop_start.enable_alter_database_create_hive_first--false/cluster/slot_1/logfile_ql3z4lrs.log --grpc-port=62483 --mon-port=31160 --ic-port=17256
2025-11-01 20:50:40,383 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/r4xo/00032e/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/r4xo/00032e/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_tenants.py.TestTenants.test_stop_start.enable_alter_database_create_hive_first--false/cluster/kikimr_configs/config.yaml', '--node-broker=localhost:20032', '--tenant=/Root/test_stop_start_enable_alter_database_create_hive_first--false_', '--log-file-name=/home/runner/.ya/build/build_root/r4xo/00032e/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_tenants.py.TestTenants.test_stop_start.enable_alter_database_create_hive_first--false/cluster/slot_1/logfile_ql3z4lrs.log', '--grpc-port=62483', '--mon-port=31160', '--ic-port=17256')' in '/home/runner/.ya/build/build_root/r4xo/00032e/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_tenants.py.TestTenants.test_stop_start.enable_alter_database_create_hive_first--false/cluster/slot_1' (no wait)
2025-11-01 20:50:40,390 - DEBUG - ya.test - execute: Command pid: 276929
2025-11-01 20:50:40,391 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:62483/1
2025-11-01 20:50:40,392 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-11-01 20:50:40,392 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-11-01 20:50:40,393 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/r4xo/00032e/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 20:50:40,400 - DEBUG - ya.test - execute: Command pid: 276930
2025-11-01 20:50:40,914 - DEBUG - ya.test - _save_outputs: Command (pid 276930) rc: 0
2025-11-01 20:50:40,914 - DEBUG - ya.test - _save_outputs: Command (pid 276930) elapsed time (sec): 0.513355016708374
2025-11-01 20:50:40,914 - DEBUG - ya.test - _save_outputs: Command (pid 276930) idrss: 0
2025-11-01 20:50:40,915 - DEBUG - ya.test - _save_outputs: Command (pid 276930) inblock: 0
2025-11-01 20:50:40,915 - DEBUG - ya.test - _save_outputs: Command (pid 276930) isrss: 0
2025-11-01 20:50:40,915 - DEBUG - ya.test - _save_outputs: Command (pid 276930) ixrss: 0
2025-11-01 20:50:40,915 - DEBUG - ya.test - _save_outputs: Command (pid 276930) majflt: 0
2025-11-01 20:50:40,915 - DEBUG - ya.test - _save_outputs: Command (pid 276930) maxrss: 538696
2025-11-01 20:50:40,915 - DEBUG - ya.test - _save_outputs: Command (pid 276930) minflt: 16141
2025-11-01 20:50:40,916 - DEBUG - ya.test - _save_outputs: Command (pid 276930) msgrcv: 0
2025-11-01 20:50:40,916 - DEBUG - ya.test - _save_outputs: Command (pid 276930) msgsnd: 0
2025-11-01 20:50:40,916 - DEBUG - ya.test - _save_outputs: Command (pid 276930) nivcsw: 57
2025-11-01 20:50:40,916 - DEBUG - ya.test - _save_outputs: Command (pid 276930) nsignals: 0
2025-11-01 20:50:40,916 - DEBUG - ya.test - _save_outputs: Command (pid 276930) nswap: 0
2025-11-01 20:50:40,916 - DEBUG - ya.test - _save_outputs: Command (pid 276930) nvcsw: 12
2025-11-01 20:50:40,917 - DEBUG - ya.test - _save_outputs: Command (pid 276930) oublock: 8
2025-11-01 20:50:40,917 - DEBUG - ya.test - _save_outputs: Command (pid 276930) stime: 0.259304
2025-11-01 20:50:40,917 - DEBUG - ya.test - _save_outputs: Command (pid 276930) utime: 0.113299
2025-11-01 20:50:40,917 - DEBUG - ya.test - _save_outputs: Command (pid 276930) wtime: 0.521
2025-11-01 20:50:40,917 - DEBUG - ya.test - _save_outputs: Command (pid 276930) output:
Git info:
    Commit: 05d0b84db63541076afbd98f86145cdc7d321216
    Branch: 
    Author: Bulat <bylatgr@gmail.com>
    Summary: Merge 178566593d70f1bd1201a183576bb9dac2870947 into d673dcc87a894a66c7dc98770ee098d1af022f54

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-mjpjznvske
    Host information: 
        Linux ghrun-mjpjznvske 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 20:50:40,917 - DEBUG - ya.test - _save_outputs: Command (pid 276930) errors:

2025-11-01 20:50:40,918 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 05d0b84db63541076afbd98f86145cdc7d321216
    Branch: 
    Author: Bulat <bylatgr@gmail.com>
    Summary: Merge 178566593d70f1bd1201a183576bb9dac2870947 into d673dcc87a894a66c7dc98770ee098d1af022f54
2025-11-01 20:50:40,918 - DEBUG - ydb.tests.library.fixtures - ydb_database_ctx: create database /Root/test_stop_start_enable_alter_database_create_hive_first--false_: wait construction done
2025-11-01 20:50:42,940 - DEBUG - ydb.tests.library.fixtures - ydb_database_ctx: create database /Root/test_stop_start_enable_alter_database_create_hive_first--false_: database up
2025-11-01 20:50:42,941 - 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 20:50:42,943 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:50:42,944 - 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 20:50:42,961 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/test_stop_start_enable_alter_database_create_hive_first--false_
2025-11-01 20:50:42,962 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, d8dc98bd-9275-455e-ad0d-dd823b61681d, localhost:20032): creating call state
2025-11-01 20:50:42,963 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, d8dc98bd-9275-455e-ad0d-dd823b61681d, localhost:20032): request = { database: "/Root/test_stop_start_enable_alter_database_create_hive_first--false_" }
2025-11-01 20:50:42,964 - DEBUG - ydb.table.SessionPool - subscribe: Active session queue is empty, subscribe waiter for a session
2025-11-01 20:50:42,965 - DEBUG - ydb.table.SessionPool - subscribe: Subscribe waiter <Future at 0x7f567c742540 state=pending>
2025-11-01 20:50:42,965 - DEBUG - ydb.table.SessionPool - subscribe: Session pool is not large enough (active_count < size: 0 < 100). will create a new session.
2025-11-01 20:50:42,965 - DEBUG - ydb.table.SessionPool - _create: Created session <ydb.table.Session object at 0x7f567c7402e0>
2025-11-01 20:50:42,966 - DEBUG - ydb.table.SessionPool - _prepare: Preparing session <ydb.table.Session object at 0x7f567c7402e0>
2025-11-01 20:50:42,966 - 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 20:50:42,969 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, d8dc98bd-9275-455e-ad0d-dd823b61681d, localhost:20032): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-mjpjznvske.auto.internal" port: 62483 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 20:50:42,969 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root/test_stop_start_enable_alter_database_create_hive_first--false_: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-mjpjznvske.auto.internal:62483, location , ssl: False>]>
2025-11-01 20:50:42,970 - 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 20:50:42,995 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:20032
2025-11-01 20:50:42,995 - DEBUG - ydb.table.SessionPool - _prepare: Preparing session <ydb.table.Session object at 0x7f567c7402e0>
2025-11-01 20:50:42,996 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, e84ac5b4-1c94-4a09-b9cf-7be9bd537f8f, ghrun-mjpjznvske.auto.internal:62483): creating call state
2025-11-01 20:50:42,996 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, e84ac5b4-1c94-4a09-b9cf-7be9bd537f8f, ghrun-mjpjznvske.auto.internal:62483): request = { operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-11-01 20:50:43,009 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, e84ac5b4-1c94-4a09-b9cf-7be9bd537f8f, ghrun-mjpjznvske.auto.internal:62483): on response callback started
2025-11-01 20:50:43,010 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, e84ac5b4-1c94-4a09-b9cf-7be9bd537f8f, ghrun-mjpjznvske.auto.internal:62483): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=50000&id=Zjg1MTFiZWItOGQxN2Y3N2UtZDZiNTM2OTEtNzQ2ZTI0NGY=" } } } }
2025-11-01 20:50:43,010 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f567c7402e0>
2025-11-01 20:50:43,010 - DEBUG - ydb.table.SessionPool - put: Replying to waiter with a session <ydb.table.Session object at 0x7f567c7402e0>
2025-11-01 20:50:43,010 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, e84ac5b4-1c94-4a09-b9cf-7be9bd537f8f, ghrun-mjpjznvske.auto.internal:62483): on response callback success
2025-11-01 20:50:43,012 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, 9e3d753b-8d75-4195-bc00-841e0e51bbc3, ghrun-mjpjznvske.auto.internal:62483): creating call state
2025-11-01 20:50:43,012 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, 9e3d753b-8d75-4195-bc00-841e0e51bbc3, ghrun-mjpjznvske.auto.internal:62483): request = { session_id: "ydb://session/3?node_id=50000&id=Zjg1MTFiZWItOGQxN2Y3N2UtZDZiNTM2OTEtNzQ2ZTI0NGY=" yql_text: "\n                CREATE TABLE `table_0` (id utf8, PRIMARY KEY (id));\n            " operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 20:50:43,229 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, 9e3d753b-8d75-4195-bc00-841e0e51bbc3, ghrun-mjpjznvske.auto.internal:62483): response = { operation { ready: true status: SUCCESS } }
2025-11-01 20:50:43,230 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f567c7402e0>
2025-11-01 20:50:43,230 - DEBUG - ydb.tests.library.fixtures - ydb_database_ctx: destroy database /Root/test_stop_start_enable_alter_database_create_hive_first--false_: remove path and dismantle internals
2025-11-01 20:50:43,230 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - remove_database: /Root/test_stop_start_enable_alter_database_create_hive_first--false_
2025-11-01 20:50:43,230 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_send_op: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: send console operation, token None
2025-11-01 20:50:43,237 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_send_op: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: response from console: RemoveTenantResponse {
  Response {
    operation {
      id: "ydb://cmsrequest/5?tenant=/Root/test_stop_start_enable_alter_database_create_hive_first--false_&cmstid=72057594037936131&txid=1762030243233301&action=2"
    }
  }
}
Status {
  Code: STATUS_CODE_UNSPECIFIED
}

2025-11-01 20:50:43,237 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: wait console operation done
2025-11-01 20:50:43,741 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: console operation done
2025-11-01 20:50:43,742 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: wait tenant gone
2025-11-01 20:50:43,748 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: tenant gone
2025-11-01 20:50:43,749 - DEBUG - ydb.tests.library.fixtures - ydb_database_ctx: destroy database /Root/test_stop_start_enable_alter_database_create_hive_first--false_: stop nodes
2025-11-01 20:50:55,760 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:62483/1
2025-11-01 20:50:55,764 - DEBUG - ydb.tests.library.fixtures - ydb_database_ctx: destroy database /Root/test_stop_start_enable_alter_database_create_hive_first--false_: database down
2025-11-01 20:50:55,764 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - remove_database: /Root/test_stop_start_enable_alter_database_create_hive_first--false_
2025-11-01 20:50:55,765 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_send_op: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: send console operation, token None
2025-11-01 20:50:55,778 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_send_op: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: response from console: RemoveTenantResponse {
  Response {
    operation {
      ready: true
      status: NOT_FOUND
      issues {
        message: "Database \'/Root/test_stop_start_enable_alter_database_create_hive_first--false_\' doesn\'t exist"
        severity: 1
      }
    }
  }
}
Status {
  Code: NOT_FOUND
  Reason: "Database \'/Root/test_stop_start_enable_alter_database_create_hive_first--false_\' doesn\'t exist"
}

2025-11-01 20:50:55,781 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: wait console operation done
2025-11-01 20:50:56,290 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: console operation done
2025-11-01 20:50:56,290 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: wait tenant gone
2025-11-01 20:50:56,300 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: tenant gone
2025-11-01 20:50:56,300 - DEBUG - ydb.tests.library.fixtures - ydb_database_ctx: create database /Root/test_stop_start_enable_alter_database_create_hive_first--false_: create path and declare internals
2025-11-01 20:50:56,815 - DEBUG - ydb.tests.library.fixtures - ydb_database_ctx: create database /Root/test_stop_start_enable_alter_database_create_hive_first--false_: start nodes and construct internals
2025-11-01 20:50:56,816 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/r4xo/00032e/ydb/apps/ydbd/ydbd
2025-11-01 20:50:56,816 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/31349
2025-11-01 20:50:56,817 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/7890
2025-11-01 20:50:56,817 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/12183
2025-11-01 20:50:56,817 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/26047
2025-11-01 20:50:56,818 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/23330
2025-11-01 20:50:56,818 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/r4xo/00032e/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_tenants.py.TestTenants.test_stop_start.enable_alter_database_create_hive_first--false/cluster/kikimr_configs"
2025-11-01 20:50:56,819 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/r4xo/00032e/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:20032 --tenant=/Root/test_stop_start_enable_alter_database_create_hive_first--false_ --log-file-name=/home/runner/.ya/build/build_root/r4xo/00032e/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_tenants.py.TestTenants.test_stop_start.enable_alter_database_create_hive_first--false/cluster/slot_2/logfile_wmejp2jj.log --grpc-port=31349 --mon-port=7890 --ic-port=12183
2025-11-01 20:50:56,819 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/r4xo/00032e/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_tenants.py.TestTenants.test_stop_start.enable_alter_database_create_hive_first--false/cluster/kikimr_configs"
2025-11-01 20:50:56,819 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/r4xo/00032e/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:20032 --tenant=/Root/test_stop_start_enable_alter_database_create_hive_first--false_ --log-file-name=/home/runner/.ya/build/build_root/r4xo/00032e/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_tenants.py.TestTenants.test_stop_start.enable_alter_database_create_hive_first--false/cluster/slot_2/logfile_wmejp2jj.log --grpc-port=31349 --mon-port=7890 --ic-port=12183
2025-11-01 20:50:56,820 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/r4xo/00032e/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/r4xo/00032e/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_tenants.py.TestTenants.test_stop_start.enable_alter_database_create_hive_first--false/cluster/kikimr_configs/config.yaml', '--node-broker=localhost:20032', '--tenant=/Root/test_stop_start_enable_alter_database_create_hive_first--false_', '--log-file-name=/home/runner/.ya/build/build_root/r4xo/00032e/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_tenants.py.TestTenants.test_stop_start.enable_alter_database_create_hive_first--false/cluster/slot_2/logfile_wmejp2jj.log', '--grpc-port=31349', '--mon-port=7890', '--ic-port=12183')' in '/home/runner/.ya/build/build_root/r4xo/00032e/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_tenants.py.TestTenants.test_stop_start.enable_alter_database_create_hive_first--false/cluster/slot_2' (no wait)
2025-11-01 20:50:56,822 - DEBUG - ya.test - execute: Command pid: 291150
2025-11-01 20:50:56,823 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:31349/2
2025-11-01 20:50:56,824 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.3
2025-11-01 20:50:56,825 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.3
2025-11-01 20:50:56,825 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/r4xo/00032e/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 20:50:56,826 - DEBUG - ya.test - execute: Command pid: 291151
2025-11-01 20:50:57,264 - DEBUG - ya.test - _save_outputs: Command (pid 291151) rc: 0
2025-11-01 20:50:57,264 - DEBUG - ya.test - _save_outputs: Command (pid 291151) elapsed time (sec): 0.4373891353607178
2025-11-01 20:50:57,265 - DEBUG - ya.test - _save_outputs: Command (pid 291151) idrss: 0
2025-11-01 20:50:57,265 - DEBUG - ya.test - _save_outputs: Command (pid 291151) inblock: 0
2025-11-01 20:50:57,265 - DEBUG - ya.test - _save_outputs: Command (pid 291151) isrss: 0
2025-11-01 20:50:57,265 - DEBUG - ya.test - _save_outputs: Command (pid 291151) ixrss: 0
2025-11-01 20:50:57,265 - DEBUG - ya.test - _save_outputs: Command (pid 291151) majflt: 0
2025-11-01 20:50:57,265 - DEBUG - ya.test - _save_outputs: Command (pid 291151) maxrss: 538576
2025-11-01 20:50:57,265 - DEBUG - ya.test - _save_outputs: Command (pid 291151) minflt: 18459
2025-11-01 20:50:57,266 - DEBUG - ya.test - _save_outputs: Command (pid 291151) msgrcv: 0
2025-11-01 20:50:57,266 - DEBUG - ya.test - _save_outputs: Command (pid 291151) msgsnd: 0
2025-11-01 20:50:57,266 - DEBUG - ya.test - _save_outputs: Command (pid 291151) nivcsw: 49
2025-11-01 20:50:57,266 - DEBUG - ya.test - _save_outputs: Command (pid 291151) nsignals: 0
2025-11-01 20:50:57,266 - DEBUG - ya.test - _save_outputs: Command (pid 291151) nswap: 0
2025-11-01 20:50:57,266 - DEBUG - ya.test - _save_outputs: Command (pid 291151) nvcsw: 17
2025-11-01 20:50:57,267 - DEBUG - ya.test - _save_outputs: Command (pid 291151) oublock: 8
2025-11-01 20:50:57,267 - DEBUG - ya.test - _save_outputs: Command (pid 291151) stime: 0.27957299999999996
2025-11-01 20:50:57,267 - DEBUG - ya.test - _save_outputs: Command (pid 291151) utime: 0.107835
2025-11-01 20:50:57,267 - DEBUG - ya.test - _save_outputs: Command (pid 291151) wtime: 0.438
2025-11-01 20:50:57,272 - DEBUG - ya.test - _save_outputs: Command (pid 291151) output:
Git info:
    Commit: 05d0b84db63541076afbd98f86145cdc7d321216
    Branch: 
    Author: Bulat <bylatgr@gmail.com>
    Summary: Merge 178566593d70f1bd1201a183576bb9dac2870947 into d673dcc87a894a66c7dc98770ee098d1af022f54

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-mjpjznvske
    Host information: 
        Linux ghrun-mjpjznvske 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 20:50:57,272 - DEBUG - ya.test - _save_outputs: Command (pid 291151) errors:

2025-11-01 20:50:57,272 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 2 version:
Git info:
    Commit: 05d0b84db63541076afbd98f86145cdc7d321216
    Branch: 
    Author: Bulat <bylatgr@gmail.com>
    Summary: Merge 178566593d70f1bd1201a183576bb9dac2870947 into d673dcc87a894a66c7dc98770ee098d1af022f54
2025-11-01 20:50:57,273 - DEBUG - ydb.tests.library.fixtures - ydb_database_ctx: create database /Root/test_stop_start_enable_alter_database_create_hive_first--false_: wait construction done
2025-11-01 20:51:03,285 - DEBUG - ydb.tests.library.fixtures - ydb_database_ctx: create database /Root/test_stop_start_enable_alter_database_create_hive_first--false_: database up
2025-11-01 20:51:03,285 - 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 20:51:03,287 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:51:03,288 - 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 20:51:03,291 - DEBUG - ydb.table.SessionPool - subscribe: Active session queue is empty, subscribe waiter for a session
2025-11-01 20:51:03,292 - DEBUG - ydb.table.SessionPool - subscribe: Subscribe waiter <Future at 0x7f567c74d910 state=pending>
2025-11-01 20:51:03,293 - DEBUG - ydb.table.SessionPool - subscribe: Session pool is not large enough (active_count < size: 0 < 100). will create a new session.
2025-11-01 20:51:03,294 - DEBUG - ydb.table.SessionPool - _create: Created session <ydb.table.Session object at 0x7f567c74d6e0>
2025-11-01 20:51:03,294 - DEBUG - ydb.table.SessionPool - _prepare: Preparing session <ydb.table.Session object at 0x7f567c74d6e0>
2025-11-01 20:51:03,295 - 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 20:51:03,296 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/test_stop_start_enable_alter_database_create_hive_first--false_
2025-11-01 20:51:03,296 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, d47de5b8-5460-453c-a432-ae4bb686b4ea, localhost:20032): creating call state
2025-11-01 20:51:03,296 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, d47de5b8-5460-453c-a432-ae4bb686b4ea, localhost:20032): request = { database: "/Root/test_stop_start_enable_alter_database_create_hive_first--false_" }
2025-11-01 20:51:03,298 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, d47de5b8-5460-453c-a432-ae4bb686b4ea, localhost:20032): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-mjpjznvske.auto.internal" port: 31349 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 20:51:03,298 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root/test_stop_start_enable_alter_database_create_hive_first--false_: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-mjpjznvske.auto.internal:31349, location , ssl: False>]>
2025-11-01 20:51:03,299 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 20:51:03,305 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:20032
2025-11-01 20:51:03,305 - DEBUG - ydb.table.SessionPool - _prepare: Preparing session <ydb.table.Session object at 0x7f567c74d6e0>
2025-11-01 20:51:03,308 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, d9d58831-4eda-4605-a4e5-4a68e9713345, ghrun-mjpjznvske.auto.internal:31349): creating call state
2025-11-01 20:51:03,308 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, d9d58831-4eda-4605-a4e5-4a68e9713345, ghrun-mjpjznvske.auto.internal:31349): request = { operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-11-01 20:51:03,311 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, d9d58831-4eda-4605-a4e5-4a68e9713345, ghrun-mjpjznvske.auto.internal:31349): on response callback started
2025-11-01 20:51:03,311 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, d9d58831-4eda-4605-a4e5-4a68e9713345, ghrun-mjpjznvske.auto.internal:31349): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=50001&id=NzhhNDgzZGMtZTY4NWZjMzItYzZjNDk2OWYtMjk0NmYxODQ=" } } } }
2025-11-01 20:51:03,312 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f567c74d6e0>
2025-11-01 20:51:03,312 - DEBUG - ydb.table.SessionPool - put: Replying to waiter with a session <ydb.table.Session object at 0x7f567c74d6e0>
2025-11-01 20:51:03,313 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, cd1f9b9b-8136-4f90-8189-cf67a547a114, ghrun-mjpjznvske.auto.internal:31349): creating call state
2025-11-01 20:51:03,313 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, d9d58831-4eda-4605-a4e5-4a68e9713345, ghrun-mjpjznvske.auto.internal:31349): on response callback success
2025-11-01 20:51:03,314 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, cd1f9b9b-8136-4f90-8189-cf67a547a114, ghrun-mjpjznvske.auto.internal:31349): request = { session_id: "ydb://session/3?node_id=50001&id=NzhhNDgzZGMtZTY4NWZjMzItYzZjNDk2OWYtMjk0NmYxODQ=" yql_text: "\n                CREATE TABLE `table_1` (id utf8, PRIMARY KEY (id));\n            " operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 20:51:03,356 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, cd1f9b9b-8136-4f90-8189-cf67a547a114, ghrun-mjpjznvske.auto.internal:31349): response = { operation { ready: true status: SUCCESS } }
2025-11-01 20:51:03,358 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f567c74d6e0>
2025-11-01 20:51:03,359 - DEBUG - ydb.tests.library.fixtures - ydb_database_ctx: destroy database /Root/test_stop_start_enable_alter_database_create_hive_first--false_: remove path and dismantle internals
2025-11-01 20:51:03,359 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - remove_database: /Root/test_stop_start_enable_alter_database_create_hive_first--false_
2025-11-01 20:51:03,359 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_send_op: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: send console operation, token None
2025-11-01 20:51:03,364 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_send_op: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: response from console: RemoveTenantResponse {
  Response {
    operation {
      id: "ydb://cmsrequest/5?tenant=/Root/test_stop_start_enable_alter_database_create_hive_first--false_&cmstid=72057594037936131&txid=1762030263362096&action=2"
    }
  }
}
Status {
  Code: STATUS_CODE_UNSPECIFIED
}

2025-11-01 20:51:03,364 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: wait console operation done
2025-11-01 20:51:03,868 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: console operation done
2025-11-01 20:51:03,868 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: wait tenant gone
2025-11-01 20:51:03,871 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: tenant gone
2025-11-01 20:51:03,871 - DEBUG - ydb.tests.library.fixtures - ydb_database_ctx: destroy database /Root/test_stop_start_enable_alter_database_create_hive_first--false_: stop nodes
2025-11-01 20:51:25,873 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:31349/2
2025-11-01 20:51:25,873 - DEBUG - ydb.tests.library.fixtures - ydb_database_ctx: destroy database /Root/test_stop_start_enable_alter_database_create_hive_first--false_: database down
2025-11-01 20:51:25,873 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - remove_database: /Root/test_stop_start_enable_alter_database_create_hive_first--false_
2025-11-01 20:51:25,873 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_send_op: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: send console operation, token None
2025-11-01 20:51:25,878 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_send_op: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: response from console: RemoveTenantResponse {
  Response {
    operation {
      ready: true
      status: NOT_FOUND
      issues {
        message: "Database \'/Root/test_stop_start_enable_alter_database_create_hive_first--false_\' doesn\'t exist"
        severity: 1
      }
    }
  }
}
Status {
  Code: NOT_FOUND
  Reason: "Database \'/Root/test_stop_start_enable_alter_database_create_hive_first--false_\' doesn\'t exist"
}

2025-11-01 20:51:25,878 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: wait console operation done
2025-11-01 20:51:26,382 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: console operation done
2025-11-01 20:51:26,382 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: wait tenant gone
2025-11-01 20:51:26,385 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: tenant gone
2025-11-01 20:51:26,385 - DEBUG - ydb.tests.library.fixtures - ydb_database_ctx: create database /Root/test_stop_start_enable_alter_database_create_hive_first--false_: create path and declare internals
2025-11-01 20:51:26,895 - DEBUG - ydb.tests.library.fixtures - ydb_database_ctx: create database /Root/test_stop_start_enable_alter_database_create_hive_first--false_: start nodes and construct internals
2025-11-01 20:51:26,896 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/r4xo/00032e/ydb/apps/ydbd/ydbd
2025-11-01 20:51:26,896 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/19726
2025-11-01 20:51:26,897 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/16708
2025-11-01 20:51:26,897 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/18672
2025-11-01 20:51:26,897 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/20825
2025-11-01 20:51:26,897 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/15899
2025-11-01 20:51:26,898 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/r4xo/00032e/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_tenants.py.TestTenants.test_stop_start.enable_alter_database_create_hive_first--false/cluster/kikimr_configs"
2025-11-01 20:51:26,898 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/r4xo/00032e/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:20032 --tenant=/Root/test_stop_start_enable_alter_database_create_hive_first--false_ --log-file-name=/home/runner/.ya/build/build_root/r4xo/00032e/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_tenants.py.TestTenants.test_stop_start.enable_alter_database_create_hive_first--false/cluster/slot_3/logfile_s8bio38v.log --grpc-port=19726 --mon-port=16708 --ic-port=18672
2025-11-01 20:51:26,898 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/r4xo/00032e/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_tenants.py.TestTenants.test_stop_start.enable_alter_database_create_hive_first--false/cluster/kikimr_configs"
2025-11-01 20:51:26,899 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/r4xo/00032e/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:20032 --tenant=/Root/test_stop_start_enable_alter_database_create_hive_first--false_ --log-file-name=/home/runner/.ya/build/build_root/r4xo/00032e/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_tenants.py.TestTenants.test_stop_start.enable_alter_database_create_hive_first--false/cluster/slot_3/logfile_s8bio38v.log --grpc-port=19726 --mon-port=16708 --ic-port=18672
2025-11-01 20:51:26,899 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/r4xo/00032e/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/r4xo/00032e/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_tenants.py.TestTenants.test_stop_start.enable_alter_database_create_hive_first--false/cluster/kikimr_configs/config.yaml', '--node-broker=localhost:20032', '--tenant=/Root/test_stop_start_enable_alter_database_create_hive_first--false_', '--log-file-name=/home/runner/.ya/build/build_root/r4xo/00032e/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_tenants.py.TestTenants.test_stop_start.enable_alter_database_create_hive_first--false/cluster/slot_3/logfile_s8bio38v.log', '--grpc-port=19726', '--mon-port=16708', '--ic-port=18672')' in '/home/runner/.ya/build/build_root/r4xo/00032e/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/test_tenants.py.TestTenants.test_stop_start.enable_alter_database_create_hive_first--false/cluster/slot_3' (no wait)
2025-11-01 20:51:26,901 - DEBUG - ya.test - execute: Command pid: 299345
2025-11-01 20:51:26,901 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:19726/3
2025-11-01 20:51:26,902 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.4
2025-11-01 20:51:26,902 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.4
2025-11-01 20:51:26,902 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/r4xo/00032e/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 20:51:26,903 - DEBUG - ya.test - execute: Command pid: 299347
2025-11-01 20:51:27,227 - DEBUG - ya.test - _save_outputs: Command (pid 299347) rc: 0
2025-11-01 20:51:27,228 - DEBUG - ya.test - _save_outputs: Command (pid 299347) elapsed time (sec): 0.3207879066467285
2025-11-01 20:51:27,228 - DEBUG - ya.test - _save_outputs: Command (pid 299347) idrss: 0
2025-11-01 20:51:27,228 - DEBUG - ya.test - _save_outputs: Command (pid 299347) inblock: 0
2025-11-01 20:51:27,228 - DEBUG - ya.test - _save_outputs: Command (pid 299347) isrss: 0
2025-11-01 20:51:27,228 - DEBUG - ya.test - _save_outputs: Command (pid 299347) ixrss: 0
2025-11-01 20:51:27,229 - DEBUG - ya.test - _save_outputs: Command (pid 299347) majflt: 2
2025-11-01 20:51:27,229 - DEBUG - ya.test - _save_outputs: Command (pid 299347) maxrss: 538604
2025-11-01 20:51:27,229 - DEBUG - ya.test - _save_outputs: Command (pid 299347) minflt: 19223
2025-11-01 20:51:27,229 - DEBUG - ya.test - _save_outputs: Command (pid 299347) msgrcv: 0
2025-11-01 20:51:27,229 - DEBUG - ya.test - _save_outputs: Command (pid 299347) msgsnd: 0
2025-11-01 20:51:27,229 - DEBUG - ya.test - _save_outputs: Command (pid 299347) nivcsw: 2
2025-11-01 20:51:27,229 - DEBUG - ya.test - _save_outputs: Command (pid 299347) nsignals: 0
2025-11-01 20:51:27,230 - DEBUG - ya.test - _save_outputs: Command (pid 299347) nswap: 0
2025-11-01 20:51:27,230 - DEBUG - ya.test - _save_outputs: Command (pid 299347) nvcsw: 22
2025-11-01 20:51:27,230 - DEBUG - ya.test - _save_outputs: Command (pid 299347) oublock: 8
2025-11-01 20:51:27,230 - DEBUG - ya.test - _save_outputs: Command (pid 299347) stime: 0.189819
2025-11-01 20:51:27,230 - DEBUG - ya.test - _save_outputs: Command (pid 299347) utime: 0.083046
2025-11-01 20:51:27,230 - DEBUG - ya.test - _save_outputs: Command (pid 299347) wtime: 0.322
2025-11-01 20:51:27,231 - DEBUG - ya.test - _save_outputs: Command (pid 299347) output:
Git info:
    Commit: 05d0b84db63541076afbd98f86145cdc7d321216
    Branch: 
    Author: Bulat <bylatgr@gmail.com>
    Summary: Merge 178566593d70f1bd1201a183576bb9dac2870947 into d673dcc87a894a66c7dc98770ee098d1af022f54

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-mjpjznvske
    Host information: 
        Linux ghrun-mjpjznvske 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 20:51:27,231 - DEBUG - ya.test - _save_outputs: Command (pid 299347) errors:

2025-11-01 20:51:27,231 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 3 version:
Git info:
    Commit: 05d0b84db63541076afbd98f86145cdc7d321216
    Branch: 
    Author: Bulat <bylatgr@gmail.com>
    Summary: Merge 178566593d70f1bd1201a183576bb9dac2870947 into d673dcc87a894a66c7dc98770ee098d1af022f54
2025-11-01 20:51:27,231 - DEBUG - ydb.tests.library.fixtures - ydb_database_ctx: create database /Root/test_stop_start_enable_alter_database_create_hive_first--false_: wait construction done
2025-11-01 20:51:29,238 - DEBUG - ydb.tests.library.fixtures - ydb_database_ctx: create database /Root/test_stop_start_enable_alter_database_create_hive_first--false_: database up
2025-11-01 20:51:29,238 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 20:51:29,240 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:51:29,241 - DEBUG - ydb.table.SessionPool - subscribe: Active session queue is empty, subscribe waiter for a session
2025-11-01 20:51:29,241 - 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 20:51:29,242 - DEBUG - ydb.table.SessionPool - subscribe: Subscribe waiter <Future at 0x7f567c711550 state=pending>
2025-11-01 20:51:29,244 - DEBUG - ydb.table.SessionPool - subscribe: Session pool is not large enough (active_count < size: 0 < 100). will create a new session.
2025-11-01 20:51:29,244 - DEBUG - ydb.table.SessionPool - _create: Created session <ydb.table.Session object at 0x7f567c70ef90>
2025-11-01 20:51:29,245 - DEBUG - ydb.table.SessionPool - _prepare: Preparing session <ydb.table.Session object at 0x7f567c70ef90>
2025-11-01 20:51:29,245 - 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 20:51:29,247 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/test_stop_start_enable_alter_database_create_hive_first--false_
2025-11-01 20:51:29,247 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, cd1ac70d-574c-49a2-86cc-1b71a82cb6c7, localhost:20032): creating call state
2025-11-01 20:51:29,247 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, cd1ac70d-574c-49a2-86cc-1b71a82cb6c7, localhost:20032): request = { database: "/Root/test_stop_start_enable_alter_database_create_hive_first--false_" }
2025-11-01 20:51:29,250 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, cd1ac70d-574c-49a2-86cc-1b71a82cb6c7, localhost:20032): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-mjpjznvske.auto.internal" port: 19726 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 20:51:29,250 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root/test_stop_start_enable_alter_database_create_hive_first--false_: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-mjpjznvske.auto.internal:19726, location , ssl: False>]>
2025-11-01 20:51:29,251 - 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 20:51:29,257 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:20032
2025-11-01 20:51:29,257 - DEBUG - ydb.table.SessionPool - _prepare: Preparing session <ydb.table.Session object at 0x7f567c70ef90>
2025-11-01 20:51:29,258 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 7fa8b97f-1818-4c5d-8f47-41047680c47e, ghrun-mjpjznvske.auto.internal:19726): creating call state
2025-11-01 20:51:29,258 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 7fa8b97f-1818-4c5d-8f47-41047680c47e, ghrun-mjpjznvske.auto.internal:19726): request = { operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-11-01 20:51:29,260 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, 7fa8b97f-1818-4c5d-8f47-41047680c47e, ghrun-mjpjznvske.auto.internal:19726): on response callback started
2025-11-01 20:51:29,261 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 7fa8b97f-1818-4c5d-8f47-41047680c47e, ghrun-mjpjznvske.auto.internal:19726): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=50002&id=ODNiODMyYzEtZjVkOGZkN2QtNDAwM2MxOWItZGU0Mzg2NTk=" } } } }
2025-11-01 20:51:29,261 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f567c70ef90>
2025-11-01 20:51:29,261 - DEBUG - ydb.table.SessionPool - put: Replying to waiter with a session <ydb.table.Session object at 0x7f567c70ef90>
2025-11-01 20:51:29,262 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, 7fa8b97f-1818-4c5d-8f47-41047680c47e, ghrun-mjpjznvske.auto.internal:19726): on response callback success
2025-11-01 20:51:29,262 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, 7ea044c4-99a7-4353-b2db-d0e31604078f, ghrun-mjpjznvske.auto.internal:19726): creating call state
2025-11-01 20:51:29,263 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, 7ea044c4-99a7-4353-b2db-d0e31604078f, ghrun-mjpjznvske.auto.internal:19726): request = { session_id: "ydb://session/3?node_id=50002&id=ODNiODMyYzEtZjVkOGZkN2QtNDAwM2MxOWItZGU0Mzg2NTk=" yql_text: "\n                CREATE TABLE `table_2` (id utf8, PRIMARY KEY (id));\n            " operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 20:51:29,300 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, 7ea044c4-99a7-4353-b2db-d0e31604078f, ghrun-mjpjznvske.auto.internal:19726): response = { operation { ready: true status: SUCCESS } }
2025-11-01 20:51:29,301 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f567c70ef90>
2025-11-01 20:51:29,301 - DEBUG - ydb.tests.library.fixtures - ydb_database_ctx: destroy database /Root/test_stop_start_enable_alter_database_create_hive_first--false_: remove path and dismantle internals
2025-11-01 20:51:29,301 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - remove_database: /Root/test_stop_start_enable_alter_database_create_hive_first--false_
2025-11-01 20:51:29,301 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_send_op: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: send console operation, token None
2025-11-01 20:51:29,305 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_send_op: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: response from console: RemoveTenantResponse {
  Response {
    operation {
      id: "ydb://cmsrequest/5?tenant=/Root/test_stop_start_enable_alter_database_create_hive_first--false_&cmstid=72057594037936131&txid=1762030289303353&action=2"
    }
  }
}
Status {
  Code: STATUS_CODE_UNSPECIFIED
}

2025-11-01 20:51:29,305 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: wait console operation done
2025-11-01 20:51:29,808 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: console operation done
2025-11-01 20:51:29,808 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: wait tenant gone
2025-11-01 20:51:29,810 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: tenant gone
2025-11-01 20:51:29,810 - DEBUG - ydb.tests.library.fixtures - ydb_database_ctx: destroy database /Root/test_stop_start_enable_alter_database_create_hive_first--false_: stop nodes
2025-11-01 20:51:56,812 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:19726/3
2025-11-01 20:51:56,812 - DEBUG - ydb.tests.library.fixtures - ydb_database_ctx: destroy database /Root/test_stop_start_enable_alter_database_create_hive_first--false_: database down
2025-11-01 20:51:56,812 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - remove_database: /Root/test_stop_start_enable_alter_database_create_hive_first--false_
2025-11-01 20:51:56,813 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_send_op: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: send console operation, token None
2025-11-01 20:51:56,819 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_send_op: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: response from console: RemoveTenantResponse {
  Response {
    operation {
      ready: true
      status: NOT_FOUND
      issues {
        message: "Database \'/Root/test_stop_start_enable_alter_database_create_hive_first--false_\' doesn\'t exist"
        severity: 1
      }
    }
  }
}
Status {
  Code: NOT_FOUND
  Reason: "Database \'/Root/test_stop_start_enable_alter_database_create_hive_first--false_\' doesn\'t exist"
}

2025-11-01 20:51:56,819 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: wait console operation done
2025-11-01 20:51:57,323 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: console operation done
2025-11-01 20:51:57,323 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: wait tenant gone
2025-11-01 20:51:57,326 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/test_stop_start_enable_alter_database_create_hive_first--false_: tenant gone
2025-11-01 20:51:57,326 - DEBUG - ydb.tests.library.fixtures - ydb_database_ctx: create database /Root/test_stop_start_enable_alter_database_create_hive_first--false_: create path and declare internals
2025-11-01 20:51:58,023 - ERROR - ya.test - logreport: ydb/tests/functional/tenants/test_tenants.py:297: in test_stop_start
    with ydb_database_ctx(ydb_cluster, database_path):
contrib/tools/python3/Lib/contextlib.py:137: in __enter__
    return next(self.gen)
ydb/tests/library/fixtures/__init__.py:88: in ydb_database_ctx
    ydb_cluster.create_database(database_path, storage_pool_units_count=storage_pools, timeout_seconds=timeout_seconds, token=token)
ydb/tests/library/harness/kikimr_cluster_interface.py:231: in create_database
    raise RuntimeError('create_database failed: %s, %s' % (operation.status, ydb.issues._format_issues(operation.issues)))
E   RuntimeError: create_database failed: 400080, message: "Group fit error BoxId# 1 StoragePoolId# 5 Error# failed to allocate group: no group options PDisks# {[(1:1-S)]}" severity: 1
2025-11-01 20:51:58,024 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-11-01 20:51:58,024 - DEBUG - ydb.table.SessionPool - stop: Requested session pool stop.
2025-11-01 20:51:58,024 - DEBUG - ydb.table.SessionPool - stop: Session pool is under stop, cancelling all in flight waiters.
2025-11-01 20:51:58,024 - DEBUG - ydb.table.SessionPool - stop: Destroying sessions in active queue
2025-11-01 20:51:58,024 - DEBUG - ydb.table.SessionPool - _destroy: Requested session destroy: <ydb.table.Session object at 0x7f567c70ef90>, reason: session-pool-terminated
2025-11-01 20:51:58,024 - DEBUG - ydb.table.SessionPool - _destroy: Session <ydb.table.Session object at 0x7f567c70ef90> is no longer active. Current active count 0.
2025-11-01 20:51:58,025 - DEBUG - ydb.connection - _prepare_call: RpcState(DeleteSession, 7874e209-b6e1-444f-9058-1f0fa2d2d0e5, ghrun-mjpjznvske.auto.internal:19726): creating call state
2025-11-01 20:51:58,025 - DEBUG - ydb.table.SessionPool - _terminate_event: Terminated session pool.
2025-11-01 20:51:58,025 - DEBUG - ydb.connection - _log_request: RpcState(DeleteSession, 7874e209-b6e1-444f-9058-1f0fa2d2d0e5, ghrun-mjpjznvske.auto.internal:19726): request = { session_id: "ydb://session/3?node_id=50002&id=ODNiODMyYzEtZjVkOGZkN2QtNDAwM2MxOWItZGU0Mzg2NTk=" operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-11-01 20:51:58,027 - DEBUG - ydb.table.SessionPool - _destroy: Sent delete on session <ydb.table.Session object at 0x7f567c70ef90>
2025-11-01 20:51:58,027 - DEBUG - ydb.table.SessionPool - stop: Destroyed active sessions
2025-11-01 20:51:58,027 - DEBUG - ydb.table.SessionPool - stop: Requested session pool stop.
2025-11-01 20:51:58,027 - DEBUG - ydb.table.SessionPool - stop: Session pool is under stop, cancelling all in flight waiters.
2025-11-01 20:51:58,027 - DEBUG - ydb.table.SessionPool - _terminate_event: Terminated session pool.
2025-11-01 20:51:58,028 - DEBUG - ydb.connection - _on_response_callback: RpcState(DeleteSession, 7874e209-b6e1-444f-9058-1f0fa2d2d0e5, ghrun-mjpjznvske.auto.internal:19726): on response callback started
2025-11-01 20:51:58,028 - DEBUG - ydb.table.SessionPool - stop: Destroying sessions in active queue
2025-11-01 20:51:58,029 - DEBUG - ydb.connection - _rpc_error_handler: RpcState(DeleteSession, 7874e209-b6e1-444f-9058-1f0fa2d2d0e5, ghrun-mjpjznvske.auto.internal:19726): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "connections to all backends failing; last error: UNKNOWN: ipv4:127.0.1.1:19726: Failed to connect to remote host: Connection refused"
	debug_error_string = "UNKNOWN:connections to all backends failing; last error: UNKNOWN: ipv4:127.0.1.1:19726: Failed to connect to remote host: Connection refused {file:"/home/runner/actions_runner/_work/ydb/ydb/contrib/libs/grpc/src/core/lib/transport/error_utils.cc", file_line:153, created_time:"2025-11-01T20:51:58.026679255+00:00", grpc_status:14}"
>
2025-11-01 20:51:58,029 - DEBUG - ydb.table.SessionPool - _destroy: Requested session destroy: <ydb.table.Session object at 0x7f567c74d6e0>, reason: session-pool-terminated
2025-11-01 20:51:58,029 - DEBUG - ydb.connection - _rpc_error_handler: RpcState(DeleteSession, 7874e209-b6e1-444f-9058-1f0fa2d2d0e5, ghrun-mjpjznvske.auto.internal:19726): unhandled rpc error, disconnecting channel
2025-11-01 20:51:58,029 - DEBUG - ydb.table.SessionPool - _destroy: Session <ydb.table.Session object at 0x7f567c74d6e0> is no longer active. Current active count 0.
2025-11-01 20:51:58,030 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-mjpjznvske.auto.internal:19726
2025-11-01 20:51:58,030 - DEBUG - ydb.connection - _prepare_call: RpcState(DeleteSession, cc7b93fd-d1f9-449f-9393-4f1280653983, ghrun-mjpjznvske.auto.internal:31349): creating call state
2025-11-01 20:51:58,031 - DEBUG - ydb.connection - _log_request: RpcState(DeleteSession, cc7b93fd-d1f9-449f-9393-4f1280653983, ghrun-mjpjznvske.auto.internal:31349): request = { session_id: "ydb://session/3?node_id=50001&id=NzhhNDgzZGMtZTY4NWZjMzItYzZjNDk2OWYtMjk0NmYxODQ=" operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-11-01 20:51:58,031 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:51:58,032 - DEBUG - ydb.table.SessionPool - _destroy: Sent delete on session <ydb.table.Session object at 0x7f567c74d6e0>
2025-11-01 20:51:58,033 - 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 20:51:58,033 - DEBUG - ydb.table.SessionPool - stop: Destroyed active sessions
2025-11-01 20:51:58,033 - DEBUG - ydb.connection - _on_response_callback: RpcState(DeleteSession, cc7b93fd-d1f9-449f-9393-4f1280653983, ghrun-mjpjznvske.auto.internal:31349): on response callback started
2025-11-01 20:51:58,036 - DEBUG - ydb.table.SessionPool - stop: Requested session pool stop.
2025-11-01 20:51:58,037 - DEBUG - ydb.connection - _rpc_error_handler: RpcState(DeleteSession, cc7b93fd-d1f9-449f-9393-4f1280653983, ghrun-mjpjznvske.auto.internal:31349): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "connections to all backends failing; last error: UNKNOWN: ipv4:127.0.1.1:31349: Failed to connect to remote host: Connection refused"
	debug_error_string = "UNKNOWN:connections to all backends failing; last error: UNKNOWN: ipv4:127.0.1.1:31349: Failed to connect to remote host: Connection refused {grpc_status:14, created_time:"2025-11-01T20:51:58.031447959+00:00", file_line:153, file:"/home/runner/actions_runner/_work/ydb/ydb/contrib/libs/grpc/src/core/lib/transport/error_utils.cc"}"
>
2025-11-01 20:51:58,038 - DEBUG - ydb.table.SessionPool - stop: Session pool is under stop, cancelling all in flight waiters.
2025-11-01 20:51:58,038 - DEBUG - ydb.table.SessionPool - _terminate_event: Terminated session pool.
2025-11-01 20:51:58,038 - DEBUG - ydb.connection - _rpc_error_handler: RpcState(DeleteSession, cc7b93fd-d1f9-449f-9393-4f1280653983, ghrun-mjpjznvske.auto.internal:31349): unhandled rpc error, disconnecting channel
2025-11-01 20:51:58,038 - DEBUG - ydb.table.SessionPool - stop: Destroying sessions in active queue
2025-11-01 20:51:58,039 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-mjpjznvske.auto.internal:31349
2025-11-01 20:51:58,040 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/test_stop_start_enable_alter_database_create_hive_first--false_
2025-11-01 20:51:58,040 - DEBUG - ydb.table.SessionPool - _destroy: Requested session destroy: <ydb.table.Session object at 0x7f567c7402e0>, reason: session-pool-terminated
2025-11-01 20:51:58,041 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:51:58,041 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 26120591-442a-4e3b-b8a3-0f1660a96071, localhost:20032): creating call state
2025-11-01 20:51:58,042 - DEBUG - ydb.table.SessionPool - _destroy: Session <ydb.table.Session object at 0x7f567c7402e0> is no longer active. Current active count 0.
2025-11-01 20:51:58,042 - 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 20:51:58,042 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 26120591-442a-4e3b-b8a3-0f1660a96071, localhost:20032): request = { database: "/Root/test_stop_start_enable_alter_database_create_hive_first--false_" }
2025-11-01 20:51:58,043 - DEBUG - ydb.connection - _prepare_call: RpcState(DeleteSession, 8287d5ed-0439-4570-8678-53e1bc85643f, ghrun-mjpjznvske.auto.internal:62483): creating call state
2025-11-01 20:51:58,045 - DEBUG - ydb.connection - _log_request: RpcState(DeleteSession, 8287d5ed-0439-4570-8678-53e1bc85643f, ghrun-mjpjznvske.auto.internal:62483): request = { session_id: "ydb://session/3?node_id=50000&id=Zjg1MTFiZWItOGQxN2Y3N2UtZDZiNTM2OTEtNzQ2ZTI0NGY=" operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-11-01 20:51:58,046 - DEBUG - ydb.table.SessionPool - _destroy: Sent delete on session <ydb.table.Session object at 0x7f567c7402e0>
2025-11-01 20:51:58,046 - DEBUG - ydb.table.SessionPool - stop: Destroyed active sessions
2025-11-01 20:51:58,046 - DEBUG - ydb.topic - close: Close topic client
2025-11-01 20:51:58,047 - DEBUG - ydb.topic - close: Topic client was closed
2025-11-01 20:51:58,047 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:20032
2025-11-01 20:51:58,047 - DEBUG - ydb.connection - _on_response_callback: RpcState(DeleteSession, 8287d5ed-0439-4570-8678-53e1bc85643f, ghrun-mjpjznvske.auto.internal:62483): on response callback started
2025-11-01 20:51:58,048 - DEBUG - ydb.connection - _rpc_error_handler: RpcState(DeleteSession, 8287d5ed-0439-4570-8678-53e1bc85643f, ghrun-mjpjznvske.auto.internal:62483): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "connections to all backends failing; last error: UNKNOWN: ipv4:127.0.1.1:62483: Failed to connect to remote host: Connection refused"
	debug_error_string = "UNKNOWN:connections to all backends failing; last error: UNKNOWN: ipv4:127.0.1.1:62483: Failed to connect to remote host: Connection refused {file:"/home/runner/actions_runner/_work/ydb/ydb/contrib/libs/grpc/src/core/lib/transport/error_utils.cc", file_line:153, created_time:"2025-11-01T20:51:58.046070741+00:00", grpc_status:14}"
>
2025-11-01 20:51:58,048 - DEBUG - ydb.connection - _rpc_error_handler: RpcState(DeleteSession, 8287d5ed-0439-4570-8678-53e1bc85643f, ghrun-mjpjznvske.auto.internal:62483): unhandled rpc error, disconnecting channel
2025-11-01 20:51:58,048 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-mjpjznvske.auto.internal:62483
2025-11-01 20:51:58,049 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 26120591-442a-4e3b-b8a3-0f1660a96071, localhost:20032): response = { operation { ready: true status: NOT_FOUND issues { message: "Requested database does not exist" issue_code: 200202 severity: 1 } } }
2025-11-01 20:51:58,049 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:51:58,049 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/test_stop_start_enable_alter_database_create_hive_first--false_
2025-11-01 20:51:58,050 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root/test_stop_start_enable_alter_database_create_hive_first--false_. Endpoint: "localhost:20032". Error details:
 message: "Requested database does not exist" issue_code: 200202 severity: 1 (server_code: 400140)
2025-11-01 20:51:58,050 - 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 20:51:58,051 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, f3e260a0-677a-4ba2-9499-b987dc4d2f87, localhost:20032): creating call state
2025-11-01 20:51:58,051 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:20032
2025-11-01 20:51:58,053 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, f3e260a0-677a-4ba2-9499-b987dc4d2f87, localhost:20032): request = { database: "/Root/test_stop_start_enable_alter_database_create_hive_first--false_" }
2025-11-01 20:51:58,055 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/test_stop_start_enable_alter_database_create_hive_first--false_
2025-11-01 20:51:58,055 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, ef24b372-d2fd-4c06-b90a-ae212d1e1425, localhost:20032): creating call state
2025-11-01 20:51:58,055 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, ef24b372-d2fd-4c06-b90a-ae212d1e1425, localhost:20032): request = { database: "/Root/test_stop_start_enable_alter_database_create_hive_first--false_" }
2025-11-01 20:51:58,056 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, f3e260a0-677a-4ba2-9499-b987dc4d2f87, localhost:20032): response = { operation { ready: true status: NOT_FOUND issues { message: "Requested database does not exist" issue_code: 200202 severity: 1 } } }
2025-11-01 20:51:58,056 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root/test_stop_start_enable_alter_database_create_hive_first--false_. Endpoint: "localhost:20032". Error details:
 message: "Requested database does not exist" issue_code: 200202 severity: 1 (server_code: 400140)
2025-11-01 20:51:58,056 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:20032
2025-11-01 20:51:58,056 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, ef24b372-d2fd-4c06-b90a-ae212d1e1425, localhost:20032): response = { operation { ready: true status: NOT_FOUND issues { message: "Requested database does not exist" issue_code: 200202 severity: 1 } } }
2025-11-01 20:51:58,057 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root/test_stop_start_enable_alter_database_create_hive_first--false_. Endpoint: "localhost:20032". Error details:
 message: "Requested database does not exist" issue_code: 200202 severity: 1 (server_code: 400140)
2025-11-01 20:51:58,057 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:20032
2025-11-01 20:51:58,241 - INFO - ydb.pool.Discovery - run: Successfully terminated discovery process
2025-11-01 20:51:58,242 - DEBUG - ydb.topic - close: Close topic client
2025-11-01 20:51:58,242 - DEBUG - ydb.topic - close: Topic client was closed
2025-11-01 20:51:58,242 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:20032
2025-11-01 20:51:58,251 - INFO - ydb.pool.Discovery - run: Successfully terminated discovery process
2025-11-01 20:51:58,252 - DEBUG - ydb.topic - close: Close topic client
2025-11-01 20:51:58,252 - DEBUG - ydb.topic - close: Topic client was closed
2025-11-01 20:51:58,252 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:20032
2025-11-01 20:51:58,257 - INFO - ydb.pool.Discovery - run: Successfully terminated discovery process
2025-11-01 20:51:58,258 - INFO - ydb.tests.library.fixtures - ydb_cluster: destroy ydb_cluster for __tests__.test_tenants
2025-11-01 20:52:01,259 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:20032/1
2025-11-01 20:52:01,259 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/15899
2025-11-01 20:52:01,259 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/20825
2025-11-01 20:52:01,260 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/18672
2025-11-01 20:52:01,260 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/16708
2025-11-01 20:52:01,260 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/19726
2025-11-01 20:52:01,260 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/23330
2025-11-01 20:52:01,260 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/26047
2025-11-01 20:52:01,260 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/12183
2025-11-01 20:52:01,260 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/7890
2025-11-01 20:52:01,260 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/31349
2025-11-01 20:52:01,260 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/27775
2025-11-01 20:52:01,261 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/18957
2025-11-01 20:52:01,261 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/17256
2025-11-01 20:52:01,261 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/31160
2025-11-01 20:52:01,261 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/62483
2025-11-01 20:52:01,261 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/19476
2025-11-01 20:52:01,261 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/5471
2025-11-01 20:52:01,261 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/14742
2025-11-01 20:52:01,261 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/20032
2025-11-01 20:52:01,261 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/10513
