2025-10-31 08:42:20,680 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-31 08:42:20,680 - INFO - ya.test - pytest_runtest_setup: test_database_backup_restore
2025-10-31 08:42:20,680 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-31 08:42:20,680 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-10-31 08:42:20,747 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd
2025-10-31 08:42:20,748 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/26624
2025-10-31 08:42:20,751 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/pogg/001904/r3tmp/kikimr_cluster_37hw8frm
2025-10-31 08:42:20,789 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd
2025-10-31 08:42:20,790 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/11298
2025-10-31 08:42:20,790 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/8894
2025-10-31 08:42:20,790 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/4548
2025-10-31 08:42:20,790 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/62706
2025-10-31 08:42:20,791 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/cluster/kikimr_configs"
2025-10-31 08:42:20,791 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/pogg/001904/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/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/cluster/node_1/logfile_rz6hbypo.log --grpc-port=11298 --mon-port=8894 --ic-port=26624
2025-10-31 08:42:20,792 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:11298/1, disk_size 68719476736
2025-10-31 08:42:20,792 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/cluster/kikimr_configs"
2025-10-31 08:42:20,792 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/pogg/001904/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/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/cluster/node_1/logfile_rz6hbypo.log --grpc-port=11298 --mon-port=8894 --ic-port=26624
2025-10-31 08:42:20,793 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/cluster/node_1/logfile_rz6hbypo.log', '--grpc-port=11298', '--mon-port=8894', '--ic-port=26624')' in '/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/cluster/node_1' (no wait)
2025-10-31 08:42:20,794 - DEBUG - ya.test - execute: Command pid: 3274849
2025-10-31 08:42:20,795 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:11298/1
2025-10-31 08:42:20,796 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-10-31 08:42:20,797 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-10-31 08:42:20,798 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-10-31 08:42:20,799 - DEBUG - ya.test - execute: Command pid: 3274851
2025-10-31 08:42:21,717 - DEBUG - ya.test - _save_outputs: Command (pid 3274851) rc: 0
2025-10-31 08:42:21,717 - DEBUG - ya.test - _save_outputs: Command (pid 3274851) elapsed time (sec): 0.9169681072235107
2025-10-31 08:42:21,717 - DEBUG - ya.test - _save_outputs: Command (pid 3274851) idrss: 0
2025-10-31 08:42:21,718 - DEBUG - ya.test - _save_outputs: Command (pid 3274851) inblock: 0
2025-10-31 08:42:21,718 - DEBUG - ya.test - _save_outputs: Command (pid 3274851) isrss: 0
2025-10-31 08:42:21,718 - DEBUG - ya.test - _save_outputs: Command (pid 3274851) ixrss: 0
2025-10-31 08:42:21,718 - DEBUG - ya.test - _save_outputs: Command (pid 3274851) majflt: 0
2025-10-31 08:42:21,718 - DEBUG - ya.test - _save_outputs: Command (pid 3274851) maxrss: 538184
2025-10-31 08:42:21,718 - DEBUG - ya.test - _save_outputs: Command (pid 3274851) minflt: 16127
2025-10-31 08:42:21,719 - DEBUG - ya.test - _save_outputs: Command (pid 3274851) msgrcv: 0
2025-10-31 08:42:21,719 - DEBUG - ya.test - _save_outputs: Command (pid 3274851) msgsnd: 0
2025-10-31 08:42:21,719 - DEBUG - ya.test - _save_outputs: Command (pid 3274851) nivcsw: 61
2025-10-31 08:42:21,719 - DEBUG - ya.test - _save_outputs: Command (pid 3274851) nsignals: 0
2025-10-31 08:42:21,719 - DEBUG - ya.test - _save_outputs: Command (pid 3274851) nswap: 0
2025-10-31 08:42:21,719 - DEBUG - ya.test - _save_outputs: Command (pid 3274851) nvcsw: 14
2025-10-31 08:42:21,720 - DEBUG - ya.test - _save_outputs: Command (pid 3274851) oublock: 8
2025-10-31 08:42:21,720 - DEBUG - ya.test - _save_outputs: Command (pid 3274851) stime: 0.739381
2025-10-31 08:42:21,720 - DEBUG - ya.test - _save_outputs: Command (pid 3274851) utime: 0.127894
2025-10-31 08:42:21,720 - DEBUG - ya.test - _save_outputs: Command (pid 3274851) wtime: 0.918
2025-10-31 08:42:21,720 - DEBUG - ya.test - _save_outputs: Command (pid 3274851) output:
Git info:
    Commit: 82bf8aab4f547668632ff26479ecdb9996428c61
    Branch: 
    Author: Innokentii Mokin <enjection@ya.ru>
    Summary: Merge 43cd17c8a58e28cd156b58873e20cf204c35cf0d into e300863ab69d6519229a61bcfeb54a36b8d86bd0

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-uabpkrvm6i
    Host information: 
        Linux ghrun-uabpkrvm6i 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-10-31 08:42:21,721 - DEBUG - ya.test - _save_outputs: Command (pid 3274851) errors:

2025-10-31 08:42:21,721 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 82bf8aab4f547668632ff26479ecdb9996428c61
    Branch: 
    Author: Innokentii Mokin <enjection@ya.ru>
    Summary: Merge 43cd17c8a58e28cd156b58873e20cf204c35cf0d into e300863ab69d6519229a61bcfeb54a36b8d86bd0
2025-10-31 08:42:23,586 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd
2025-10-31 08:42:23,587 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:11298', '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: 26624\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-10-31 08:42:23,588 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-10-31 08:42:23,588 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-10-31 08:42:23,588 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:11298', '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: 26624\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-10-31 08:42:23,589 - DEBUG - ya.test - execute: Command pid: 3277487
2025-10-31 08:42:24,066 - DEBUG - ya.test - _save_outputs: Command (pid 3277487) rc: 0
2025-10-31 08:42:24,066 - DEBUG - ya.test - _save_outputs: Command (pid 3277487) elapsed time (sec): 0.47535037994384766
2025-10-31 08:42:24,066 - DEBUG - ya.test - _save_outputs: Command (pid 3277487) idrss: 0
2025-10-31 08:42:24,067 - DEBUG - ya.test - _save_outputs: Command (pid 3277487) inblock: 0
2025-10-31 08:42:24,067 - DEBUG - ya.test - _save_outputs: Command (pid 3277487) isrss: 0
2025-10-31 08:42:24,067 - DEBUG - ya.test - _save_outputs: Command (pid 3277487) ixrss: 0
2025-10-31 08:42:24,067 - DEBUG - ya.test - _save_outputs: Command (pid 3277487) majflt: 0
2025-10-31 08:42:24,067 - DEBUG - ya.test - _save_outputs: Command (pid 3277487) maxrss: 546680
2025-10-31 08:42:24,067 - DEBUG - ya.test - _save_outputs: Command (pid 3277487) minflt: 18269
2025-10-31 08:42:24,068 - DEBUG - ya.test - _save_outputs: Command (pid 3277487) msgrcv: 0
2025-10-31 08:42:24,068 - DEBUG - ya.test - _save_outputs: Command (pid 3277487) msgsnd: 0
2025-10-31 08:42:24,068 - DEBUG - ya.test - _save_outputs: Command (pid 3277487) nivcsw: 10
2025-10-31 08:42:24,068 - DEBUG - ya.test - _save_outputs: Command (pid 3277487) nsignals: 0
2025-10-31 08:42:24,068 - DEBUG - ya.test - _save_outputs: Command (pid 3277487) nswap: 0
2025-10-31 08:42:24,069 - DEBUG - ya.test - _save_outputs: Command (pid 3277487) nvcsw: 135
2025-10-31 08:42:24,069 - DEBUG - ya.test - _save_outputs: Command (pid 3277487) oublock: 8
2025-10-31 08:42:24,069 - DEBUG - ya.test - _save_outputs: Command (pid 3277487) stime: 0.28652299999999997
2025-10-31 08:42:24,069 - DEBUG - ya.test - _save_outputs: Command (pid 3277487) utime: 0.145279
2025-10-31 08:42:24,069 - DEBUG - ya.test - _save_outputs: Command (pid 3277487) wtime: 0.477
2025-10-31 08:42:24,069 - DEBUG - ya.test - _save_outputs: Command (pid 3277487) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 4

2025-10-31 08:42:24,070 - DEBUG - ya.test - _save_outputs: Command (pid 3277487) errors:

2025-10-31 08:42:24,071 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd
2025-10-31 08:42:24,071 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:11298', '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-10-31 08:42:24,072 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-10-31 08:42:24,072 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-10-31 08:42:24,073 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:11298', '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-10-31 08:42:24,074 - DEBUG - ya.test - execute: Command pid: 3277754
2025-10-31 08:42:24,711 - DEBUG - ya.test - _save_outputs: Command (pid 3277754) rc: 0
2025-10-31 08:42:24,711 - DEBUG - ya.test - _save_outputs: Command (pid 3277754) elapsed time (sec): 0.6364483833312988
2025-10-31 08:42:24,711 - DEBUG - ya.test - _save_outputs: Command (pid 3277754) idrss: 0
2025-10-31 08:42:24,712 - DEBUG - ya.test - _save_outputs: Command (pid 3277754) inblock: 0
2025-10-31 08:42:24,712 - DEBUG - ya.test - _save_outputs: Command (pid 3277754) isrss: 0
2025-10-31 08:42:24,712 - DEBUG - ya.test - _save_outputs: Command (pid 3277754) ixrss: 0
2025-10-31 08:42:24,712 - DEBUG - ya.test - _save_outputs: Command (pid 3277754) majflt: 0
2025-10-31 08:42:24,712 - DEBUG - ya.test - _save_outputs: Command (pid 3277754) maxrss: 546696
2025-10-31 08:42:24,712 - DEBUG - ya.test - _save_outputs: Command (pid 3277754) minflt: 18273
2025-10-31 08:42:24,713 - DEBUG - ya.test - _save_outputs: Command (pid 3277754) msgrcv: 0
2025-10-31 08:42:24,713 - DEBUG - ya.test - _save_outputs: Command (pid 3277754) msgsnd: 0
2025-10-31 08:42:24,713 - DEBUG - ya.test - _save_outputs: Command (pid 3277754) nivcsw: 8
2025-10-31 08:42:24,713 - DEBUG - ya.test - _save_outputs: Command (pid 3277754) nsignals: 0
2025-10-31 08:42:24,713 - DEBUG - ya.test - _save_outputs: Command (pid 3277754) nswap: 0
2025-10-31 08:42:24,713 - DEBUG - ya.test - _save_outputs: Command (pid 3277754) nvcsw: 126
2025-10-31 08:42:24,714 - DEBUG - ya.test - _save_outputs: Command (pid 3277754) oublock: 8
2025-10-31 08:42:24,714 - DEBUG - ya.test - _save_outputs: Command (pid 3277754) stime: 0.45652899999999996
2025-10-31 08:42:24,714 - DEBUG - ya.test - _save_outputs: Command (pid 3277754) utime: 0.140306
2025-10-31 08:42:24,714 - DEBUG - ya.test - _save_outputs: Command (pid 3277754) wtime: 0.638
2025-10-31 08:42:24,714 - DEBUG - ya.test - _save_outputs: Command (pid 3277754) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-10-31 08:42:24,715 - DEBUG - ya.test - _save_outputs: Command (pid 3277754) errors:

2025-10-31 08:42:24,715 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-10-31 08:42:24,729 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-10-31 08:42:25,249 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd
2025-10-31 08:42:25,250 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/11193
2025-10-31 08:42:25,250 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/30282
2025-10-31 08:42:25,251 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/2255
2025-10-31 08:42:25,251 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/13929
2025-10-31 08:42:25,251 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/9569
2025-10-31 08:42:25,252 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/cluster/kikimr_configs"
2025-10-31 08:42:25,252 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:11298 --tenant=/Root/db1 --log-file-name=/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/cluster/slot_1/logfile_xqhpehtl.log --grpc-port=11193 --mon-port=30282 --ic-port=2255
2025-10-31 08:42:25,253 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd
2025-10-31 08:42:25,253 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/28947
2025-10-31 08:42:25,253 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/7788
2025-10-31 08:42:25,254 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/6677
2025-10-31 08:42:25,254 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/4217
2025-10-31 08:42:25,254 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/23249
2025-10-31 08:42:25,255 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/cluster/kikimr_configs"
2025-10-31 08:42:25,255 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:11298 --tenant=/Root/db1 --log-file-name=/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/cluster/slot_2/logfile_yryzrjzs.log --grpc-port=28947 --mon-port=7788 --ic-port=6677
2025-10-31 08:42:25,255 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd
2025-10-31 08:42:25,256 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/15368
2025-10-31 08:42:25,256 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/3380
2025-10-31 08:42:25,256 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/6936
2025-10-31 08:42:25,256 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/24773
2025-10-31 08:42:25,257 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/27536
2025-10-31 08:42:25,257 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/cluster/kikimr_configs"
2025-10-31 08:42:25,258 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:11298 --tenant=/Root/db1 --log-file-name=/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/cluster/slot_3/logfile_btpb8wvm.log --grpc-port=15368 --mon-port=3380 --ic-port=6936
2025-10-31 08:42:25,258 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/cluster/kikimr_configs"
2025-10-31 08:42:25,258 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:11298 --tenant=/Root/db1 --log-file-name=/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/cluster/slot_1/logfile_xqhpehtl.log --grpc-port=11193 --mon-port=30282 --ic-port=2255
2025-10-31 08:42:25,259 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/cluster/kikimr_configs/config.yaml', '--node-broker=localhost:11298', '--tenant=/Root/db1', '--log-file-name=/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/cluster/slot_1/logfile_xqhpehtl.log', '--grpc-port=11193', '--mon-port=30282', '--ic-port=2255')' in '/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/cluster/slot_1' (no wait)
2025-10-31 08:42:25,260 - DEBUG - ya.test - execute: Command pid: 3278639
2025-10-31 08:42:25,261 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:11193/1
2025-10-31 08:42:25,262 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-10-31 08:42:25,262 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-10-31 08:42:25,263 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-10-31 08:42:25,264 - DEBUG - ya.test - execute: Command pid: 3278640
2025-10-31 08:42:25,672 - DEBUG - ya.test - _save_outputs: Command (pid 3278640) rc: 0
2025-10-31 08:42:25,672 - DEBUG - ya.test - _save_outputs: Command (pid 3278640) elapsed time (sec): 0.4072134494781494
2025-10-31 08:42:25,673 - DEBUG - ya.test - _save_outputs: Command (pid 3278640) idrss: 0
2025-10-31 08:42:25,673 - DEBUG - ya.test - _save_outputs: Command (pid 3278640) inblock: 0
2025-10-31 08:42:25,673 - DEBUG - ya.test - _save_outputs: Command (pid 3278640) isrss: 0
2025-10-31 08:42:25,674 - DEBUG - ya.test - _save_outputs: Command (pid 3278640) ixrss: 0
2025-10-31 08:42:25,674 - DEBUG - ya.test - _save_outputs: Command (pid 3278640) majflt: 0
2025-10-31 08:42:25,674 - DEBUG - ya.test - _save_outputs: Command (pid 3278640) maxrss: 538184
2025-10-31 08:42:25,675 - DEBUG - ya.test - _save_outputs: Command (pid 3278640) minflt: 16129
2025-10-31 08:42:25,675 - DEBUG - ya.test - _save_outputs: Command (pid 3278640) msgrcv: 0
2025-10-31 08:42:25,675 - DEBUG - ya.test - _save_outputs: Command (pid 3278640) msgsnd: 0
2025-10-31 08:42:25,675 - DEBUG - ya.test - _save_outputs: Command (pid 3278640) nivcsw: 6
2025-10-31 08:42:25,675 - DEBUG - ya.test - _save_outputs: Command (pid 3278640) nsignals: 0
2025-10-31 08:42:25,676 - DEBUG - ya.test - _save_outputs: Command (pid 3278640) nswap: 0
2025-10-31 08:42:25,676 - DEBUG - ya.test - _save_outputs: Command (pid 3278640) nvcsw: 19
2025-10-31 08:42:25,676 - DEBUG - ya.test - _save_outputs: Command (pid 3278640) oublock: 8
2025-10-31 08:42:25,677 - DEBUG - ya.test - _save_outputs: Command (pid 3278640) stime: 0.23929799999999998
2025-10-31 08:42:25,678 - DEBUG - ya.test - _save_outputs: Command (pid 3278640) utime: 0.11964899999999999
2025-10-31 08:42:25,679 - DEBUG - ya.test - _save_outputs: Command (pid 3278640) wtime: 0.408
2025-10-31 08:42:25,679 - DEBUG - ya.test - _save_outputs: Command (pid 3278640) output:
Git info:
    Commit: 82bf8aab4f547668632ff26479ecdb9996428c61
    Branch: 
    Author: Innokentii Mokin <enjection@ya.ru>
    Summary: Merge 43cd17c8a58e28cd156b58873e20cf204c35cf0d into e300863ab69d6519229a61bcfeb54a36b8d86bd0

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-uabpkrvm6i
    Host information: 
        Linux ghrun-uabpkrvm6i 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-10-31 08:42:25,680 - DEBUG - ya.test - _save_outputs: Command (pid 3278640) errors:

2025-10-31 08:42:25,681 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 82bf8aab4f547668632ff26479ecdb9996428c61
    Branch: 
    Author: Innokentii Mokin <enjection@ya.ru>
    Summary: Merge 43cd17c8a58e28cd156b58873e20cf204c35cf0d into e300863ab69d6519229a61bcfeb54a36b8d86bd0
2025-10-31 08:42:25,681 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/cluster/kikimr_configs"
2025-10-31 08:42:25,682 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:11298 --tenant=/Root/db1 --log-file-name=/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/cluster/slot_2/logfile_yryzrjzs.log --grpc-port=28947 --mon-port=7788 --ic-port=6677
2025-10-31 08:42:25,683 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/cluster/kikimr_configs/config.yaml', '--node-broker=localhost:11298', '--tenant=/Root/db1', '--log-file-name=/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/cluster/slot_2/logfile_yryzrjzs.log', '--grpc-port=28947', '--mon-port=7788', '--ic-port=6677')' in '/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/cluster/slot_2' (no wait)
2025-10-31 08:42:25,685 - DEBUG - ya.test - execute: Command pid: 3278789
2025-10-31 08:42:25,686 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:28947/2
2025-10-31 08:42:25,688 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.3
2025-10-31 08:42:25,688 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.3
2025-10-31 08:42:25,688 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-10-31 08:42:25,689 - DEBUG - ya.test - execute: Command pid: 3278790
2025-10-31 08:42:26,097 - DEBUG - ya.test - _save_outputs: Command (pid 3278790) rc: 0
2025-10-31 08:42:26,097 - DEBUG - ya.test - _save_outputs: Command (pid 3278790) elapsed time (sec): 0.4065401554107666
2025-10-31 08:42:26,097 - DEBUG - ya.test - _save_outputs: Command (pid 3278790) idrss: 0
2025-10-31 08:42:26,097 - DEBUG - ya.test - _save_outputs: Command (pid 3278790) inblock: 0
2025-10-31 08:42:26,097 - DEBUG - ya.test - _save_outputs: Command (pid 3278790) isrss: 0
2025-10-31 08:42:26,114 - DEBUG - ya.test - _save_outputs: Command (pid 3278790) ixrss: 0
2025-10-31 08:42:26,115 - DEBUG - ya.test - _save_outputs: Command (pid 3278790) majflt: 0
2025-10-31 08:42:26,115 - DEBUG - ya.test - _save_outputs: Command (pid 3278790) maxrss: 538184
2025-10-31 08:42:26,116 - DEBUG - ya.test - _save_outputs: Command (pid 3278790) minflt: 16128
2025-10-31 08:42:26,116 - DEBUG - ya.test - _save_outputs: Command (pid 3278790) msgrcv: 0
2025-10-31 08:42:26,117 - DEBUG - ya.test - _save_outputs: Command (pid 3278790) msgsnd: 0
2025-10-31 08:42:26,117 - DEBUG - ya.test - _save_outputs: Command (pid 3278790) nivcsw: 45
2025-10-31 08:42:26,118 - DEBUG - ya.test - _save_outputs: Command (pid 3278790) nsignals: 0
2025-10-31 08:42:26,118 - DEBUG - ya.test - _save_outputs: Command (pid 3278790) nswap: 0
2025-10-31 08:42:26,119 - DEBUG - ya.test - _save_outputs: Command (pid 3278790) nvcsw: 21
2025-10-31 08:42:26,119 - DEBUG - ya.test - _save_outputs: Command (pid 3278790) oublock: 8
2025-10-31 08:42:26,119 - DEBUG - ya.test - _save_outputs: Command (pid 3278790) stime: 0.240996
2025-10-31 08:42:26,119 - DEBUG - ya.test - _save_outputs: Command (pid 3278790) utime: 0.11456999999999999
2025-10-31 08:42:26,119 - DEBUG - ya.test - _save_outputs: Command (pid 3278790) wtime: 0.408
2025-10-31 08:42:26,119 - DEBUG - ya.test - _save_outputs: Command (pid 3278790) output:
Git info:
    Commit: 82bf8aab4f547668632ff26479ecdb9996428c61
    Branch: 
    Author: Innokentii Mokin <enjection@ya.ru>
    Summary: Merge 43cd17c8a58e28cd156b58873e20cf204c35cf0d into e300863ab69d6519229a61bcfeb54a36b8d86bd0

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-uabpkrvm6i
    Host information: 
        Linux ghrun-uabpkrvm6i 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-10-31 08:42:26,120 - DEBUG - ya.test - _save_outputs: Command (pid 3278790) errors:

2025-10-31 08:42:26,120 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 2 version:
Git info:
    Commit: 82bf8aab4f547668632ff26479ecdb9996428c61
    Branch: 
    Author: Innokentii Mokin <enjection@ya.ru>
    Summary: Merge 43cd17c8a58e28cd156b58873e20cf204c35cf0d into e300863ab69d6519229a61bcfeb54a36b8d86bd0
2025-10-31 08:42:26,120 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/cluster/kikimr_configs"
2025-10-31 08:42:26,120 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:11298 --tenant=/Root/db1 --log-file-name=/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/cluster/slot_3/logfile_btpb8wvm.log --grpc-port=15368 --mon-port=3380 --ic-port=6936
2025-10-31 08:42:26,121 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/cluster/kikimr_configs/config.yaml', '--node-broker=localhost:11298', '--tenant=/Root/db1', '--log-file-name=/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/cluster/slot_3/logfile_btpb8wvm.log', '--grpc-port=15368', '--mon-port=3380', '--ic-port=6936')' in '/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/cluster/slot_3' (no wait)
2025-10-31 08:42:26,123 - DEBUG - ya.test - execute: Command pid: 3279208
2025-10-31 08:42:26,123 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:15368/3
2025-10-31 08:42:26,125 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.4
2025-10-31 08:42:26,125 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.4
2025-10-31 08:42:26,126 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-10-31 08:42:26,127 - DEBUG - ya.test - execute: Command pid: 3279209
2025-10-31 08:42:26,884 - DEBUG - ya.test - _save_outputs: Command (pid 3279209) rc: 0
2025-10-31 08:42:26,884 - DEBUG - ya.test - _save_outputs: Command (pid 3279209) elapsed time (sec): 0.7554013729095459
2025-10-31 08:42:26,885 - DEBUG - ya.test - _save_outputs: Command (pid 3279209) idrss: 0
2025-10-31 08:42:26,886 - DEBUG - ya.test - _save_outputs: Command (pid 3279209) inblock: 0
2025-10-31 08:42:26,889 - DEBUG - ya.test - _save_outputs: Command (pid 3279209) isrss: 0
2025-10-31 08:42:26,889 - DEBUG - ya.test - _save_outputs: Command (pid 3279209) ixrss: 0
2025-10-31 08:42:26,890 - DEBUG - ya.test - _save_outputs: Command (pid 3279209) majflt: 0
2025-10-31 08:42:26,890 - DEBUG - ya.test - _save_outputs: Command (pid 3279209) maxrss: 538184
2025-10-31 08:42:26,891 - DEBUG - ya.test - _save_outputs: Command (pid 3279209) minflt: 16128
2025-10-31 08:42:26,891 - DEBUG - ya.test - _save_outputs: Command (pid 3279209) msgrcv: 0
2025-10-31 08:42:26,892 - DEBUG - ya.test - _save_outputs: Command (pid 3279209) msgsnd: 0
2025-10-31 08:42:26,893 - DEBUG - ya.test - _save_outputs: Command (pid 3279209) nivcsw: 10
2025-10-31 08:42:26,893 - DEBUG - ya.test - _save_outputs: Command (pid 3279209) nsignals: 0
2025-10-31 08:42:26,893 - DEBUG - ya.test - _save_outputs: Command (pid 3279209) nswap: 0
2025-10-31 08:42:26,894 - DEBUG - ya.test - _save_outputs: Command (pid 3279209) nvcsw: 18
2025-10-31 08:42:26,894 - DEBUG - ya.test - _save_outputs: Command (pid 3279209) oublock: 8
2025-10-31 08:42:26,894 - DEBUG - ya.test - _save_outputs: Command (pid 3279209) stime: 0.56722
2025-10-31 08:42:26,895 - DEBUG - ya.test - _save_outputs: Command (pid 3279209) utime: 0.139807
2025-10-31 08:42:26,895 - DEBUG - ya.test - _save_outputs: Command (pid 3279209) wtime: 0.757
2025-10-31 08:42:26,895 - DEBUG - ya.test - _save_outputs: Command (pid 3279209) output:
Git info:
    Commit: 82bf8aab4f547668632ff26479ecdb9996428c61
    Branch: 
    Author: Innokentii Mokin <enjection@ya.ru>
    Summary: Merge 43cd17c8a58e28cd156b58873e20cf204c35cf0d into e300863ab69d6519229a61bcfeb54a36b8d86bd0

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-uabpkrvm6i
    Host information: 
        Linux ghrun-uabpkrvm6i 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-10-31 08:42:26,896 - DEBUG - ya.test - _save_outputs: Command (pid 3279209) errors:

2025-10-31 08:42:26,896 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 3 version:
Git info:
    Commit: 82bf8aab4f547668632ff26479ecdb9996428c61
    Branch: 
    Author: Innokentii Mokin <enjection@ya.ru>
    Summary: Merge 43cd17c8a58e28cd156b58873e20cf204c35cf0d into e300863ab69d6519229a61bcfeb54a36b8d86bd0
2025-10-31 08:43:32,953 - 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-10-31 08:43:32,956 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:43:32,958 - 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-10-31 08:43:32,968 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/db1
2025-10-31 08:43:32,968 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, ced82b2f-4df0-4a0c-acd8-d535068ebdd3, localhost:11298): creating call state
2025-10-31 08:43:32,969 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, ced82b2f-4df0-4a0c-acd8-d535068ebdd3, localhost:11298): request = { database: "/Root/db1" }
2025-10-31 08:43:32,972 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, ced82b2f-4df0-4a0c-acd8-d535068ebdd3, localhost:11298): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-uabpkrvm6i.auto.internal" port: 11193 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-10-31 08:43:32,973 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root/db1: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-uabpkrvm6i.auto.internal:11193, location , ssl: False>]>
2025-10-31 08:43:32,973 - 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-10-31 08:43:32,982 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:11298
2025-10-31 08:43:33,055 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd
2025-10-31 08:43:33,056 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/5452
2025-10-31 08:43:33,060 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/pogg/001904/r3tmp/kikimr_restore_cluster_r1csteu_
2025-10-31 08:43:33,099 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd
2025-10-31 08:43:33,099 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/6393
2025-10-31 08:43:33,100 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/25130
2025-10-31 08:43:33,100 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/14668
2025-10-31 08:43:33,100 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/12660
2025-10-31 08:43:33,101 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/restore_cluster/kikimr_configs"
2025-10-31 08:43:33,101 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/pogg/001904/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/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/restore_cluster/node_1/logfile_hqliyutj.log --grpc-port=6393 --mon-port=25130 --ic-port=5452
2025-10-31 08:43:33,101 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:6393/1, disk_size 68719476736
2025-10-31 08:43:33,102 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/restore_cluster/kikimr_configs"
2025-10-31 08:43:33,102 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/pogg/001904/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/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/restore_cluster/node_1/logfile_hqliyutj.log --grpc-port=6393 --mon-port=25130 --ic-port=5452
2025-10-31 08:43:33,105 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/restore_cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/restore_cluster/node_1/logfile_hqliyutj.log', '--grpc-port=6393', '--mon-port=25130', '--ic-port=5452')' in '/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/restore_cluster/node_1' (no wait)
2025-10-31 08:43:33,107 - DEBUG - ya.test - execute: Command pid: 3341641
2025-10-31 08:43:33,107 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:6393/1
2025-10-31 08:43:33,108 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.5
2025-10-31 08:43:33,109 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.5
2025-10-31 08:43:33,109 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-10-31 08:43:33,110 - DEBUG - ya.test - execute: Command pid: 3341643
2025-10-31 08:43:33,577 - DEBUG - ya.test - _save_outputs: Command (pid 3341643) rc: 0
2025-10-31 08:43:33,577 - DEBUG - ya.test - _save_outputs: Command (pid 3341643) elapsed time (sec): 0.46453309059143066
2025-10-31 08:43:33,578 - DEBUG - ya.test - _save_outputs: Command (pid 3341643) idrss: 0
2025-10-31 08:43:33,585 - DEBUG - ya.test - _save_outputs: Command (pid 3341643) inblock: 0
2025-10-31 08:43:33,585 - DEBUG - ya.test - _save_outputs: Command (pid 3341643) isrss: 0
2025-10-31 08:43:33,586 - DEBUG - ya.test - _save_outputs: Command (pid 3341643) ixrss: 0
2025-10-31 08:43:33,586 - DEBUG - ya.test - _save_outputs: Command (pid 3341643) majflt: 0
2025-10-31 08:43:33,589 - DEBUG - ya.test - _save_outputs: Command (pid 3341643) maxrss: 538184
2025-10-31 08:43:33,589 - DEBUG - ya.test - _save_outputs: Command (pid 3341643) minflt: 18104
2025-10-31 08:43:33,589 - DEBUG - ya.test - _save_outputs: Command (pid 3341643) msgrcv: 0
2025-10-31 08:43:33,589 - DEBUG - ya.test - _save_outputs: Command (pid 3341643) msgsnd: 0
2025-10-31 08:43:33,589 - DEBUG - ya.test - _save_outputs: Command (pid 3341643) nivcsw: 5
2025-10-31 08:43:33,589 - DEBUG - ya.test - _save_outputs: Command (pid 3341643) nsignals: 0
2025-10-31 08:43:33,590 - DEBUG - ya.test - _save_outputs: Command (pid 3341643) nswap: 0
2025-10-31 08:43:33,590 - DEBUG - ya.test - _save_outputs: Command (pid 3341643) nvcsw: 19
2025-10-31 08:43:33,590 - DEBUG - ya.test - _save_outputs: Command (pid 3341643) oublock: 8
2025-10-31 08:43:33,590 - DEBUG - ya.test - _save_outputs: Command (pid 3341643) stime: 0.293516
2025-10-31 08:43:33,590 - DEBUG - ya.test - _save_outputs: Command (pid 3341643) utime: 0.122959
2025-10-31 08:43:33,590 - DEBUG - ya.test - _save_outputs: Command (pid 3341643) wtime: 0.466
2025-10-31 08:43:33,591 - DEBUG - ya.test - _save_outputs: Command (pid 3341643) output:
Git info:
    Commit: 82bf8aab4f547668632ff26479ecdb9996428c61
    Branch: 
    Author: Innokentii Mokin <enjection@ya.ru>
    Summary: Merge 43cd17c8a58e28cd156b58873e20cf204c35cf0d into e300863ab69d6519229a61bcfeb54a36b8d86bd0

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-uabpkrvm6i
    Host information: 
        Linux ghrun-uabpkrvm6i 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-10-31 08:43:33,593 - DEBUG - ya.test - _save_outputs: Command (pid 3341643) errors:

2025-10-31 08:43:33,594 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 82bf8aab4f547668632ff26479ecdb9996428c61
    Branch: 
    Author: Innokentii Mokin <enjection@ya.ru>
    Summary: Merge 43cd17c8a58e28cd156b58873e20cf204c35cf0d into e300863ab69d6519229a61bcfeb54a36b8d86bd0
2025-10-31 08:43:35,447 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd
2025-10-31 08:43:35,448 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:6393', '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: 5452\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-10-31 08:43:35,449 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.6
2025-10-31 08:43:35,449 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.6
2025-10-31 08:43:35,450 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:6393', '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: 5452\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-10-31 08:43:35,451 - DEBUG - ya.test - execute: Command pid: 3345095
2025-10-31 08:43:35,884 - DEBUG - ya.test - _save_outputs: Command (pid 3345095) rc: 0
2025-10-31 08:43:35,884 - DEBUG - ya.test - _save_outputs: Command (pid 3345095) elapsed time (sec): 0.4319896697998047
2025-10-31 08:43:35,884 - DEBUG - ya.test - _save_outputs: Command (pid 3345095) idrss: 0
2025-10-31 08:43:35,884 - DEBUG - ya.test - _save_outputs: Command (pid 3345095) inblock: 0
2025-10-31 08:43:35,885 - DEBUG - ya.test - _save_outputs: Command (pid 3345095) isrss: 0
2025-10-31 08:43:35,885 - DEBUG - ya.test - _save_outputs: Command (pid 3345095) ixrss: 0
2025-10-31 08:43:35,885 - DEBUG - ya.test - _save_outputs: Command (pid 3345095) majflt: 0
2025-10-31 08:43:35,885 - DEBUG - ya.test - _save_outputs: Command (pid 3345095) maxrss: 546652
2025-10-31 08:43:35,885 - DEBUG - ya.test - _save_outputs: Command (pid 3345095) minflt: 18270
2025-10-31 08:43:35,885 - DEBUG - ya.test - _save_outputs: Command (pid 3345095) msgrcv: 0
2025-10-31 08:43:35,886 - DEBUG - ya.test - _save_outputs: Command (pid 3345095) msgsnd: 0
2025-10-31 08:43:35,886 - DEBUG - ya.test - _save_outputs: Command (pid 3345095) nivcsw: 5
2025-10-31 08:43:35,886 - DEBUG - ya.test - _save_outputs: Command (pid 3345095) nsignals: 0
2025-10-31 08:43:35,886 - DEBUG - ya.test - _save_outputs: Command (pid 3345095) nswap: 0
2025-10-31 08:43:35,886 - DEBUG - ya.test - _save_outputs: Command (pid 3345095) nvcsw: 138
2025-10-31 08:43:35,886 - DEBUG - ya.test - _save_outputs: Command (pid 3345095) oublock: 8
2025-10-31 08:43:35,887 - DEBUG - ya.test - _save_outputs: Command (pid 3345095) stime: 0.27158699999999997
2025-10-31 08:43:35,887 - DEBUG - ya.test - _save_outputs: Command (pid 3345095) utime: 0.11808099999999999
2025-10-31 08:43:35,887 - DEBUG - ya.test - _save_outputs: Command (pid 3345095) wtime: 0.433
2025-10-31 08:43:35,887 - DEBUG - ya.test - _save_outputs: Command (pid 3345095) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 4

2025-10-31 08:43:35,887 - DEBUG - ya.test - _save_outputs: Command (pid 3345095) errors:

2025-10-31 08:43:35,888 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd
2025-10-31 08:43:35,889 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:6393', '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-10-31 08:43:35,889 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.7
2025-10-31 08:43:35,890 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.7
2025-10-31 08:43:35,890 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:6393', '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-10-31 08:43:35,891 - DEBUG - ya.test - execute: Command pid: 3345787
2025-10-31 08:43:36,353 - DEBUG - ya.test - _save_outputs: Command (pid 3345787) rc: 0
2025-10-31 08:43:36,353 - DEBUG - ya.test - _save_outputs: Command (pid 3345787) elapsed time (sec): 0.4610440731048584
2025-10-31 08:43:36,354 - DEBUG - ya.test - _save_outputs: Command (pid 3345787) idrss: 0
2025-10-31 08:43:36,354 - DEBUG - ya.test - _save_outputs: Command (pid 3345787) inblock: 0
2025-10-31 08:43:36,354 - DEBUG - ya.test - _save_outputs: Command (pid 3345787) isrss: 0
2025-10-31 08:43:36,354 - DEBUG - ya.test - _save_outputs: Command (pid 3345787) ixrss: 0
2025-10-31 08:43:36,354 - DEBUG - ya.test - _save_outputs: Command (pid 3345787) majflt: 0
2025-10-31 08:43:36,355 - DEBUG - ya.test - _save_outputs: Command (pid 3345787) maxrss: 546640
2025-10-31 08:43:36,355 - DEBUG - ya.test - _save_outputs: Command (pid 3345787) minflt: 18274
2025-10-31 08:43:36,355 - DEBUG - ya.test - _save_outputs: Command (pid 3345787) msgrcv: 0
2025-10-31 08:43:36,355 - DEBUG - ya.test - _save_outputs: Command (pid 3345787) msgsnd: 0
2025-10-31 08:43:36,355 - DEBUG - ya.test - _save_outputs: Command (pid 3345787) nivcsw: 6
2025-10-31 08:43:36,355 - DEBUG - ya.test - _save_outputs: Command (pid 3345787) nsignals: 0
2025-10-31 08:43:36,356 - DEBUG - ya.test - _save_outputs: Command (pid 3345787) nswap: 0
2025-10-31 08:43:36,356 - DEBUG - ya.test - _save_outputs: Command (pid 3345787) nvcsw: 141
2025-10-31 08:43:36,356 - DEBUG - ya.test - _save_outputs: Command (pid 3345787) oublock: 8
2025-10-31 08:43:36,356 - DEBUG - ya.test - _save_outputs: Command (pid 3345787) stime: 0.29264599999999996
2025-10-31 08:43:36,356 - DEBUG - ya.test - _save_outputs: Command (pid 3345787) utime: 0.126
2025-10-31 08:43:36,356 - DEBUG - ya.test - _save_outputs: Command (pid 3345787) wtime: 0.462
2025-10-31 08:43:36,357 - DEBUG - ya.test - _save_outputs: Command (pid 3345787) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-10-31 08:43:36,357 - DEBUG - ya.test - _save_outputs: Command (pid 3345787) errors:

2025-10-31 08:43:36,357 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root2: {'dynamic_storage_pool:1': 'hdd'}
2025-10-31 08:43:36,368 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-10-31 08:43:36,377 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd
2025-10-31 08:43:36,377 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/24128
2025-10-31 08:43:36,378 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/23072
2025-10-31 08:43:36,378 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/16202
2025-10-31 08:43:36,378 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/29198
2025-10-31 08:43:36,378 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/16494
2025-10-31 08:43:36,379 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/restore_cluster/kikimr_configs"
2025-10-31 08:43:36,379 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:6393 --tenant=/Root2/db1 --log-file-name=/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/restore_cluster/slot_1/logfile_8be8hf4k.log --grpc-port=24128 --mon-port=23072 --ic-port=16202
2025-10-31 08:43:36,379 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/restore_cluster/kikimr_configs"
2025-10-31 08:43:36,380 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:6393 --tenant=/Root2/db1 --log-file-name=/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/restore_cluster/slot_1/logfile_8be8hf4k.log --grpc-port=24128 --mon-port=23072 --ic-port=16202
2025-10-31 08:43:36,380 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/restore_cluster/kikimr_configs/config.yaml', '--node-broker=localhost:6393', '--tenant=/Root2/db1', '--log-file-name=/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/restore_cluster/slot_1/logfile_8be8hf4k.log', '--grpc-port=24128', '--mon-port=23072', '--ic-port=16202')' in '/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/test_ydb_backup.py.TestDatabaseBackupRestore.test_database_backup_restore/restore_cluster/slot_1' (no wait)
2025-10-31 08:43:36,382 - DEBUG - ya.test - execute: Command pid: 3346413
2025-10-31 08:43:36,382 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:24128/1
2025-10-31 08:43:36,384 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.8
2025-10-31 08:43:36,385 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.8
2025-10-31 08:43:36,385 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-10-31 08:43:36,386 - DEBUG - ya.test - execute: Command pid: 3346433
2025-10-31 08:43:36,751 - DEBUG - ya.test - _save_outputs: Command (pid 3346433) rc: 0
2025-10-31 08:43:36,752 - DEBUG - ya.test - _save_outputs: Command (pid 3346433) elapsed time (sec): 0.36463093757629395
2025-10-31 08:43:36,752 - DEBUG - ya.test - _save_outputs: Command (pid 3346433) idrss: 0
2025-10-31 08:43:36,752 - DEBUG - ya.test - _save_outputs: Command (pid 3346433) inblock: 0
2025-10-31 08:43:36,752 - DEBUG - ya.test - _save_outputs: Command (pid 3346433) isrss: 0
2025-10-31 08:43:36,753 - DEBUG - ya.test - _save_outputs: Command (pid 3346433) ixrss: 0
2025-10-31 08:43:36,753 - DEBUG - ya.test - _save_outputs: Command (pid 3346433) majflt: 0
2025-10-31 08:43:36,753 - DEBUG - ya.test - _save_outputs: Command (pid 3346433) maxrss: 538184
2025-10-31 08:43:36,753 - DEBUG - ya.test - _save_outputs: Command (pid 3346433) minflt: 16130
2025-10-31 08:43:36,753 - DEBUG - ya.test - _save_outputs: Command (pid 3346433) msgrcv: 0
2025-10-31 08:43:36,753 - DEBUG - ya.test - _save_outputs: Command (pid 3346433) msgsnd: 0
2025-10-31 08:43:36,753 - DEBUG - ya.test - _save_outputs: Command (pid 3346433) nivcsw: 3
2025-10-31 08:43:36,754 - DEBUG - ya.test - _save_outputs: Command (pid 3346433) nsignals: 0
2025-10-31 08:43:36,754 - DEBUG - ya.test - _save_outputs: Command (pid 3346433) nswap: 0
2025-10-31 08:43:36,754 - DEBUG - ya.test - _save_outputs: Command (pid 3346433) nvcsw: 13
2025-10-31 08:43:36,754 - DEBUG - ya.test - _save_outputs: Command (pid 3346433) oublock: 8
2025-10-31 08:43:36,754 - DEBUG - ya.test - _save_outputs: Command (pid 3346433) stime: 0.213696
2025-10-31 08:43:36,754 - DEBUG - ya.test - _save_outputs: Command (pid 3346433) utime: 0.102891
2025-10-31 08:43:36,755 - DEBUG - ya.test - _save_outputs: Command (pid 3346433) wtime: 0.366
2025-10-31 08:43:36,755 - DEBUG - ya.test - _save_outputs: Command (pid 3346433) output:
Git info:
    Commit: 82bf8aab4f547668632ff26479ecdb9996428c61
    Branch: 
    Author: Innokentii Mokin <enjection@ya.ru>
    Summary: Merge 43cd17c8a58e28cd156b58873e20cf204c35cf0d into e300863ab69d6519229a61bcfeb54a36b8d86bd0

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-uabpkrvm6i
    Host information: 
        Linux ghrun-uabpkrvm6i 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-10-31 08:43:36,755 - DEBUG - ya.test - _save_outputs: Command (pid 3346433) errors:

2025-10-31 08:43:36,755 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 82bf8aab4f547668632ff26479ecdb9996428c61
    Branch: 
    Author: Innokentii Mokin <enjection@ya.ru>
    Summary: Merge 43cd17c8a58e28cd156b58873e20cf204c35cf0d into e300863ab69d6519229a61bcfeb54a36b8d86bd0
2025-10-31 08:43:36,756 - 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-10-31 08:43:36,760 - 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-10-31 08:43:36,761 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_ydb_backup.py::TestDatabaseBackupRestore, test_name: test_database_backup_restore)
2025-10-31 08:43:36,765 - DEBUG - ydb.table.SessionPool - subscribe: Active session queue is empty, subscribe waiter for a session
2025-10-31 08:43:36,766 - DEBUG - ydb.table.SessionPool - subscribe: Subscribe waiter <Future at 0x7f388fae54b0 state=pending>
2025-10-31 08:43:36,766 - DEBUG - ydb.table.SessionPool - subscribe: Session pool is not large enough (active_count < size: 0 < 100). will create a new session.
2025-10-31 08:43:36,767 - DEBUG - ydb.table.SessionPool - _create: Created session <ydb.table.Session object at 0x7f388fae4e20>
2025-10-31 08:43:36,767 - DEBUG - ydb.table.SessionPool - _prepare: Preparing session <ydb.table.Session object at 0x7f388fae4e20>
2025-10-31 08:43:36,768 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, f6077bd8-6cfc-4a76-8f78-63d88f7677db, ghrun-uabpkrvm6i.auto.internal:11193): creating call state
2025-10-31 08:43:36,768 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, f6077bd8-6cfc-4a76-8f78-63d88f7677db, ghrun-uabpkrvm6i.auto.internal:11193): request = { operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-10-31 08:43:36,771 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, f6077bd8-6cfc-4a76-8f78-63d88f7677db, ghrun-uabpkrvm6i.auto.internal:11193): on response callback started
2025-10-31 08:43:36,771 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:43:36,772 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, f6077bd8-6cfc-4a76-8f78-63d88f7677db, ghrun-uabpkrvm6i.auto.internal:11193): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=50000&id=YTk5ZjNkY2UtNTJkZjZlYjYtMTZmZDVkOGEtMTliYTY2Nw==" } } } }
2025-10-31 08:43:36,772 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 9b5cf909-7e42-400a-a8eb-2c43278b401b, localhost:6393): creating call state
2025-10-31 08:43:36,773 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f388fae4e20>
2025-10-31 08:43:36,773 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 9b5cf909-7e42-400a-a8eb-2c43278b401b, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:43:36,775 - DEBUG - ydb.table.SessionPool - put: Replying to waiter with a session <ydb.table.Session object at 0x7f388fae4e20>
2025-10-31 08:43:36,775 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, a7963b72-4fdb-4077-b85a-bb931099c9aa, ghrun-uabpkrvm6i.auto.internal:11193): creating call state
2025-10-31 08:43:36,776 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, f6077bd8-6cfc-4a76-8f78-63d88f7677db, ghrun-uabpkrvm6i.auto.internal:11193): on response callback success
2025-10-31 08:43:36,777 - DEBUG - ydb.connection - _rpc_error_handler: RpcState(ListEndpoints, 9b5cf909-7e42-400a-a8eb-2c43278b401b, localhost:6393): received error, <_InactiveRpcError of RPC that terminated with:
	status = StatusCode.UNAUTHENTICATED
	details = "unauthenticated, unauthenticated, Unknown database"
	debug_error_string = "UNKNOWN:Error received from peer  {grpc_message:"unauthenticated, unauthenticated, Unknown database", grpc_status:16, created_time:"2025-10-31T08:43:36.777241747+00:00", file_line:1211, file:"/home/runner/actions_runner/_work/ydb/ydb/contrib/libs/grpc/src/core/lib/surface/call.cc"}"
>
2025-10-31 08:43:36,778 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, a7963b72-4fdb-4077-b85a-bb931099c9aa, ghrun-uabpkrvm6i.auto.internal:11193): request = { session_id: "ydb://session/3?node_id=50000&id=YTk5ZjNkY2UtNTJkZjZlYjYtMTZmZDVkOGEtMTliYTY2Nw==" yql_text: "CREATE GROUP people" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 08:43:36,781 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 unauthenticated, unauthenticated, Unknown database
2025-10-31 08:43:36,783 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:43:36,791 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, a7963b72-4fdb-4077-b85a-bb931099c9aa, ghrun-uabpkrvm6i.auto.internal:11193): response = { operation { ready: true status: SUCCESS } }
2025-10-31 08:43:36,791 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, 5c66de2a-a98f-4eb8-8c03-240ba3a57584, ghrun-uabpkrvm6i.auto.internal:11193): creating call state
2025-10-31 08:43:36,792 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, 5c66de2a-a98f-4eb8-8c03-240ba3a57584, ghrun-uabpkrvm6i.auto.internal:11193): request = { session_id: "ydb://session/3?node_id=50000&id=YTk5ZjNkY2UtNTJkZjZlYjYtMTZmZDVkOGEtMTliYTY2Nw==" yql_text: "CREATE USER alice PASSWORD \'1234\'" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 08:43:36,803 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, 5c66de2a-a98f-4eb8-8c03-240ba3a57584, ghrun-uabpkrvm6i.auto.internal:11193): response = { operation { ready: true status: SUCCESS } }
2025-10-31 08:43:36,804 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, 0a408a02-edba-46fc-bbef-8a3b4a2fa46a, ghrun-uabpkrvm6i.auto.internal:11193): creating call state
2025-10-31 08:43:36,804 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, 0a408a02-edba-46fc-bbef-8a3b4a2fa46a, ghrun-uabpkrvm6i.auto.internal:11193): request = { session_id: "ydb://session/3?node_id=50000&id=YTk5ZjNkY2UtNTJkZjZlYjYtMTZmZDVkOGEtMTliYTY2Nw==" yql_text: "CREATE USER bob PASSWORD \'1234\'" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 08:43:36,814 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, 0a408a02-edba-46fc-bbef-8a3b4a2fa46a, ghrun-uabpkrvm6i.auto.internal:11193): response = { operation { ready: true status: SUCCESS } }
2025-10-31 08:43:36,815 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, c60ccf03-5b21-49a1-98c4-8f6c17514f71, ghrun-uabpkrvm6i.auto.internal:11193): creating call state
2025-10-31 08:43:36,816 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, c60ccf03-5b21-49a1-98c4-8f6c17514f71, ghrun-uabpkrvm6i.auto.internal:11193): request = { session_id: "ydb://session/3?node_id=50000&id=YTk5ZjNkY2UtNTJkZjZlYjYtMTZmZDVkOGEtMTliYTY2Nw==" yql_text: "ALTER GROUP people ADD USER alice" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 08:43:36,824 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, c60ccf03-5b21-49a1-98c4-8f6c17514f71, ghrun-uabpkrvm6i.auto.internal:11193): response = { operation { ready: true status: SUCCESS } }
2025-10-31 08:43:36,824 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, b2beb069-9d41-43b3-8faa-c037f9844e75, ghrun-uabpkrvm6i.auto.internal:11193): creating call state
2025-10-31 08:43:36,825 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, b2beb069-9d41-43b3-8faa-c037f9844e75, ghrun-uabpkrvm6i.auto.internal:11193): request = { session_id: "ydb://session/3?node_id=50000&id=YTk5ZjNkY2UtNTJkZjZlYjYtMTZmZDVkOGEtMTliYTY2Nw==" yql_text: "ALTER GROUP people ADD USER bob" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 08:43:36,832 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, b2beb069-9d41-43b3-8faa-c037f9844e75, ghrun-uabpkrvm6i.auto.internal:11193): response = { operation { ready: true status: SUCCESS } }
2025-10-31 08:43:36,833 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, 39ede48d-8784-44da-9c59-5b10eb1adae4, ghrun-uabpkrvm6i.auto.internal:11193): creating call state
2025-10-31 08:43:36,833 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, 39ede48d-8784-44da-9c59-5b10eb1adae4, ghrun-uabpkrvm6i.auto.internal:11193): request = { session_id: "ydb://session/3?node_id=50000&id=YTk5ZjNkY2UtNTJkZjZlYjYtMTZmZDVkOGEtMTliYTY2Nw==" yql_text: "CREATE GROUP dbadmins" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 08:43:36,841 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, 39ede48d-8784-44da-9c59-5b10eb1adae4, ghrun-uabpkrvm6i.auto.internal:11193): response = { operation { ready: true status: SUCCESS } }
2025-10-31 08:43:36,842 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, eebbcb25-dda1-4a3e-a039-fd4ba94a89ea, ghrun-uabpkrvm6i.auto.internal:11193): creating call state
2025-10-31 08:43:36,842 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, eebbcb25-dda1-4a3e-a039-fd4ba94a89ea, ghrun-uabpkrvm6i.auto.internal:11193): request = { session_id: "ydb://session/3?node_id=50000&id=YTk5ZjNkY2UtNTJkZjZlYjYtMTZmZDVkOGEtMTliYTY2Nw==" yql_text: "CREATE USER dbadmin1" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 08:43:36,853 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, eebbcb25-dda1-4a3e-a039-fd4ba94a89ea, ghrun-uabpkrvm6i.auto.internal:11193): response = { operation { ready: true status: SUCCESS } }
2025-10-31 08:43:36,854 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, a1de7ced-addd-49ba-a588-35b42fec4eb4, ghrun-uabpkrvm6i.auto.internal:11193): creating call state
2025-10-31 08:43:36,855 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, a1de7ced-addd-49ba-a588-35b42fec4eb4, ghrun-uabpkrvm6i.auto.internal:11193): request = { session_id: "ydb://session/3?node_id=50000&id=YTk5ZjNkY2UtNTJkZjZlYjYtMTZmZDVkOGEtMTliYTY2Nw==" yql_text: "CREATE USER dbadmin2 PASSWORD \'1234\'" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 08:43:36,866 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, a1de7ced-addd-49ba-a588-35b42fec4eb4, ghrun-uabpkrvm6i.auto.internal:11193): response = { operation { ready: true status: SUCCESS } }
2025-10-31 08:43:36,866 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, 76bbd49a-e77e-40a4-b695-dd6bc1ab8e03, ghrun-uabpkrvm6i.auto.internal:11193): creating call state
2025-10-31 08:43:36,867 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, 76bbd49a-e77e-40a4-b695-dd6bc1ab8e03, ghrun-uabpkrvm6i.auto.internal:11193): request = { session_id: "ydb://session/3?node_id=50000&id=YTk5ZjNkY2UtNTJkZjZlYjYtMTZmZDVkOGEtMTliYTY2Nw==" yql_text: "ALTER GROUP dbadmins ADD USER dbadmin1" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 08:43:36,877 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, 76bbd49a-e77e-40a4-b695-dd6bc1ab8e03, ghrun-uabpkrvm6i.auto.internal:11193): response = { operation { ready: true status: SUCCESS } }
2025-10-31 08:43:36,878 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, ba4260d2-fbe8-43a3-87e7-3165ec9f0fac, ghrun-uabpkrvm6i.auto.internal:11193): creating call state
2025-10-31 08:43:36,878 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, ba4260d2-fbe8-43a3-87e7-3165ec9f0fac, ghrun-uabpkrvm6i.auto.internal:11193): request = { session_id: "ydb://session/3?node_id=50000&id=YTk5ZjNkY2UtNTJkZjZlYjYtMTZmZDVkOGEtMTliYTY2Nw==" yql_text: "ALTER GROUP dbadmins ADD USER dbadmin2" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 08:43:36,887 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, ba4260d2-fbe8-43a3-87e7-3165ec9f0fac, ghrun-uabpkrvm6i.auto.internal:11193): response = { operation { ready: true status: SUCCESS } }
2025-10-31 08:43:36,887 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, 43ccde72-4ebc-43f2-b22a-823ce1dc94f7, ghrun-uabpkrvm6i.auto.internal:11193): creating call state
2025-10-31 08:43:36,888 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, 43ccde72-4ebc-43f2-b22a-823ce1dc94f7, ghrun-uabpkrvm6i.auto.internal:11193): request = { session_id: "ydb://session/3?node_id=50000&id=YTk5ZjNkY2UtNTJkZjZlYjYtMTZmZDVkOGEtMTliYTY2Nw==" yql_text: "GRANT \"ydb.generic.use\" on `/Root/db1` TO dbadmins" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 08:43:36,898 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, 43ccde72-4ebc-43f2-b22a-823ce1dc94f7, ghrun-uabpkrvm6i.auto.internal:11193): response = { operation { ready: true status: SUCCESS } }
2025-10-31 08:43:36,899 - DEBUG - ydb.connection - _prepare_call: RpcState(ModifyPermissions, 092ca4e2-4b48-449c-bc14-1a96be5e6498, ghrun-uabpkrvm6i.auto.internal:11193): creating call state
2025-10-31 08:43:36,899 - DEBUG - ydb.connection - _log_request: RpcState(ModifyPermissions, 092ca4e2-4b48-449c-bc14-1a96be5e6498, ghrun-uabpkrvm6i.auto.internal:11193): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/db1" actions { change_owner: "dbadmins" } }
2025-10-31 08:43:36,904 - DEBUG - ydb.connection - _log_response: RpcState(ModifyPermissions, 092ca4e2-4b48-449c-bc14-1a96be5e6498, ghrun-uabpkrvm6i.auto.internal:11193): response = { operation { ready: true status: SUCCESS } }
2025-10-31 08:43:36,905 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f388fae4e20>
2025-10-31 08:43:36,905 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 6116ba8c-e1ff-4600-aee9-f2a1334a7e38, ghrun-uabpkrvm6i.auto.internal:11193): creating call state
2025-10-31 08:43:36,906 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 6116ba8c-e1ff-4600-aee9-f2a1334a7e38, ghrun-uabpkrvm6i.auto.internal:11193): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 08:43:36,908 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 6116ba8c-e1ff-4600-aee9-f2a1334a7e38, ghrun-uabpkrvm6i.auto.internal:11193): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=50000&id=ODc2YWM1OGYtYTQxMzczYzMtZmE4MmE3ODUtYmRhYTMwY2I=" } } } }
2025-10-31 08:43:36,909 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 644ecf11-0b31-4f8a-89fa-a6e983c60873, ghrun-uabpkrvm6i.auto.internal:11193): creating call state
2025-10-31 08:43:36,910 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 644ecf11-0b31-4f8a-89fa-a6e983c60873, ghrun-uabpkrvm6i.auto.internal:11193): request = { session_id: "ydb://session/3?node_id=50000&id=ODc2YWM1OGYtYTQxMzczYzMtZmE4MmE3ODUtYmRhYTMwY2I=" path: "/Root/db1/table" columns { name: "id" type { optional_type { item { type_id: UINT32 } } } } columns { name: "number" type { optional_type { item { type_id: UINT64 } } } } columns { name: "string" type { optional_type { item { type_id: STRING } } } } columns { name: "fixed_point" type { optional_type { item { decimal_type { precision: 22 scale: 9 } } } } } primary_key: "id" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 08:43:36,943 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 644ecf11-0b31-4f8a-89fa-a6e983c60873, ghrun-uabpkrvm6i.auto.internal:11193): response = { operation { ready: true status: SUCCESS } }
2025-10-31 08:43:36,945 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 97d1ae1c-4ffc-47d8-a833-80f1ff41d59d, ghrun-uabpkrvm6i.auto.internal:11193): creating call state
2025-10-31 08:43:36,945 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 97d1ae1c-4ffc-47d8-a833-80f1ff41d59d, ghrun-uabpkrvm6i.auto.internal:11193): request = { session_id: "ydb://session/3?node_id=50000&id=ODc2YWM1OGYtYTQxMzczYzMtZmE4MmE3ODUtYmRhYTMwY2I=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "\n        PRAGMA TablePathPrefix(\"/Root/db1\");\n        UPSERT INTO table (`id`, `number`, `string`, `fixed_point`) VALUES (2, 6,  \"pen\",       CAST(\"2.4\" AS Decimal(22,9)));\n        UPSERT INTO table (`id`,           `string`, `fixed_point`) VALUES (3,     \"pineapple\", CAST(\"3.5\" AS Decimal(22,9)));\n        UPSERT INTO table (`id`, `number`,          `fixed_point`) VALUES (5, 12,              CAST(\"512.6\" AS Decimal(22,9)));\n        UPSERT INTO table (`id`, `number`, `string`             ) VALUES (7, 15, \"pen\"          );\n        " } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 08:43:36,984 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 97d1ae1c-4ffc-47d8-a833-80f1ff41d59d, ghrun-uabpkrvm6i.auto.internal:11193): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-10-31 08:43:36,985 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydb/ydb
2025-10-31 08:43:36,985 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out
2025-10-31 08:43:36,986 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err
2025-10-31 08:43:36,986 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydb/ydb', '--verbose', '--endpoint', 'grpc://localhost:11298', '--database', '/Root', 'admin', 'cluster', 'dump', '--output', '/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/cluster_backup']' in 'None' (waiting)
2025-10-31 08:43:36,986 - DEBUG - ya.test - execute: Command pid: 3347128
2025-10-31 08:43:37,327 - DEBUG - ya.test - _save_outputs: Command (pid 3347128) rc: 0
2025-10-31 08:43:37,327 - DEBUG - ya.test - _save_outputs: Command (pid 3347128) elapsed time (sec): 0.3395423889160156
2025-10-31 08:43:37,327 - DEBUG - ya.test - _save_outputs: Command (pid 3347128) idrss: 0
2025-10-31 08:43:37,328 - DEBUG - ya.test - _save_outputs: Command (pid 3347128) inblock: 0
2025-10-31 08:43:37,328 - DEBUG - ya.test - _save_outputs: Command (pid 3347128) isrss: 0
2025-10-31 08:43:37,328 - DEBUG - ya.test - _save_outputs: Command (pid 3347128) ixrss: 0
2025-10-31 08:43:37,328 - DEBUG - ya.test - _save_outputs: Command (pid 3347128) majflt: 0
2025-10-31 08:43:37,328 - DEBUG - ya.test - _save_outputs: Command (pid 3347128) maxrss: 165604
2025-10-31 08:43:37,328 - DEBUG - ya.test - _save_outputs: Command (pid 3347128) minflt: 3636
2025-10-31 08:43:37,329 - DEBUG - ya.test - _save_outputs: Command (pid 3347128) msgrcv: 0
2025-10-31 08:43:37,329 - DEBUG - ya.test - _save_outputs: Command (pid 3347128) msgsnd: 0
2025-10-31 08:43:37,329 - DEBUG - ya.test - _save_outputs: Command (pid 3347128) nivcsw: 4
2025-10-31 08:43:37,329 - DEBUG - ya.test - _save_outputs: Command (pid 3347128) nsignals: 0
2025-10-31 08:43:37,329 - DEBUG - ya.test - _save_outputs: Command (pid 3347128) nswap: 0
2025-10-31 08:43:37,329 - DEBUG - ya.test - _save_outputs: Command (pid 3347128) nvcsw: 369
2025-10-31 08:43:37,330 - DEBUG - ya.test - _save_outputs: Command (pid 3347128) oublock: 72
2025-10-31 08:43:37,330 - DEBUG - ya.test - _save_outputs: Command (pid 3347128) stime: 0.042214
2025-10-31 08:43:37,330 - DEBUG - ya.test - _save_outputs: Command (pid 3347128) utime: 0.063322
2025-10-31 08:43:37,330 - DEBUG - ya.test - _save_outputs: Command (pid 3347128) wtime: 0.34
2025-10-31 08:43:37,330 - DEBUG - ya.test - _save_outputs: Command (pid 3347128) output:

2025-10-31 08:43:37,330 - DEBUG - ya.test - _save_outputs: Command (pid 3347128) errors:
Using auth method "token" from YDB_TOKEN enviroment variable
2025-10-31T08:43:37.090786Z :INFO: Backup cluster to "/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/cluster_backup"
2025-10-31T08:43:37.098334Z :INFO: Backup cluster root "/Root" to /home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/cluster_backup
2025-10-31T08:43:37.142538Z :DEBUG: Write users into "/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/cluster_backup/create_user.sql"
2025-10-31T08:43:37.165353Z :DEBUG: Write groups into "/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/cluster_backup/create_group.sql"
2025-10-31T08:43:37.191994Z :DEBUG: Write group members into "/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/cluster_backup/alter_group.sql"
2025-10-31T08:43:37.195595Z :DEBUG: Write ACL into "/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/cluster_backup/permissions.pb"
2025-10-31T08:43:37.203731Z :INFO: Backup database "/Root/db1" to "/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/cluster_backup/Root/db1"
2025-10-31T08:43:37.211503Z :DEBUG: Write database description into "/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/cluster_backup/Root/db1/database.pb"
2025-10-31T08:43:37.265239Z :DEBUG: Write users into "/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/cluster_backup/Root/db1/create_user.sql"
2025-10-31T08:43:37.287238Z :DEBUG: Write groups into "/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/cluster_backup/Root/db1/create_group.sql"
2025-10-31T08:43:37.311204Z :DEBUG: Write group members into "/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/cluster_backup/Root/db1/alter_group.sql"
2025-10-31T08:43:37.313992Z :DEBUG: Write ACL into "/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/cluster_backup/Root/db1/permissions.pb"
2025-10-31T08:43:37.314885Z :INFO: Backup cluster is completed successfully

2025-10-31 08:43:37,330 - DEBUG - __tests__.test_ydb_backup - fs_recursive_list: prefix# /home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/cluster_backup path# 
2025-10-31 08:43:37,331 - DEBUG - __tests__.test_ydb_backup - fs_recursive_list: prefix# /home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/cluster_backup path# Root
2025-10-31 08:43:37,331 - DEBUG - __tests__.test_ydb_backup - fs_recursive_list: prefix# /home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/cluster_backup path# Root/db1
2025-10-31 08:43:37,331 - DEBUG - __tests__.test_ydb_backup - create_backup: std_out:

2025-10-31 08:43:37,331 - DEBUG - __tests__.test_ydb_backup - create_backup: fs_recursive_list(backup_files_dir)# ['permissions.pb', 'create_user.sql', 'alter_group.sql', 'create_group.sql', 'Root/db1/permissions.pb', 'Root/db1/create_user.sql', 'Root/db1/database.pb', 'Root/db1/alter_group.sql', 'Root/db1/create_group.sql']
2025-10-31 08:43:37,331 - DEBUG - __tests__.test_ydb_backup - create_backup: expected_files# ['permissions.pb', 'create_user.sql', 'create_group.sql', 'alter_group.sql', 'Root/db1/database.pb', 'Root/db1/permissions.pb', 'Root/db1/create_user.sql', 'Root/db1/create_group.sql', 'Root/db1/alter_group.sql']
2025-10-31 08:43:37,332 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydb/ydb
2025-10-31 08:43:37,332 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.0
2025-10-31 08:43:37,333 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.0
2025-10-31 08:43:37,333 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydb/ydb', '--verbose', '--endpoint', 'grpc://localhost:11298', '--database', '/Root/db1', '--user', 'dbadmin1', '--no-password', 'admin', 'database', 'dump', '--output', '/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/database_backup']' in 'None' (waiting)
2025-10-31 08:43:37,334 - DEBUG - ya.test - execute: Command pid: 3347664
2025-10-31 08:43:37,803 - DEBUG - ya.test - _save_outputs: Command (pid 3347664) rc: 0
2025-10-31 08:43:37,803 - DEBUG - ya.test - _save_outputs: Command (pid 3347664) elapsed time (sec): 0.46747660636901855
2025-10-31 08:43:37,804 - DEBUG - ya.test - _save_outputs: Command (pid 3347664) idrss: 0
2025-10-31 08:43:37,804 - DEBUG - ya.test - _save_outputs: Command (pid 3347664) inblock: 0
2025-10-31 08:43:37,804 - DEBUG - ya.test - _save_outputs: Command (pid 3347664) isrss: 0
2025-10-31 08:43:37,805 - DEBUG - ya.test - _save_outputs: Command (pid 3347664) ixrss: 0
2025-10-31 08:43:37,806 - DEBUG - ya.test - _save_outputs: Command (pid 3347664) majflt: 0
2025-10-31 08:43:37,806 - DEBUG - ya.test - _save_outputs: Command (pid 3347664) maxrss: 165604
2025-10-31 08:43:37,806 - DEBUG - ya.test - _save_outputs: Command (pid 3347664) minflt: 3646
2025-10-31 08:43:37,806 - DEBUG - ya.test - _save_outputs: Command (pid 3347664) msgrcv: 0
2025-10-31 08:43:37,806 - DEBUG - ya.test - _save_outputs: Command (pid 3347664) msgsnd: 0
2025-10-31 08:43:37,806 - DEBUG - ya.test - _save_outputs: Command (pid 3347664) nivcsw: 2
2025-10-31 08:43:37,807 - DEBUG - ya.test - _save_outputs: Command (pid 3347664) nsignals: 0
2025-10-31 08:43:37,808 - DEBUG - ya.test - _save_outputs: Command (pid 3347664) nswap: 0
2025-10-31 08:43:37,808 - DEBUG - ya.test - _save_outputs: Command (pid 3347664) nvcsw: 361
2025-10-31 08:43:37,808 - DEBUG - ya.test - _save_outputs: Command (pid 3347664) oublock: 72
2025-10-31 08:43:37,808 - DEBUG - ya.test - _save_outputs: Command (pid 3347664) stime: 0.039522
2025-10-31 08:43:37,809 - DEBUG - ya.test - _save_outputs: Command (pid 3347664) utime: 0.067187
2025-10-31 08:43:37,809 - DEBUG - ya.test - _save_outputs: Command (pid 3347664) wtime: 0.469
2025-10-31 08:43:37,809 - DEBUG - ya.test - _save_outputs: Command (pid 3347664) output:

2025-10-31 08:43:37,809 - DEBUG - ya.test - _save_outputs: Command (pid 3347664) errors:
Using auth method "static-credentials" from explicit command line option --user with username "dbadmin1"
Using no password due to explicit --no-password option
2025-10-31T08:43:37.543091Z :INFO: Backup database "/Root/db1" to "/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/database_backup"
2025-10-31T08:43:37.551991Z :DEBUG: Write database description into "/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/database_backup/database.pb"
2025-10-31T08:43:37.581854Z :DEBUG: Write users into "/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/database_backup/create_user.sql"
2025-10-31T08:43:37.606951Z :DEBUG: Write groups into "/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/database_backup/create_group.sql"
2025-10-31T08:43:37.629048Z :DEBUG: Write group members into "/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/database_backup/alter_group.sql"
2025-10-31T08:43:37.632117Z :DEBUG: Write ACL into "/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/database_backup/permissions.pb"
2025-10-31T08:43:37.632236Z :INFO: Create temporary directory "/Root/db1/~backup_20251031T084337" in database
2025-10-31T08:43:37.643725Z :DEBUG: Process "/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/database_backup/table"
2025-10-31T08:43:37.645692Z :INFO: Copy tables: { src: "/Root/db1/table", dst: "/Root/db1/~backup_20251031T084337/table" }
2025-10-31T08:43:37.686547Z :DEBUG: Describe table "/Root/db1/table"
2025-10-31T08:43:37.690437Z :DEBUG: Describe table "/Root/db1/~backup_20251031T084337/table"
2025-10-31T08:43:37.694335Z :INFO: Backup table "/Root/db1/~backup_20251031T084337/table" to "/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/database_backup/table"
2025-10-31T08:43:37.694948Z :DEBUG: Write scheme into "/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/database_backup/table/scheme.pb"
2025-10-31T08:43:37.697202Z :DEBUG: Write ACL into "/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/database_backup/table/permissions.pb"
2025-10-31T08:43:37.697298Z :DEBUG: Read table "/Root/db1/~backup_20251031T084337/table"
2025-10-31T08:43:37.752527Z :DEBUG: Write data into "/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/database_backup/table/data_00.csv"
2025-10-31T08:43:37.753814Z :DEBUG: Drop table "/Root/db1/~backup_20251031T084337/table"
2025-10-31T08:43:37.771087Z :INFO: Remove temporary directory "/Root/db1/~backup_20251031T084337" in database
2025-10-31T08:43:37.784880Z :INFO: Backup database "/Root/db1" is completed successfully

2025-10-31 08:43:37,809 - DEBUG - __tests__.test_ydb_backup - fs_recursive_list: prefix# /home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/database_backup path# 
2025-10-31 08:43:37,810 - DEBUG - __tests__.test_ydb_backup - fs_recursive_list: prefix# /home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/database_backup path# table
2025-10-31 08:43:37,810 - DEBUG - __tests__.test_ydb_backup - create_backup: std_out:

2025-10-31 08:43:37,810 - DEBUG - __tests__.test_ydb_backup - create_backup: fs_recursive_list(backup_files_dir)# ['table/permissions.pb', 'table/data_00.csv', 'table/scheme.pb', 'permissions.pb', 'create_user.sql', 'database.pb', 'alter_group.sql', 'create_group.sql']
2025-10-31 08:43:37,810 - DEBUG - __tests__.test_ydb_backup - create_backup: expected_files# ['database.pb', 'permissions.pb', 'create_user.sql', 'create_group.sql', 'alter_group.sql', 'table/scheme.pb', 'table/permissions.pb', 'table/data_00.csv']
2025-10-31 08:43:37,811 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydb/ydb
2025-10-31 08:43:37,811 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.1
2025-10-31 08:43:37,812 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.1
2025-10-31 08:43:37,812 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydb/ydb', '--verbose', '--assume-yes', '--endpoint', 'grpc://localhost:6393', '--database', '/Root2', 'admin', 'cluster', 'restore', '--input', '/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/cluster_backup', '-w', '240s']' in 'None' (waiting)
2025-10-31 08:43:37,813 - DEBUG - ya.test - execute: Command pid: 3348408
2025-10-31 08:43:38,631 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:43:38,631 - 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-10-31 08:43:38,689 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:43:38,690 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, ebb7e356-0d5e-4e05-91a6-5c83f67d087c, localhost:6393): creating call state
2025-10-31 08:43:38,690 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, ebb7e356-0d5e-4e05-91a6-5c83f67d087c, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:43:38,692 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, ebb7e356-0d5e-4e05-91a6-5c83f67d087c, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:43:38,693 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:43:38,693 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:43:40,506 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:43:40,506 - 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-10-31 08:43:40,512 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:43:40,518 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, b9e7716c-f32f-49be-be9d-d73a5d685b43, localhost:6393): creating call state
2025-10-31 08:43:40,518 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, b9e7716c-f32f-49be-be9d-d73a5d685b43, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:43:40,520 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, b9e7716c-f32f-49be-be9d-d73a5d685b43, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:43:40,521 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:43:40,521 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:43:41,910 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:43:41,911 - 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-10-31 08:43:41,916 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:43:41,917 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 736b9299-e314-4682-84b1-44c0f3efa7e3, localhost:6393): creating call state
2025-10-31 08:43:41,917 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 736b9299-e314-4682-84b1-44c0f3efa7e3, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:43:41,919 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 736b9299-e314-4682-84b1-44c0f3efa7e3, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:43:41,920 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:43:41,920 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:43:43,323 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:43:43,324 - 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-10-31 08:43:43,329 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:43:43,330 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 6b39bbeb-3e9c-40a6-8afe-4026ef5a9860, localhost:6393): creating call state
2025-10-31 08:43:43,330 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 6b39bbeb-3e9c-40a6-8afe-4026ef5a9860, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:43:43,333 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 6b39bbeb-3e9c-40a6-8afe-4026ef5a9860, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:43:43,334 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:43:43,334 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:43:45,110 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:43:45,110 - 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-10-31 08:43:45,116 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:43:45,117 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 15c0e2c9-7cea-4ea9-a3f6-46302c5c86fc, localhost:6393): creating call state
2025-10-31 08:43:45,117 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 15c0e2c9-7cea-4ea9-a3f6-46302c5c86fc, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:43:45,119 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 15c0e2c9-7cea-4ea9-a3f6-46302c5c86fc, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:43:45,120 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:43:45,120 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:43:46,534 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:43:46,536 - 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-10-31 08:43:46,541 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:43:46,542 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 2fb1dcfb-a3b0-4b5a-a639-444e2e304391, localhost:6393): creating call state
2025-10-31 08:43:46,542 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 2fb1dcfb-a3b0-4b5a-a639-444e2e304391, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:43:46,544 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 2fb1dcfb-a3b0-4b5a-a639-444e2e304391, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:43:46,545 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:43:46,545 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:43:48,523 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:43:48,524 - 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-10-31 08:43:48,529 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:43:48,530 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 10de8f2d-8b6c-4bee-b99f-5acc1853e2a8, localhost:6393): creating call state
2025-10-31 08:43:48,530 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 10de8f2d-8b6c-4bee-b99f-5acc1853e2a8, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:43:48,533 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 10de8f2d-8b6c-4bee-b99f-5acc1853e2a8, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:43:48,534 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:43:48,534 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:43:50,134 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:43:50,135 - 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-10-31 08:43:50,142 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:43:50,142 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 17333ee3-a182-424e-bf0f-deeb13bb064f, localhost:6393): creating call state
2025-10-31 08:43:50,143 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 17333ee3-a182-424e-bf0f-deeb13bb064f, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:43:50,145 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 17333ee3-a182-424e-bf0f-deeb13bb064f, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:43:50,145 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:43:50,146 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:43:51,693 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:43:51,694 - 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-10-31 08:43:51,699 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:43:51,699 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 24eb272c-3bff-4a19-8aa7-9703cd056529, localhost:6393): creating call state
2025-10-31 08:43:51,700 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 24eb272c-3bff-4a19-8aa7-9703cd056529, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:43:51,702 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 24eb272c-3bff-4a19-8aa7-9703cd056529, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:43:51,702 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:43:51,703 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:43:53,001 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:43:53,001 - 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-10-31 08:43:53,007 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:43:53,008 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 0e289fc2-f0d7-496a-b81b-1a43b745280a, localhost:6393): creating call state
2025-10-31 08:43:53,009 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 0e289fc2-f0d7-496a-b81b-1a43b745280a, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:43:53,011 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 0e289fc2-f0d7-496a-b81b-1a43b745280a, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:43:53,026 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:43:53,030 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:43:54,527 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:43:54,528 - 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-10-31 08:43:54,534 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:43:54,535 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 8fb4cfd2-56d1-46dc-9eaa-8d65bb0eaf72, localhost:6393): creating call state
2025-10-31 08:43:54,535 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 8fb4cfd2-56d1-46dc-9eaa-8d65bb0eaf72, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:43:54,537 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 8fb4cfd2-56d1-46dc-9eaa-8d65bb0eaf72, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:43:54,538 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:43:54,538 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:43:56,030 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:43:56,030 - 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-10-31 08:43:56,036 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:43:56,039 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 24f58938-bcbb-487f-a25f-5fe8c3a501c6, localhost:6393): creating call state
2025-10-31 08:43:56,039 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 24f58938-bcbb-487f-a25f-5fe8c3a501c6, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:43:56,041 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 24f58938-bcbb-487f-a25f-5fe8c3a501c6, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:43:56,042 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:43:56,043 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:43:57,458 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:43:57,458 - 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-10-31 08:43:57,468 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:43:57,469 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 2537a7c0-d76a-4577-a452-76dd89011525, localhost:6393): creating call state
2025-10-31 08:43:57,469 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 2537a7c0-d76a-4577-a452-76dd89011525, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:43:57,472 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 2537a7c0-d76a-4577-a452-76dd89011525, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:43:57,472 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:43:57,473 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:43:58,964 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:43:58,965 - 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-10-31 08:43:58,973 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:43:58,974 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 373a685f-800c-403b-ada6-e859ffa413f4, localhost:6393): creating call state
2025-10-31 08:43:58,974 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 373a685f-800c-403b-ada6-e859ffa413f4, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:43:58,980 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 373a685f-800c-403b-ada6-e859ffa413f4, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:43:58,981 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:43:58,981 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:44:00,957 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:44:00,963 - 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-10-31 08:44:00,968 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:44:00,969 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, ae6a7a33-73f5-484f-894e-8602e79fdd37, localhost:6393): creating call state
2025-10-31 08:44:00,969 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, ae6a7a33-73f5-484f-894e-8602e79fdd37, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:44:00,971 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, ae6a7a33-73f5-484f-894e-8602e79fdd37, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:44:00,972 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:44:00,972 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:44:02,730 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:44:02,733 - 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-10-31 08:44:02,739 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:44:02,742 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, d1008cdd-db60-478d-b688-df6fe0c16f6d, localhost:6393): creating call state
2025-10-31 08:44:02,743 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, d1008cdd-db60-478d-b688-df6fe0c16f6d, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:44:02,748 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, d1008cdd-db60-478d-b688-df6fe0c16f6d, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:44:02,749 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:44:02,750 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:44:04,885 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:44:04,886 - 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-10-31 08:44:04,892 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:44:04,892 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 5cab85d7-405f-4963-8738-4508767453a2, localhost:6393): creating call state
2025-10-31 08:44:04,893 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 5cab85d7-405f-4963-8738-4508767453a2, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:44:04,895 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 5cab85d7-405f-4963-8738-4508767453a2, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:44:04,896 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:44:04,896 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:44:06,155 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:44:06,157 - 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-10-31 08:44:06,163 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:44:06,164 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, ed02cfb9-8edc-49ea-8fa6-b7a07ded00f1, localhost:6393): creating call state
2025-10-31 08:44:06,164 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, ed02cfb9-8edc-49ea-8fa6-b7a07ded00f1, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:44:06,167 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, ed02cfb9-8edc-49ea-8fa6-b7a07ded00f1, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:44:06,168 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:44:06,168 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:44:07,411 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:44:07,413 - 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-10-31 08:44:07,420 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:44:07,421 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, c4ebc138-5671-46cc-a4f3-88240e283c12, localhost:6393): creating call state
2025-10-31 08:44:07,423 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, c4ebc138-5671-46cc-a4f3-88240e283c12, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:44:07,428 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, c4ebc138-5671-46cc-a4f3-88240e283c12, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:44:07,429 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:44:07,430 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:44:08,823 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:44:08,824 - 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-10-31 08:44:08,829 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:44:08,830 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, f2494382-a2f1-4e79-a5ba-985c088ea9da, localhost:6393): creating call state
2025-10-31 08:44:08,831 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, f2494382-a2f1-4e79-a5ba-985c088ea9da, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:44:08,834 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, f2494382-a2f1-4e79-a5ba-985c088ea9da, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:44:08,834 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:44:08,836 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:44:10,905 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:44:10,906 - 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-10-31 08:44:10,921 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:44:10,943 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 691cf305-c52c-4d44-ac61-e9b2955c1b7b, localhost:6393): creating call state
2025-10-31 08:44:10,943 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 691cf305-c52c-4d44-ac61-e9b2955c1b7b, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:44:10,959 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 691cf305-c52c-4d44-ac61-e9b2955c1b7b, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:44:10,969 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:44:10,970 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:44:12,545 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:44:12,549 - 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-10-31 08:44:12,555 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:44:12,556 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, b070d1ff-2aa0-454c-844a-9ac8657f1a40, localhost:6393): creating call state
2025-10-31 08:44:12,556 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, b070d1ff-2aa0-454c-844a-9ac8657f1a40, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:44:12,560 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, b070d1ff-2aa0-454c-844a-9ac8657f1a40, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:44:12,560 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:44:12,561 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:44:14,142 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:44:14,143 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-10-31 08:44:14,150 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:44:14,151 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 20d5f1b6-f8e3-4b30-8239-21b445fc0238, localhost:6393): creating call state
2025-10-31 08:44:14,151 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 20d5f1b6-f8e3-4b30-8239-21b445fc0238, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:44:14,156 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 20d5f1b6-f8e3-4b30-8239-21b445fc0238, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:44:14,162 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:44:14,165 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:44:15,426 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:44:15,427 - 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-10-31 08:44:15,432 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:44:15,433 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, d6dafb64-0f2a-4aff-9e12-dc009fba1412, localhost:6393): creating call state
2025-10-31 08:44:15,433 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, d6dafb64-0f2a-4aff-9e12-dc009fba1412, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:44:15,436 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, d6dafb64-0f2a-4aff-9e12-dc009fba1412, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:44:15,436 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:44:15,437 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:44:17,324 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:44:17,324 - 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-10-31 08:44:17,329 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:44:17,330 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, b5fc155d-c6c2-42c8-be23-734ff9901b62, localhost:6393): creating call state
2025-10-31 08:44:17,331 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, b5fc155d-c6c2-42c8-be23-734ff9901b62, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:44:17,333 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, b5fc155d-c6c2-42c8-be23-734ff9901b62, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:44:17,333 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:44:17,334 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:44:19,260 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:44:19,260 - 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-10-31 08:44:19,283 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:44:19,284 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 0c90eab4-39d1-4000-bd0d-40d202b79dba, localhost:6393): creating call state
2025-10-31 08:44:19,284 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 0c90eab4-39d1-4000-bd0d-40d202b79dba, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:44:19,287 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 0c90eab4-39d1-4000-bd0d-40d202b79dba, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:44:19,287 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:44:19,287 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:44:20,614 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:44:20,622 - 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-10-31 08:44:20,629 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:44:20,632 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 3d95b6ed-222a-40ad-8ed7-c07d5e86a2c7, localhost:6393): creating call state
2025-10-31 08:44:20,633 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 3d95b6ed-222a-40ad-8ed7-c07d5e86a2c7, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:44:20,636 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 3d95b6ed-222a-40ad-8ed7-c07d5e86a2c7, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:44:20,639 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:44:20,639 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:44:22,197 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:44:22,198 - 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-10-31 08:44:22,218 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:44:22,219 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, bea3c5c8-90e3-4895-8b46-436875315bbd, localhost:6393): creating call state
2025-10-31 08:44:22,219 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, bea3c5c8-90e3-4895-8b46-436875315bbd, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:44:22,253 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, bea3c5c8-90e3-4895-8b46-436875315bbd, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:44:22,253 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:44:22,259 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:44:23,767 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:44:23,767 - 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-10-31 08:44:23,788 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:44:23,809 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 99cd19ab-96a3-4d03-be71-f177e8cdb777, localhost:6393): creating call state
2025-10-31 08:44:23,810 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 99cd19ab-96a3-4d03-be71-f177e8cdb777, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:44:23,812 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 99cd19ab-96a3-4d03-be71-f177e8cdb777, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:44:23,813 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:44:23,813 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:44:25,698 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:44:25,699 - 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-10-31 08:44:25,734 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:44:25,735 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 9bbbb93d-28c4-42d8-a562-4331e7df462d, localhost:6393): creating call state
2025-10-31 08:44:25,735 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 9bbbb93d-28c4-42d8-a562-4331e7df462d, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:44:25,739 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 9bbbb93d-28c4-42d8-a562-4331e7df462d, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:44:25,775 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:44:25,776 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:44:27,409 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:44:27,409 - 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-10-31 08:44:27,415 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:44:27,431 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 810ed83e-331b-4d16-92a4-955309059d0e, localhost:6393): creating call state
2025-10-31 08:44:27,431 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 810ed83e-331b-4d16-92a4-955309059d0e, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:44:27,434 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 810ed83e-331b-4d16-92a4-955309059d0e, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:44:27,434 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:44:27,435 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:44:28,698 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:44:28,703 - 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-10-31 08:44:28,738 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:44:28,755 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 1138e764-5053-4283-a971-979ae7c842fd, localhost:6393): creating call state
2025-10-31 08:44:28,755 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 1138e764-5053-4283-a971-979ae7c842fd, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:44:28,765 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 1138e764-5053-4283-a971-979ae7c842fd, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:44:28,765 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:44:28,766 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:44:30,747 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:44:30,748 - 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-10-31 08:44:30,754 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:44:30,754 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 79034550-4f03-4cf4-a625-3080808e1cb5, localhost:6393): creating call state
2025-10-31 08:44:30,755 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 79034550-4f03-4cf4-a625-3080808e1cb5, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:44:30,759 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 79034550-4f03-4cf4-a625-3080808e1cb5, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:44:30,760 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:44:30,760 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:44:32,387 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:44:32,394 - 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-10-31 08:44:32,407 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:44:32,409 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, fead874b-9130-44e1-9353-330757c3a983, localhost:6393): creating call state
2025-10-31 08:44:32,409 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, fead874b-9130-44e1-9353-330757c3a983, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:44:32,411 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, fead874b-9130-44e1-9353-330757c3a983, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:44:32,412 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:44:32,412 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:44:34,510 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:44:34,510 - 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-10-31 08:44:34,521 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:44:34,530 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, d7035335-8a3d-46a5-8d9a-219cfe4a24e6, localhost:6393): creating call state
2025-10-31 08:44:34,531 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, d7035335-8a3d-46a5-8d9a-219cfe4a24e6, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:44:34,546 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, d7035335-8a3d-46a5-8d9a-219cfe4a24e6, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:44:34,547 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:44:34,550 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:44:36,563 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:44:36,564 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-10-31 08:44:36,574 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:44:36,574 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, ba4c2bfd-2bb6-4fd2-a79e-6cad87f664d5, localhost:6393): creating call state
2025-10-31 08:44:36,575 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, ba4c2bfd-2bb6-4fd2-a79e-6cad87f664d5, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:44:36,589 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, ba4c2bfd-2bb6-4fd2-a79e-6cad87f664d5, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:44:36,590 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:44:36,590 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:44:38,616 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:44:38,617 - 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-10-31 08:44:38,629 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:44:38,630 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 3779e199-d44a-45ce-8820-2f376c7e4a07, localhost:6393): creating call state
2025-10-31 08:44:38,630 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 3779e199-d44a-45ce-8820-2f376c7e4a07, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:44:38,635 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 3779e199-d44a-45ce-8820-2f376c7e4a07, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:44:38,646 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:44:38,646 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:44:39,706 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:44:39,706 - 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-10-31 08:44:39,711 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/db1
2025-10-31 08:44:39,712 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 5163d085-6772-43cb-8d1e-c7289ce102f2, localhost:11298): creating call state
2025-10-31 08:44:39,715 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 5163d085-6772-43cb-8d1e-c7289ce102f2, localhost:11298): request = { database: "/Root/db1" }
2025-10-31 08:44:39,719 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 5163d085-6772-43cb-8d1e-c7289ce102f2, localhost:11298): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-uabpkrvm6i.auto.internal" port: 15368 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 } endpoints { address: "ghrun-uabpkrvm6i.auto.internal" port: 28947 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 } endpoints { address: "ghrun-uabpkrvm6i.auto.internal" port: 11193 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-10-31 08:44:39,721 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root/db1: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-uabpkrvm6i.auto.internal:11193, location , ssl: False>, <Endpoint ghrun-uabpkrvm6i.auto.internal:15368, location , ssl: False>, <Endpoint ghrun-uabpkrvm6i.auto.internal:28947, location , ssl: False>]>
2025-10-31 08:44:39,722 - 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-10-31 08:44:39,737 - 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-10-31 08:44:39,747 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:11298
2025-10-31 08:44:40,629 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:44:40,632 - 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-10-31 08:44:40,637 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:44:40,642 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 451568a2-dd08-4c98-8429-9a915d96f9cb, localhost:6393): creating call state
2025-10-31 08:44:40,643 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 451568a2-dd08-4c98-8429-9a915d96f9cb, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:44:40,645 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 451568a2-dd08-4c98-8429-9a915d96f9cb, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:44:40,646 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:44:40,647 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:44:42,094 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:44:42,094 - 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-10-31 08:44:42,105 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:44:42,105 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 77090890-b3c9-42a5-ae40-46d63858d296, localhost:6393): creating call state
2025-10-31 08:44:42,106 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 77090890-b3c9-42a5-ae40-46d63858d296, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:44:42,108 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 77090890-b3c9-42a5-ae40-46d63858d296, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:44:42,109 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:44:42,109 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:44:43,458 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:44:43,459 - 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-10-31 08:44:43,473 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:44:43,479 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 07ad38fb-30db-4527-9923-95d7cea0507a, localhost:6393): creating call state
2025-10-31 08:44:43,484 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 07ad38fb-30db-4527-9923-95d7cea0507a, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:44:43,487 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 07ad38fb-30db-4527-9923-95d7cea0507a, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:44:43,488 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:44:43,489 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:44:44,978 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:44:44,979 - 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-10-31 08:44:44,987 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:44:44,988 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 30de35f6-90de-4b50-9aae-ecac4c5c1afa, localhost:6393): creating call state
2025-10-31 08:44:44,988 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 30de35f6-90de-4b50-9aae-ecac4c5c1afa, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:44:44,995 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 30de35f6-90de-4b50-9aae-ecac4c5c1afa, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:44:44,995 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:44:44,996 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:44:46,870 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:44:46,871 - 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-10-31 08:44:46,886 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:44:46,887 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, c2b4e9c6-8dbd-4d9a-9282-cc8bda88f7e8, localhost:6393): creating call state
2025-10-31 08:44:46,887 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, c2b4e9c6-8dbd-4d9a-9282-cc8bda88f7e8, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:44:46,895 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, c2b4e9c6-8dbd-4d9a-9282-cc8bda88f7e8, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:44:46,900 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:44:46,900 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:44:48,366 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:44:48,367 - 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-10-31 08:44:48,372 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:44:48,373 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, ec48eabc-e337-4ca7-87b9-9deafa55b084, localhost:6393): creating call state
2025-10-31 08:44:48,374 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, ec48eabc-e337-4ca7-87b9-9deafa55b084, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:44:48,377 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, ec48eabc-e337-4ca7-87b9-9deafa55b084, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:44:48,378 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:44:48,378 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:44:49,591 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:44:49,591 - 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-10-31 08:44:49,603 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:44:49,603 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 936d6e69-493d-412e-9f4d-6fe91928ac9d, localhost:6393): creating call state
2025-10-31 08:44:49,604 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 936d6e69-493d-412e-9f4d-6fe91928ac9d, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:44:49,608 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 936d6e69-493d-412e-9f4d-6fe91928ac9d, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:44:49,608 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:44:49,608 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:44:51,019 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:44:51,019 - 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-10-31 08:44:51,024 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:44:51,025 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 2874415b-0715-49f6-978d-6f2e56c58c1c, localhost:6393): creating call state
2025-10-31 08:44:51,025 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 2874415b-0715-49f6-978d-6f2e56c58c1c, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:44:51,031 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 2874415b-0715-49f6-978d-6f2e56c58c1c, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:44:51,032 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:44:51,032 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:44:52,631 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:44:52,631 - 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-10-31 08:44:52,638 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:44:52,638 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, f9f0e733-3145-433e-8862-84ed34cee4f3, localhost:6393): creating call state
2025-10-31 08:44:52,639 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, f9f0e733-3145-433e-8862-84ed34cee4f3, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:44:52,641 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, f9f0e733-3145-433e-8862-84ed34cee4f3, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:44:52,642 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:44:52,642 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:44:54,398 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:44:54,399 - 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-10-31 08:44:54,405 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:44:54,411 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 804c55ce-5668-4f70-a3cd-56cb7ff2c6d9, localhost:6393): creating call state
2025-10-31 08:44:54,413 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 804c55ce-5668-4f70-a3cd-56cb7ff2c6d9, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:44:54,417 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 804c55ce-5668-4f70-a3cd-56cb7ff2c6d9, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:44:54,419 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:44:54,421 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:44:56,269 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:44:56,269 - 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-10-31 08:44:56,275 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:44:56,279 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 2139c461-9a25-47dc-826b-afb4e79223a4, localhost:6393): creating call state
2025-10-31 08:44:56,279 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 2139c461-9a25-47dc-826b-afb4e79223a4, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:44:56,282 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 2139c461-9a25-47dc-826b-afb4e79223a4, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:44:56,282 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:44:56,282 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:44:58,457 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:44:58,458 - 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-10-31 08:44:58,469 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:44:58,488 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 25c86f3a-0f44-4714-8332-77fbe3347889, localhost:6393): creating call state
2025-10-31 08:44:58,489 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 25c86f3a-0f44-4714-8332-77fbe3347889, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:44:58,496 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 25c86f3a-0f44-4714-8332-77fbe3347889, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:44:58,497 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:44:58,497 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:45:00,012 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:45:00,030 - 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-10-31 08:45:00,037 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:45:00,037 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 7f018021-3fee-461d-a762-b55098815d9f, localhost:6393): creating call state
2025-10-31 08:45:00,038 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 7f018021-3fee-461d-a762-b55098815d9f, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:45:00,040 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 7f018021-3fee-461d-a762-b55098815d9f, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:45:00,041 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:45:00,041 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:45:01,918 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:45:01,919 - 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-10-31 08:45:01,936 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:45:01,940 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 7a323ef6-177d-48fe-8264-6ce3bcee3168, localhost:6393): creating call state
2025-10-31 08:45:01,941 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 7a323ef6-177d-48fe-8264-6ce3bcee3168, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:45:01,946 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 7a323ef6-177d-48fe-8264-6ce3bcee3168, localhost:6393): response = { operation { ready: true status: UNAVAILABLE issues { message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 } } }
2025-10-31 08:45:01,956 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:6393". Error details:
 message: "Database nodes resolve failed with no certain result" issue_code: 200400 severity: 1 (server_code: 400050)
2025-10-31 08:45:01,956 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:45:03,596 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:45:03,598 - 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-10-31 08:45:03,604 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-10-31 08:45:03,606 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, dfb97b77-119d-4ea4-96ec-4cf4782067e9, localhost:6393): creating call state
2025-10-31 08:45:03,606 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, dfb97b77-119d-4ea4-96ec-4cf4782067e9, localhost:6393): request = { database: "/Root2/db1" }
2025-10-31 08:45:03,616 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, dfb97b77-119d-4ea4-96ec-4cf4782067e9, localhost:6393): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-uabpkrvm6i.auto.internal" port: 24128 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-10-31 08:45:03,622 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root2/db1: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-uabpkrvm6i.auto.internal:24128, location , ssl: False>]>
2025-10-31 08:45:03,622 - 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-10-31 08:45:03,644 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6393
2025-10-31 08:45:41,250 - DEBUG - ya.test - _save_outputs: Command (pid 3348408) rc: 0
2025-10-31 08:45:41,251 - DEBUG - ya.test - _save_outputs: Command (pid 3348408) elapsed time (sec): 123.43685412406921
2025-10-31 08:45:41,251 - DEBUG - ya.test - _save_outputs: Command (pid 3348408) idrss: 0
2025-10-31 08:45:41,251 - DEBUG - ya.test - _save_outputs: Command (pid 3348408) inblock: 0
2025-10-31 08:45:41,252 - DEBUG - ya.test - _save_outputs: Command (pid 3348408) isrss: 0
2025-10-31 08:45:41,252 - DEBUG - ya.test - _save_outputs: Command (pid 3348408) ixrss: 0
2025-10-31 08:45:41,252 - DEBUG - ya.test - _save_outputs: Command (pid 3348408) majflt: 0
2025-10-31 08:45:41,252 - DEBUG - ya.test - _save_outputs: Command (pid 3348408) maxrss: 165604
2025-10-31 08:45:41,252 - DEBUG - ya.test - _save_outputs: Command (pid 3348408) minflt: 3756
2025-10-31 08:45:41,253 - DEBUG - ya.test - _save_outputs: Command (pid 3348408) msgrcv: 0
2025-10-31 08:45:41,253 - DEBUG - ya.test - _save_outputs: Command (pid 3348408) msgsnd: 0
2025-10-31 08:45:41,253 - DEBUG - ya.test - _save_outputs: Command (pid 3348408) nivcsw: 31
2025-10-31 08:45:41,253 - DEBUG - ya.test - _save_outputs: Command (pid 3348408) nsignals: 0
2025-10-31 08:45:41,253 - DEBUG - ya.test - _save_outputs: Command (pid 3348408) nswap: 0
2025-10-31 08:45:41,253 - DEBUG - ya.test - _save_outputs: Command (pid 3348408) nvcsw: 6389
2025-10-31 08:45:41,254 - DEBUG - ya.test - _save_outputs: Command (pid 3348408) oublock: 24
2025-10-31 08:45:41,254 - DEBUG - ya.test - _save_outputs: Command (pid 3348408) stime: 0.173282
2025-10-31 08:45:41,255 - DEBUG - ya.test - _save_outputs: Command (pid 3348408) utime: 0.269551
2025-10-31 08:45:41,255 - DEBUG - ya.test - _save_outputs: Command (pid 3348408) wtime: 123.438
2025-10-31 08:45:41,255 - DEBUG - ya.test - _save_outputs: Command (pid 3348408) output:

2025-10-31 08:45:41,255 - DEBUG - ya.test - _save_outputs: Command (pid 3348408) errors:
Using auth method "token" from YDB_TOKEN enviroment variable
2025-10-31T08:43:37.922909Z :INFO: Restore cluster from "/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/cluster_backup"
2025-10-31T08:43:37.923647Z :DEBUG: Try to find cluster root path
2025-10-31T08:43:37.929764Z :INFO: Restore cluster root "/Root2" from "/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/cluster_backup"
2025-10-31T08:43:37.931776Z :DEBUG: Restore users to "/Root2"
2025-10-31T08:43:37.946151Z :DEBUG: User from create statement "CREATE USER `root` HASH '{\"hash\":\"t3vkn6k4hD4H4xp4RCZioSDA+enZWYnEN4qT6GBKsxw=\",\"salt\":\"pu6Ajcvu+IiURnwHyEPQQw==\",\"type\":\"argon2id\"}';" already exists, trying to alter it
2025-10-31T08:43:37.953449Z :DEBUG: Restore groups to "/Root2"
2025-10-31T08:43:37.953547Z :DEBUG: Restore group members to "/Root2"
2025-10-31T08:43:38.036119Z :DEBUG: Restore ACL "/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/cluster_backup" to "/Root2"
2025-10-31T08:43:38.036162Z :DEBUG: Read ACL from "/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/cluster_backup/permissions.pb"
2025-10-31T08:43:38.040609Z :DEBUG: Read database description from "/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/cluster_backup/Root/db1/database.pb"
2025-10-31T08:43:38.041132Z :INFO: Restore database from "/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/cluster_backup/Root/db1" to "/Root2/db1"
2025-10-31T08:43:38.058337Z :INFO: Waiting for available database nodes for "/Root2/db1", make sure that nodes are running, time left: 239.996790s
2025-10-31T08:43:39.059979Z :INFO: Waiting for available database nodes for "/Root2/db1", make sure that nodes are running, time left: 238.995276s
2025-10-31T08:43:41.061547Z :INFO: Waiting for available database nodes for "/Root2/db1", make sure that nodes are running, time left: 236.993924s
2025-10-31T08:43:45.063003Z :INFO: Waiting for available database nodes for "/Root2/db1", make sure that nodes are running, time left: 232.992932s
2025-10-31T08:43:53.067930Z :INFO: Waiting for available database nodes for "/Root2/db1", make sure that nodes are running, time left: 224.988916s
2025-10-31T08:44:09.074626Z :INFO: Waiting for available database nodes for "/Root2/db1", make sure that nodes are running, time left: 208.984042s
2025-10-31T08:44:41.083617Z :INFO: Waiting for available database nodes for "/Root2/db1", make sure that nodes are running, time left: 176.978712s
2025-10-31T08:45:41.091266Z :DEBUG: Restore users to "/Root2/db1"
2025-10-31T08:45:41.126680Z :DEBUG: Restore groups to "/Root2/db1"
2025-10-31T08:45:41.136420Z :DEBUG: Restore group members to "/Root2/db1"
2025-10-31T08:45:41.156257Z :DEBUG: Restore ACL "/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/cluster_backup/Root/db1" to "/Root2/db1"
2025-10-31T08:45:41.156295Z :DEBUG: Read ACL from "/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/cluster_backup/Root/db1/permissions.pb"
2025-10-31T08:45:41.173860Z :INFO: Restore cluster completed successfully

2025-10-31 08:45:41,265 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydb/ydb
2025-10-31 08:45:41,267 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.2
2025-10-31 08:45:41,267 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.2
2025-10-31 08:45:41,267 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydb/ydb', '--verbose', '--assume-yes', '--endpoint', 'grpc://localhost:6393', '--database', '/Root2/db1', '--user', 'dbadmin1', '--no-password', 'admin', 'database', 'restore', '--input', '/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/database_backup', '-w', '240s']' in 'None' (waiting)
2025-10-31 08:45:41,269 - DEBUG - ya.test - execute: Command pid: 3449451
2025-10-31 08:45:41,577 - DEBUG - ya.test - _save_outputs: Command (pid 3449451) rc: 1
2025-10-31 08:45:41,578 - DEBUG - ya.test - _save_outputs: Command (pid 3449451) elapsed time (sec): 0.30705738067626953
2025-10-31 08:45:41,579 - DEBUG - ya.test - _save_outputs: Command (pid 3449451) idrss: 0
2025-10-31 08:45:41,579 - DEBUG - ya.test - _save_outputs: Command (pid 3449451) inblock: 0
2025-10-31 08:45:41,580 - DEBUG - ya.test - _save_outputs: Command (pid 3449451) isrss: 0
2025-10-31 08:45:41,580 - DEBUG - ya.test - _save_outputs: Command (pid 3449451) ixrss: 0
2025-10-31 08:45:41,580 - DEBUG - ya.test - _save_outputs: Command (pid 3449451) majflt: 0
2025-10-31 08:45:41,581 - DEBUG - ya.test - _save_outputs: Command (pid 3449451) maxrss: 167996
2025-10-31 08:45:41,581 - DEBUG - ya.test - _save_outputs: Command (pid 3449451) minflt: 3463
2025-10-31 08:45:41,581 - DEBUG - ya.test - _save_outputs: Command (pid 3449451) msgrcv: 0
2025-10-31 08:45:41,581 - DEBUG - ya.test - _save_outputs: Command (pid 3449451) msgsnd: 0
2025-10-31 08:45:41,581 - DEBUG - ya.test - _save_outputs: Command (pid 3449451) nivcsw: 22
2025-10-31 08:45:41,581 - DEBUG - ya.test - _save_outputs: Command (pid 3449451) nsignals: 0
2025-10-31 08:45:41,582 - DEBUG - ya.test - _save_outputs: Command (pid 3449451) nswap: 0
2025-10-31 08:45:41,582 - DEBUG - ya.test - _save_outputs: Command (pid 3449451) nvcsw: 142
2025-10-31 08:45:41,582 - DEBUG - ya.test - _save_outputs: Command (pid 3449451) oublock: 8
2025-10-31 08:45:41,582 - DEBUG - ya.test - _save_outputs: Command (pid 3449451) stime: 0.016243999999999998
2025-10-31 08:45:41,582 - DEBUG - ya.test - _save_outputs: Command (pid 3449451) utime: 0.06497599999999999
2025-10-31 08:45:41,583 - DEBUG - ya.test - _save_outputs: Command (pid 3449451) wtime: 0.308
2025-10-31 08:45:41,583 - DEBUG - ya.test - _save_outputs: Command (pid 3449451) output:

2025-10-31 08:45:41,584 - DEBUG - ya.test - _save_outputs: Command (pid 3449451) errors:
Using auth method "static-credentials" from explicit command line option --user with username "dbadmin1"
Using no password due to explicit --no-password option
2025-10-31T08:45:41.540240Z :DEBUG: Read database description from "/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/database_backup/database.pb"
2025-10-31T08:45:41.541613Z :INFO: Restore database from "/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/database_backup" to "/Root2/db1"
2025-10-31T08:45:41.541737Z :ERROR: Restore database failed: [ { <main>: Error: GRpc error: (16): unauthenticated, unauthenticated: { <main>: Error: Could not find correct token validator } } { <main>: Error: Grpc error response on endpoint localhost:6393 } { <main>: Error: Endpoint list is empty for database /Root2/db1, cluster endpoint localhost:6393. } ]
Status: CLIENT_UNAUTHENTICATED
Issues: 
<main>: Error: GRpc error: (16): unauthenticated, unauthenticated: { <main>: Error: Could not find correct token validator }
<main>: Error: Grpc error response on endpoint localhost:6393
<main>: Error: Endpoint list is empty for database /Root2/db1, cluster endpoint localhost:6393.

2025-10-31 08:45:41,585 - ERROR - ya.test - _finalise: Execution failed with exit code: 1
	,std_out:b''
	std_err:b'Using auth method "static-credentials" from explicit command line option --user with username "dbadmin1"\nUsing no password due to explicit --no-password option\n2025-10-31T08:45:41.540240Z :DEBUG: Read database description from "/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/database_backup/database.pb"\n2025-10-31T08:45:41.541613Z :INFO: Restore database from "/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/database_backup" to "/Root2/db1"\n2025-10-31T08:45:41.541737Z :ERROR: Restore database failed: [ { <main>: Error: GRpc error: (16): unauthenticated, unauthenticated: { <main>: Error: Could not find correct token validator } } { <main>: Error: Grpc error response on endpoint localhost:6393 } { <main>: Error: Endpoint list is empty for database /Root2/db1, cluster endpoint localhost:6393. } ]\nStatus: CLIENT_UNAUTHENTICATED\nIssues: \n<main>: Error: GRpc error: (16): unauthenticated, unauthenticated: { <main>: Error: Could not find correct token validator }\n<main>: Error: Grpc error response on endpoint localhost:6393\n<main>: Error: Endpoint list is empty for database /Root2/db1, cluster endpoint localhost:6393.\n'

2025-10-31 08:45:42,344 - ERROR - ya.test - logreport: ydb/tests/functional/ydb_cli/test_ydb_backup.py:1627: in test_database_backup_restore
    self.restore_database_backup(input="database_backup")
ydb/tests/functional/ydb_cli/test_ydb_backup.py:1553: in restore_database_backup
    cls.restore(
ydb/tests/functional/ydb_cli/test_ydb_backup.py:1526: in restore
    yatest.common.execute(
library/python/testing/yatest_common/yatest/common/process.py:656: in execute
    res.wait(check_exit_code, timeout, on_timeout)
library/python/testing/yatest_common/yatest/common/process.py:411: in wait
    self._finalise(check_exit_code)
library/python/testing/yatest_common/yatest/common/process.py:422: in _finalise
    raise ExecutionError(self)
E   yatest.common.process.ExecutionError: Command '/home/runner/.ya/build/build_root/pogg/001904/ydb/apps/ydb/ydb --verbose --assume-yes --endpoint grpc://localhost:6393 --database /Root2/db1 --user dbadmin1 --no-password admin database restore --input /home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/database_backup -w 240s' has failed with code 1.
E   Errors:
E   Using auth method "static-credentials" from explicit command line option --user with username "dbadmin1"
E   Using no password due to explicit --no-password option
E   2025-10-31T08:45:41.540240Z :DEBUG: Read database description from "/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/database_backup/database.pb"
E   2025-10-31T08:45:41.541613Z :INFO: Restore database from "/home/runner/.ya/build/build_root/pogg/001904/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/database_backup" to "/Root2/db1"
E   2025-10-31T08:45:41.541737Z :ERROR: Restore database failed: [ { <main>: Error: GRpc error: (16): unauthenticated, unauthenticated: { <main>: Error: Could not find correct token validator } } { <main>: Error: Grpc error response on endpoint localhost:6393 } { <main>: Error: Endpoint list is empty for database /Root2/db1, cluster endpoint localhost:6393. } ]
E   Status: CLIENT_UNAUTHENTICATED
E   Issues: 
E   <main>: Error: GRpc error: (16): unauthenticated, unauthenticated: { <main>: Error: Could not find correct token validator }
E   <main>: Error: Grpc error response on endpoint localhost:6393
E   <main>: Error: Endpoint list is empty for database /Root2/db1, cluster endpoint localhost:6393.
2025-10-31 08:45:42,347 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-10-31 08:45:42,731 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:45:42,732 - 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-10-31 08:45:42,759 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/db1
2025-10-31 08:45:42,779 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 8da9c701-aad2-4cdd-aea2-9842ae8f04cf, localhost:11298): creating call state
2025-10-31 08:45:42,780 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 8da9c701-aad2-4cdd-aea2-9842ae8f04cf, localhost:11298): request = { database: "/Root/db1" }
2025-10-31 08:45:42,784 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 8da9c701-aad2-4cdd-aea2-9842ae8f04cf, localhost:11298): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-uabpkrvm6i.auto.internal" port: 15368 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 } endpoints { address: "ghrun-uabpkrvm6i.auto.internal" port: 28947 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 } endpoints { address: "ghrun-uabpkrvm6i.auto.internal" port: 11193 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-10-31 08:45:42,785 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root/db1: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-uabpkrvm6i.auto.internal:28947, location , ssl: False>, <Endpoint ghrun-uabpkrvm6i.auto.internal:15368, location , ssl: False>, <Endpoint ghrun-uabpkrvm6i.auto.internal:11193, location , ssl: False>]>
2025-10-31 08:45:42,785 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:11298
2025-10-31 08:45:45,348 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:24128/1
2025-10-31 08:45:57,352 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:6393/1
2025-10-31 08:45:57,357 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/16494
2025-10-31 08:45:57,358 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/29198
2025-10-31 08:45:57,358 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/16202
2025-10-31 08:45:57,358 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/23072
2025-10-31 08:45:57,358 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/24128
2025-10-31 08:45:57,358 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/12660
2025-10-31 08:45:57,359 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/14668
2025-10-31 08:45:57,360 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/25130
2025-10-31 08:45:57,360 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/6393
2025-10-31 08:45:57,360 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/5452
2025-10-31 08:46:18,213 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:46:18,214 - 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-10-31 08:46:19,362 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:11193/1
2025-10-31 08:46:20,363 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:28947/2
2025-10-31 08:46:21,364 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:15368/3
2025-10-31 08:46:24,365 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:11298/1
2025-10-31 08:46:24,366 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/27536
2025-10-31 08:46:24,367 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/24773
2025-10-31 08:46:24,367 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/6936
2025-10-31 08:46:24,367 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/3380
2025-10-31 08:46:24,367 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/15368
2025-10-31 08:46:24,367 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/23249
2025-10-31 08:46:24,368 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/4217
2025-10-31 08:46:24,368 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/6677
2025-10-31 08:46:24,368 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/7788
2025-10-31 08:46:24,368 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/28947
2025-10-31 08:46:24,368 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/9569
2025-10-31 08:46:24,368 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/13929
2025-10-31 08:46:24,369 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/2255
2025-10-31 08:46:24,369 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/30282
2025-10-31 08:46:24,369 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/11193
2025-10-31 08:46:24,369 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/62706
2025-10-31 08:46:24,369 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/4548
2025-10-31 08:46:24,369 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/8894
2025-10-31 08:46:24,370 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/11298
2025-10-31 08:46:24,370 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/26624
