2025-11-01 04:20:57,542 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 04:20:57,542 - INFO - ya.test - pytest_runtest_setup: test_database_backup_restore
2025-11-01 04:20:57,542 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 04:20:57,542 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-01 04:20:57,581 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd
2025-11-01 04:20:57,581 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/8837
2025-11-01 04:20:57,582 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/g81u/004d6f/r3tmp/kikimr_cluster_msu773_z
2025-11-01 04:20:57,605 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd
2025-11-01 04:20:57,605 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/10118
2025-11-01 04:20:57,606 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/31906
2025-11-01 04:20:57,606 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/64412
2025-11-01 04:20:57,606 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/10226
2025-11-01 04:20:57,606 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/g81u/004d6f/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-11-01 04:20:57,607 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/g81u/004d6f/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/g81u/004d6f/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_8fyuly8s.log --grpc-port=10118 --mon-port=31906 --ic-port=8837
2025-11-01 04:20:57,607 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:10118/1, disk_size 68719476736
2025-11-01 04:20:57,607 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/g81u/004d6f/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-11-01 04:20:57,607 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/g81u/004d6f/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/g81u/004d6f/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_8fyuly8s.log --grpc-port=10118 --mon-port=31906 --ic-port=8837
2025-11-01 04:20:57,608 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/g81u/004d6f/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/g81u/004d6f/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_8fyuly8s.log', '--grpc-port=10118', '--mon-port=31906', '--ic-port=8837')' in '/home/runner/.ya/build/build_root/g81u/004d6f/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-11-01 04:20:57,609 - DEBUG - ya.test - execute: Command pid: 2586302
2025-11-01 04:20:57,609 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:10118/1
2025-11-01 04:20:57,610 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-11-01 04:20:57,610 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-11-01 04:20:57,610 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 04:20:57,611 - DEBUG - ya.test - execute: Command pid: 2586304
2025-11-01 04:20:57,928 - DEBUG - ya.test - _save_outputs: Command (pid 2586304) rc: 0
2025-11-01 04:20:57,928 - DEBUG - ya.test - _save_outputs: Command (pid 2586304) elapsed time (sec): 0.31652402877807617
2025-11-01 04:20:57,928 - DEBUG - ya.test - _save_outputs: Command (pid 2586304) idrss: 0
2025-11-01 04:20:57,928 - DEBUG - ya.test - _save_outputs: Command (pid 2586304) inblock: 0
2025-11-01 04:20:57,928 - DEBUG - ya.test - _save_outputs: Command (pid 2586304) isrss: 0
2025-11-01 04:20:57,929 - DEBUG - ya.test - _save_outputs: Command (pid 2586304) ixrss: 0
2025-11-01 04:20:57,929 - DEBUG - ya.test - _save_outputs: Command (pid 2586304) majflt: 0
2025-11-01 04:20:57,929 - DEBUG - ya.test - _save_outputs: Command (pid 2586304) maxrss: 538372
2025-11-01 04:20:57,929 - DEBUG - ya.test - _save_outputs: Command (pid 2586304) minflt: 16126
2025-11-01 04:20:57,929 - DEBUG - ya.test - _save_outputs: Command (pid 2586304) msgrcv: 0
2025-11-01 04:20:57,929 - DEBUG - ya.test - _save_outputs: Command (pid 2586304) msgsnd: 0
2025-11-01 04:20:57,929 - DEBUG - ya.test - _save_outputs: Command (pid 2586304) nivcsw: 3
2025-11-01 04:20:57,929 - DEBUG - ya.test - _save_outputs: Command (pid 2586304) nsignals: 0
2025-11-01 04:20:57,930 - DEBUG - ya.test - _save_outputs: Command (pid 2586304) nswap: 0
2025-11-01 04:20:57,930 - DEBUG - ya.test - _save_outputs: Command (pid 2586304) nvcsw: 13
2025-11-01 04:20:57,930 - DEBUG - ya.test - _save_outputs: Command (pid 2586304) oublock: 8
2025-11-01 04:20:57,930 - DEBUG - ya.test - _save_outputs: Command (pid 2586304) stime: 0.192233
2025-11-01 04:20:57,930 - DEBUG - ya.test - _save_outputs: Command (pid 2586304) utime: 0.07609199999999999
2025-11-01 04:20:57,930 - DEBUG - ya.test - _save_outputs: Command (pid 2586304) wtime: 0.317
2025-11-01 04:20:57,930 - DEBUG - ya.test - _save_outputs: Command (pid 2586304) output:
Git info:
    Commit: 767d72532e5716ba790791cf237fdadb24b0e578
    Branch: 
    Author: Innokentii Mokin <enjection@ya.ru>
    Summary: Merge 96af589a3c3d7740081955df0fe84da0a7b35651 into 2afee58ebdae8491f810ad53605d37376c4e5de6

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

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

2025-11-01 04:20:57,930 - DEBUG - ya.test - _save_outputs: Command (pid 2586304) errors:

2025-11-01 04:20:57,931 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 767d72532e5716ba790791cf237fdadb24b0e578
    Branch: 
    Author: Innokentii Mokin <enjection@ya.ru>
    Summary: Merge 96af589a3c3d7740081955df0fe84da0a7b35651 into 2afee58ebdae8491f810ad53605d37376c4e5de6
2025-11-01 04:20:59,648 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd
2025-11-01 04:20:59,648 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:10118', '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: 8837\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-01 04:20:59,648 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-11-01 04:20:59,649 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-11-01 04:20:59,649 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:10118', '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: 8837\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-01 04:20:59,649 - DEBUG - ya.test - execute: Command pid: 2588369
2025-11-01 04:21:00,203 - DEBUG - ya.test - _save_outputs: Command (pid 2588369) rc: 0
2025-11-01 04:21:00,203 - DEBUG - ya.test - _save_outputs: Command (pid 2588369) elapsed time (sec): 0.5531654357910156
2025-11-01 04:21:00,204 - DEBUG - ya.test - _save_outputs: Command (pid 2588369) idrss: 0
2025-11-01 04:21:00,204 - DEBUG - ya.test - _save_outputs: Command (pid 2588369) inblock: 0
2025-11-01 04:21:00,204 - DEBUG - ya.test - _save_outputs: Command (pid 2588369) isrss: 0
2025-11-01 04:21:00,204 - DEBUG - ya.test - _save_outputs: Command (pid 2588369) ixrss: 0
2025-11-01 04:21:00,204 - DEBUG - ya.test - _save_outputs: Command (pid 2588369) majflt: 0
2025-11-01 04:21:00,204 - DEBUG - ya.test - _save_outputs: Command (pid 2588369) maxrss: 546808
2025-11-01 04:21:00,204 - DEBUG - ya.test - _save_outputs: Command (pid 2588369) minflt: 18274
2025-11-01 04:21:00,204 - DEBUG - ya.test - _save_outputs: Command (pid 2588369) msgrcv: 0
2025-11-01 04:21:00,204 - DEBUG - ya.test - _save_outputs: Command (pid 2588369) msgsnd: 0
2025-11-01 04:21:00,205 - DEBUG - ya.test - _save_outputs: Command (pid 2588369) nivcsw: 2
2025-11-01 04:21:00,205 - DEBUG - ya.test - _save_outputs: Command (pid 2588369) nsignals: 0
2025-11-01 04:21:00,205 - DEBUG - ya.test - _save_outputs: Command (pid 2588369) nswap: 0
2025-11-01 04:21:00,205 - DEBUG - ya.test - _save_outputs: Command (pid 2588369) nvcsw: 147
2025-11-01 04:21:00,205 - DEBUG - ya.test - _save_outputs: Command (pid 2588369) oublock: 8
2025-11-01 04:21:00,205 - DEBUG - ya.test - _save_outputs: Command (pid 2588369) stime: 0.409684
2025-11-01 04:21:00,205 - DEBUG - ya.test - _save_outputs: Command (pid 2588369) utime: 0.099438
2025-11-01 04:21:00,205 - DEBUG - ya.test - _save_outputs: Command (pid 2588369) wtime: 0.554
2025-11-01 04:21:00,205 - DEBUG - ya.test - _save_outputs: Command (pid 2588369) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 4

2025-11-01 04:21:00,206 - DEBUG - ya.test - _save_outputs: Command (pid 2588369) errors:

2025-11-01 04:21:00,206 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd
2025-11-01 04:21:00,207 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:10118', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']
2025-11-01 04:21:00,207 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-11-01 04:21:00,208 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-11-01 04:21:00,208 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:10118', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-01 04:21:00,209 - DEBUG - ya.test - execute: Command pid: 2589213
2025-11-01 04:21:00,576 - DEBUG - ya.test - _save_outputs: Command (pid 2589213) rc: 0
2025-11-01 04:21:00,576 - DEBUG - ya.test - _save_outputs: Command (pid 2589213) elapsed time (sec): 0.36712098121643066
2025-11-01 04:21:00,577 - DEBUG - ya.test - _save_outputs: Command (pid 2589213) idrss: 0
2025-11-01 04:21:00,577 - DEBUG - ya.test - _save_outputs: Command (pid 2589213) inblock: 0
2025-11-01 04:21:00,577 - DEBUG - ya.test - _save_outputs: Command (pid 2589213) isrss: 0
2025-11-01 04:21:00,577 - DEBUG - ya.test - _save_outputs: Command (pid 2589213) ixrss: 0
2025-11-01 04:21:00,577 - DEBUG - ya.test - _save_outputs: Command (pid 2589213) majflt: 0
2025-11-01 04:21:00,577 - DEBUG - ya.test - _save_outputs: Command (pid 2589213) maxrss: 546824
2025-11-01 04:21:00,577 - DEBUG - ya.test - _save_outputs: Command (pid 2589213) minflt: 18268
2025-11-01 04:21:00,578 - DEBUG - ya.test - _save_outputs: Command (pid 2589213) msgrcv: 0
2025-11-01 04:21:00,578 - DEBUG - ya.test - _save_outputs: Command (pid 2589213) msgsnd: 0
2025-11-01 04:21:00,578 - DEBUG - ya.test - _save_outputs: Command (pid 2589213) nivcsw: 1
2025-11-01 04:21:00,578 - DEBUG - ya.test - _save_outputs: Command (pid 2589213) nsignals: 0
2025-11-01 04:21:00,578 - DEBUG - ya.test - _save_outputs: Command (pid 2589213) nswap: 0
2025-11-01 04:21:00,579 - DEBUG - ya.test - _save_outputs: Command (pid 2589213) nvcsw: 137
2025-11-01 04:21:00,579 - DEBUG - ya.test - _save_outputs: Command (pid 2589213) oublock: 8
2025-11-01 04:21:00,579 - DEBUG - ya.test - _save_outputs: Command (pid 2589213) stime: 0.215027
2025-11-01 04:21:00,579 - DEBUG - ya.test - _save_outputs: Command (pid 2589213) utime: 0.107503
2025-11-01 04:21:00,579 - DEBUG - ya.test - _save_outputs: Command (pid 2589213) wtime: 0.368
2025-11-01 04:21:00,579 - DEBUG - ya.test - _save_outputs: Command (pid 2589213) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-01 04:21:00,579 - DEBUG - ya.test - _save_outputs: Command (pid 2589213) errors:

2025-11-01 04:21:00,579 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-01 04:21:00,591 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-11-01 04:21:01,108 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd
2025-11-01 04:21:01,108 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/63312
2025-11-01 04:21:01,109 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/29663
2025-11-01 04:21:01,109 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/23505
2025-11-01 04:21:01,109 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/62598
2025-11-01 04:21:01,109 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/29429
2025-11-01 04:21:01,110 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/g81u/004d6f/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-11-01 04:21:01,110 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:10118 --tenant=/Root/db1 --log-file-name=/home/runner/.ya/build/build_root/g81u/004d6f/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_ei528ilv.log --grpc-port=63312 --mon-port=29663 --ic-port=23505
2025-11-01 04:21:01,110 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd
2025-11-01 04:21:01,110 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/7108
2025-11-01 04:21:01,111 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/24965
2025-11-01 04:21:01,111 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/8045
2025-11-01 04:21:01,111 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/15391
2025-11-01 04:21:01,111 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/28622
2025-11-01 04:21:01,112 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/g81u/004d6f/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-11-01 04:21:01,112 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:10118 --tenant=/Root/db1 --log-file-name=/home/runner/.ya/build/build_root/g81u/004d6f/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_ecb1dz54.log --grpc-port=7108 --mon-port=24965 --ic-port=8045
2025-11-01 04:21:01,112 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd
2025-11-01 04:21:01,112 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/17919
2025-11-01 04:21:01,113 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/10209
2025-11-01 04:21:01,113 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/24456
2025-11-01 04:21:01,113 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/26136
2025-11-01 04:21:01,113 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/26690
2025-11-01 04:21:01,114 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/g81u/004d6f/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-11-01 04:21:01,114 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:10118 --tenant=/Root/db1 --log-file-name=/home/runner/.ya/build/build_root/g81u/004d6f/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_v5xlkn03.log --grpc-port=17919 --mon-port=10209 --ic-port=24456
2025-11-01 04:21:01,114 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/g81u/004d6f/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-11-01 04:21:01,114 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:10118 --tenant=/Root/db1 --log-file-name=/home/runner/.ya/build/build_root/g81u/004d6f/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_ei528ilv.log --grpc-port=63312 --mon-port=29663 --ic-port=23505
2025-11-01 04:21:01,115 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/g81u/004d6f/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:10118', '--tenant=/Root/db1', '--log-file-name=/home/runner/.ya/build/build_root/g81u/004d6f/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_ei528ilv.log', '--grpc-port=63312', '--mon-port=29663', '--ic-port=23505')' in '/home/runner/.ya/build/build_root/g81u/004d6f/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-11-01 04:21:01,116 - DEBUG - ya.test - execute: Command pid: 2590274
2025-11-01 04:21:01,116 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:63312/1
2025-11-01 04:21:01,117 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-11-01 04:21:01,117 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-11-01 04:21:01,117 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 04:21:01,118 - DEBUG - ya.test - execute: Command pid: 2590275
2025-11-01 04:21:01,512 - DEBUG - ya.test - _save_outputs: Command (pid 2590275) rc: 0
2025-11-01 04:21:01,512 - DEBUG - ya.test - _save_outputs: Command (pid 2590275) elapsed time (sec): 0.39320921897888184
2025-11-01 04:21:01,512 - DEBUG - ya.test - _save_outputs: Command (pid 2590275) idrss: 0
2025-11-01 04:21:01,512 - DEBUG - ya.test - _save_outputs: Command (pid 2590275) inblock: 0
2025-11-01 04:21:01,512 - DEBUG - ya.test - _save_outputs: Command (pid 2590275) isrss: 0
2025-11-01 04:21:01,513 - DEBUG - ya.test - _save_outputs: Command (pid 2590275) ixrss: 0
2025-11-01 04:21:01,513 - DEBUG - ya.test - _save_outputs: Command (pid 2590275) majflt: 0
2025-11-01 04:21:01,513 - DEBUG - ya.test - _save_outputs: Command (pid 2590275) maxrss: 538372
2025-11-01 04:21:01,513 - DEBUG - ya.test - _save_outputs: Command (pid 2590275) minflt: 16127
2025-11-01 04:21:01,513 - DEBUG - ya.test - _save_outputs: Command (pid 2590275) msgrcv: 0
2025-11-01 04:21:01,513 - DEBUG - ya.test - _save_outputs: Command (pid 2590275) msgsnd: 0
2025-11-01 04:21:01,513 - DEBUG - ya.test - _save_outputs: Command (pid 2590275) nivcsw: 1
2025-11-01 04:21:01,513 - DEBUG - ya.test - _save_outputs: Command (pid 2590275) nsignals: 0
2025-11-01 04:21:01,513 - DEBUG - ya.test - _save_outputs: Command (pid 2590275) nswap: 0
2025-11-01 04:21:01,514 - DEBUG - ya.test - _save_outputs: Command (pid 2590275) nvcsw: 13
2025-11-01 04:21:01,514 - DEBUG - ya.test - _save_outputs: Command (pid 2590275) oublock: 8
2025-11-01 04:21:01,514 - DEBUG - ya.test - _save_outputs: Command (pid 2590275) stime: 0.245922
2025-11-01 04:21:01,514 - DEBUG - ya.test - _save_outputs: Command (pid 2590275) utime: 0.099162
2025-11-01 04:21:01,514 - DEBUG - ya.test - _save_outputs: Command (pid 2590275) wtime: 0.394
2025-11-01 04:21:01,514 - DEBUG - ya.test - _save_outputs: Command (pid 2590275) output:
Git info:
    Commit: 767d72532e5716ba790791cf237fdadb24b0e578
    Branch: 
    Author: Innokentii Mokin <enjection@ya.ru>
    Summary: Merge 96af589a3c3d7740081955df0fe84da0a7b35651 into 2afee58ebdae8491f810ad53605d37376c4e5de6

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

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

2025-11-01 04:21:01,514 - DEBUG - ya.test - _save_outputs: Command (pid 2590275) errors:

2025-11-01 04:21:01,514 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 767d72532e5716ba790791cf237fdadb24b0e578
    Branch: 
    Author: Innokentii Mokin <enjection@ya.ru>
    Summary: Merge 96af589a3c3d7740081955df0fe84da0a7b35651 into 2afee58ebdae8491f810ad53605d37376c4e5de6
2025-11-01 04:21:01,515 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/g81u/004d6f/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-11-01 04:21:01,515 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:10118 --tenant=/Root/db1 --log-file-name=/home/runner/.ya/build/build_root/g81u/004d6f/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_ecb1dz54.log --grpc-port=7108 --mon-port=24965 --ic-port=8045
2025-11-01 04:21:01,516 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/g81u/004d6f/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:10118', '--tenant=/Root/db1', '--log-file-name=/home/runner/.ya/build/build_root/g81u/004d6f/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_ecb1dz54.log', '--grpc-port=7108', '--mon-port=24965', '--ic-port=8045')' in '/home/runner/.ya/build/build_root/g81u/004d6f/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-11-01 04:21:01,517 - DEBUG - ya.test - execute: Command pid: 2590680
2025-11-01 04:21:01,517 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:7108/2
2025-11-01 04:21:01,518 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.3
2025-11-01 04:21:01,518 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.3
2025-11-01 04:21:01,519 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 04:21:01,519 - DEBUG - ya.test - execute: Command pid: 2590719
2025-11-01 04:21:02,045 - DEBUG - ya.test - _save_outputs: Command (pid 2590719) rc: 0
2025-11-01 04:21:02,046 - DEBUG - ya.test - _save_outputs: Command (pid 2590719) elapsed time (sec): 0.525421142578125
2025-11-01 04:21:02,046 - DEBUG - ya.test - _save_outputs: Command (pid 2590719) idrss: 0
2025-11-01 04:21:02,046 - DEBUG - ya.test - _save_outputs: Command (pid 2590719) inblock: 0
2025-11-01 04:21:02,046 - DEBUG - ya.test - _save_outputs: Command (pid 2590719) isrss: 0
2025-11-01 04:21:02,046 - DEBUG - ya.test - _save_outputs: Command (pid 2590719) ixrss: 0
2025-11-01 04:21:02,047 - DEBUG - ya.test - _save_outputs: Command (pid 2590719) majflt: 1
2025-11-01 04:21:02,047 - DEBUG - ya.test - _save_outputs: Command (pid 2590719) maxrss: 538420
2025-11-01 04:21:02,047 - DEBUG - ya.test - _save_outputs: Command (pid 2590719) minflt: 17343
2025-11-01 04:21:02,047 - DEBUG - ya.test - _save_outputs: Command (pid 2590719) msgrcv: 0
2025-11-01 04:21:02,047 - DEBUG - ya.test - _save_outputs: Command (pid 2590719) msgsnd: 0
2025-11-01 04:21:02,047 - DEBUG - ya.test - _save_outputs: Command (pid 2590719) nivcsw: 3
2025-11-01 04:21:02,047 - DEBUG - ya.test - _save_outputs: Command (pid 2590719) nsignals: 0
2025-11-01 04:21:02,047 - DEBUG - ya.test - _save_outputs: Command (pid 2590719) nswap: 0
2025-11-01 04:21:02,048 - DEBUG - ya.test - _save_outputs: Command (pid 2590719) nvcsw: 16
2025-11-01 04:21:02,048 - DEBUG - ya.test - _save_outputs: Command (pid 2590719) oublock: 8
2025-11-01 04:21:02,048 - DEBUG - ya.test - _save_outputs: Command (pid 2590719) stime: 0.368958
2025-11-01 04:21:02,048 - DEBUG - ya.test - _save_outputs: Command (pid 2590719) utime: 0.10828099999999999
2025-11-01 04:21:02,048 - DEBUG - ya.test - _save_outputs: Command (pid 2590719) wtime: 0.526
2025-11-01 04:21:02,048 - DEBUG - ya.test - _save_outputs: Command (pid 2590719) output:
Git info:
    Commit: 767d72532e5716ba790791cf237fdadb24b0e578
    Branch: 
    Author: Innokentii Mokin <enjection@ya.ru>
    Summary: Merge 96af589a3c3d7740081955df0fe84da0a7b35651 into 2afee58ebdae8491f810ad53605d37376c4e5de6

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

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

2025-11-01 04:21:02,048 - DEBUG - ya.test - _save_outputs: Command (pid 2590719) errors:

2025-11-01 04:21:02,049 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 2 version:
Git info:
    Commit: 767d72532e5716ba790791cf237fdadb24b0e578
    Branch: 
    Author: Innokentii Mokin <enjection@ya.ru>
    Summary: Merge 96af589a3c3d7740081955df0fe84da0a7b35651 into 2afee58ebdae8491f810ad53605d37376c4e5de6
2025-11-01 04:21:02,049 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/g81u/004d6f/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-11-01 04:21:02,049 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:10118 --tenant=/Root/db1 --log-file-name=/home/runner/.ya/build/build_root/g81u/004d6f/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_v5xlkn03.log --grpc-port=17919 --mon-port=10209 --ic-port=24456
2025-11-01 04:21:02,050 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/g81u/004d6f/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:10118', '--tenant=/Root/db1', '--log-file-name=/home/runner/.ya/build/build_root/g81u/004d6f/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_v5xlkn03.log', '--grpc-port=17919', '--mon-port=10209', '--ic-port=24456')' in '/home/runner/.ya/build/build_root/g81u/004d6f/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-11-01 04:21:02,051 - DEBUG - ya.test - execute: Command pid: 2591237
2025-11-01 04:21:02,051 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:17919/3
2025-11-01 04:21:02,052 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.4
2025-11-01 04:21:02,052 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.4
2025-11-01 04:21:02,052 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 04:21:02,053 - DEBUG - ya.test - execute: Command pid: 2591238
2025-11-01 04:21:02,416 - DEBUG - ya.test - _save_outputs: Command (pid 2591238) rc: 0
2025-11-01 04:21:02,416 - DEBUG - ya.test - _save_outputs: Command (pid 2591238) elapsed time (sec): 0.3622450828552246
2025-11-01 04:21:02,416 - DEBUG - ya.test - _save_outputs: Command (pid 2591238) idrss: 0
2025-11-01 04:21:02,417 - DEBUG - ya.test - _save_outputs: Command (pid 2591238) inblock: 0
2025-11-01 04:21:02,417 - DEBUG - ya.test - _save_outputs: Command (pid 2591238) isrss: 0
2025-11-01 04:21:02,417 - DEBUG - ya.test - _save_outputs: Command (pid 2591238) ixrss: 0
2025-11-01 04:21:02,417 - DEBUG - ya.test - _save_outputs: Command (pid 2591238) majflt: 0
2025-11-01 04:21:02,417 - DEBUG - ya.test - _save_outputs: Command (pid 2591238) maxrss: 538372
2025-11-01 04:21:02,417 - DEBUG - ya.test - _save_outputs: Command (pid 2591238) minflt: 16128
2025-11-01 04:21:02,417 - DEBUG - ya.test - _save_outputs: Command (pid 2591238) msgrcv: 0
2025-11-01 04:21:02,417 - DEBUG - ya.test - _save_outputs: Command (pid 2591238) msgsnd: 0
2025-11-01 04:21:02,417 - DEBUG - ya.test - _save_outputs: Command (pid 2591238) nivcsw: 3
2025-11-01 04:21:02,418 - DEBUG - ya.test - _save_outputs: Command (pid 2591238) nsignals: 0
2025-11-01 04:21:02,418 - DEBUG - ya.test - _save_outputs: Command (pid 2591238) nswap: 0
2025-11-01 04:21:02,418 - DEBUG - ya.test - _save_outputs: Command (pid 2591238) nvcsw: 14
2025-11-01 04:21:02,418 - DEBUG - ya.test - _save_outputs: Command (pid 2591238) oublock: 8
2025-11-01 04:21:02,418 - DEBUG - ya.test - _save_outputs: Command (pid 2591238) stime: 0.21862299999999998
2025-11-01 04:21:02,418 - DEBUG - ya.test - _save_outputs: Command (pid 2591238) utime: 0.095399
2025-11-01 04:21:02,418 - DEBUG - ya.test - _save_outputs: Command (pid 2591238) wtime: 0.363
2025-11-01 04:21:02,418 - DEBUG - ya.test - _save_outputs: Command (pid 2591238) output:
Git info:
    Commit: 767d72532e5716ba790791cf237fdadb24b0e578
    Branch: 
    Author: Innokentii Mokin <enjection@ya.ru>
    Summary: Merge 96af589a3c3d7740081955df0fe84da0a7b35651 into 2afee58ebdae8491f810ad53605d37376c4e5de6

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

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

2025-11-01 04:21:02,419 - DEBUG - ya.test - _save_outputs: Command (pid 2591238) errors:

2025-11-01 04:21:02,419 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 3 version:
Git info:
    Commit: 767d72532e5716ba790791cf237fdadb24b0e578
    Branch: 
    Author: Innokentii Mokin <enjection@ya.ru>
    Summary: Merge 96af589a3c3d7740081955df0fe84da0a7b35651 into 2afee58ebdae8491f810ad53605d37376c4e5de6
2025-11-01 04:22:53,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-11-01 04:22:53,601 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 04:22:53,603 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 04:22:53,617 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/db1
2025-11-01 04:22:53,617 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 23d428bc-c470-444c-b994-b36beae1d067, localhost:10118): creating call state
2025-11-01 04:22:53,618 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 23d428bc-c470-444c-b994-b36beae1d067, localhost:10118): request = { database: "/Root/db1" }
2025-11-01 04:22:53,622 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 23d428bc-c470-444c-b994-b36beae1d067, localhost:10118): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-i4gyxlpqdu.auto.internal" port: 63312 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" node_id: 50000 } self_location: "1" } } } }
2025-11-01 04:22:53,622 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root/db1: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-i4gyxlpqdu.auto.internal:63312, location , ssl: False>]>
2025-11-01 04:22:53,623 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 04:22:53,631 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:10118
2025-11-01 04:22:53,699 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd
2025-11-01 04:22:53,700 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/31478
2025-11-01 04:22:53,701 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/g81u/004d6f/r3tmp/kikimr_restore_cluster_4flerj9h
2025-11-01 04:22:53,741 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd
2025-11-01 04:22:53,741 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/2836
2025-11-01 04:22:53,742 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/1497
2025-11-01 04:22:53,742 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/26524
2025-11-01 04:22:53,744 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/9921
2025-11-01 04:22:53,745 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/g81u/004d6f/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-11-01 04:22:53,745 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/g81u/004d6f/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/g81u/004d6f/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_kvksi120.log --grpc-port=2836 --mon-port=1497 --ic-port=31478
2025-11-01 04:22:53,745 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:2836/1, disk_size 68719476736
2025-11-01 04:22:53,746 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/g81u/004d6f/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-11-01 04:22:53,746 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/g81u/004d6f/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/g81u/004d6f/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_kvksi120.log --grpc-port=2836 --mon-port=1497 --ic-port=31478
2025-11-01 04:22:53,747 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/g81u/004d6f/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/g81u/004d6f/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_kvksi120.log', '--grpc-port=2836', '--mon-port=1497', '--ic-port=31478')' in '/home/runner/.ya/build/build_root/g81u/004d6f/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-11-01 04:22:53,749 - DEBUG - ya.test - execute: Command pid: 2666803
2025-11-01 04:22:53,749 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:2836/1
2025-11-01 04:22:53,750 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.5
2025-11-01 04:22:53,751 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.5
2025-11-01 04:22:53,751 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 04:22:53,754 - DEBUG - ya.test - execute: Command pid: 2666804
2025-11-01 04:22:55,387 - DEBUG - ya.test - _save_outputs: Command (pid 2666804) rc: 0
2025-11-01 04:22:55,387 - DEBUG - ya.test - _save_outputs: Command (pid 2666804) elapsed time (sec): 1.6314070224761963
2025-11-01 04:22:55,387 - DEBUG - ya.test - _save_outputs: Command (pid 2666804) idrss: 0
2025-11-01 04:22:55,388 - DEBUG - ya.test - _save_outputs: Command (pid 2666804) inblock: 0
2025-11-01 04:22:55,388 - DEBUG - ya.test - _save_outputs: Command (pid 2666804) isrss: 0
2025-11-01 04:22:55,388 - DEBUG - ya.test - _save_outputs: Command (pid 2666804) ixrss: 0
2025-11-01 04:22:55,388 - DEBUG - ya.test - _save_outputs: Command (pid 2666804) majflt: 0
2025-11-01 04:22:55,388 - DEBUG - ya.test - _save_outputs: Command (pid 2666804) maxrss: 538372
2025-11-01 04:22:55,388 - DEBUG - ya.test - _save_outputs: Command (pid 2666804) minflt: 16129
2025-11-01 04:22:55,389 - DEBUG - ya.test - _save_outputs: Command (pid 2666804) msgrcv: 0
2025-11-01 04:22:55,389 - DEBUG - ya.test - _save_outputs: Command (pid 2666804) msgsnd: 0
2025-11-01 04:22:55,389 - DEBUG - ya.test - _save_outputs: Command (pid 2666804) nivcsw: 111
2025-11-01 04:22:55,389 - DEBUG - ya.test - _save_outputs: Command (pid 2666804) nsignals: 0
2025-11-01 04:22:55,389 - DEBUG - ya.test - _save_outputs: Command (pid 2666804) nswap: 0
2025-11-01 04:22:55,389 - DEBUG - ya.test - _save_outputs: Command (pid 2666804) nvcsw: 19
2025-11-01 04:22:55,390 - DEBUG - ya.test - _save_outputs: Command (pid 2666804) oublock: 8
2025-11-01 04:22:55,390 - DEBUG - ya.test - _save_outputs: Command (pid 2666804) stime: 1.452147
2025-11-01 04:22:55,390 - DEBUG - ya.test - _save_outputs: Command (pid 2666804) utime: 0.111397
2025-11-01 04:22:55,390 - DEBUG - ya.test - _save_outputs: Command (pid 2666804) wtime: 1.635
2025-11-01 04:22:55,395 - DEBUG - ya.test - _save_outputs: Command (pid 2666804) output:
Git info:
    Commit: 767d72532e5716ba790791cf237fdadb24b0e578
    Branch: 
    Author: Innokentii Mokin <enjection@ya.ru>
    Summary: Merge 96af589a3c3d7740081955df0fe84da0a7b35651 into 2afee58ebdae8491f810ad53605d37376c4e5de6

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

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

2025-11-01 04:22:55,395 - DEBUG - ya.test - _save_outputs: Command (pid 2666804) errors:

2025-11-01 04:22:55,395 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 767d72532e5716ba790791cf237fdadb24b0e578
    Branch: 
    Author: Innokentii Mokin <enjection@ya.ru>
    Summary: Merge 96af589a3c3d7740081955df0fe84da0a7b35651 into 2afee58ebdae8491f810ad53605d37376c4e5de6
2025-11-01 04:22:59,662 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd
2025-11-01 04:22:59,663 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:2836', '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: 31478\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-01 04:22:59,663 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.6
2025-11-01 04:22:59,664 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.6
2025-11-01 04:22:59,664 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:2836', '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: 31478\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-01 04:22:59,665 - DEBUG - ya.test - execute: Command pid: 2669743
2025-11-01 04:23:03,853 - DEBUG - ya.test - _save_outputs: Command (pid 2669743) rc: 0
2025-11-01 04:23:03,853 - DEBUG - ya.test - _save_outputs: Command (pid 2669743) elapsed time (sec): 4.187737464904785
2025-11-01 04:23:03,854 - DEBUG - ya.test - _save_outputs: Command (pid 2669743) idrss: 0
2025-11-01 04:23:03,854 - DEBUG - ya.test - _save_outputs: Command (pid 2669743) inblock: 0
2025-11-01 04:23:03,854 - DEBUG - ya.test - _save_outputs: Command (pid 2669743) isrss: 0
2025-11-01 04:23:03,854 - DEBUG - ya.test - _save_outputs: Command (pid 2669743) ixrss: 0
2025-11-01 04:23:03,854 - DEBUG - ya.test - _save_outputs: Command (pid 2669743) majflt: 0
2025-11-01 04:23:03,854 - DEBUG - ya.test - _save_outputs: Command (pid 2669743) maxrss: 546780
2025-11-01 04:23:03,855 - DEBUG - ya.test - _save_outputs: Command (pid 2669743) minflt: 18271
2025-11-01 04:23:03,855 - DEBUG - ya.test - _save_outputs: Command (pid 2669743) msgrcv: 0
2025-11-01 04:23:03,855 - DEBUG - ya.test - _save_outputs: Command (pid 2669743) msgsnd: 0
2025-11-01 04:23:03,855 - DEBUG - ya.test - _save_outputs: Command (pid 2669743) nivcsw: 654
2025-11-01 04:23:03,855 - DEBUG - ya.test - _save_outputs: Command (pid 2669743) nsignals: 0
2025-11-01 04:23:03,855 - DEBUG - ya.test - _save_outputs: Command (pid 2669743) nswap: 0
2025-11-01 04:23:03,856 - DEBUG - ya.test - _save_outputs: Command (pid 2669743) nvcsw: 139
2025-11-01 04:23:03,856 - DEBUG - ya.test - _save_outputs: Command (pid 2669743) oublock: 8
2025-11-01 04:23:03,856 - DEBUG - ya.test - _save_outputs: Command (pid 2669743) stime: 3.721717
2025-11-01 04:23:03,856 - DEBUG - ya.test - _save_outputs: Command (pid 2669743) utime: 0.12312999999999999
2025-11-01 04:23:03,856 - DEBUG - ya.test - _save_outputs: Command (pid 2669743) wtime: 4.189
2025-11-01 04:23:03,856 - DEBUG - ya.test - _save_outputs: Command (pid 2669743) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 4

2025-11-01 04:23:03,857 - DEBUG - ya.test - _save_outputs: Command (pid 2669743) errors:

2025-11-01 04:23:03,857 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd
2025-11-01 04:23:03,858 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:2836', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']
2025-11-01 04:23:03,858 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.7
2025-11-01 04:23:03,859 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.7
2025-11-01 04:23:03,859 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:2836', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-01 04:23:03,866 - DEBUG - ya.test - execute: Command pid: 2671352
2025-11-01 04:23:09,129 - DEBUG - ya.test - _save_outputs: Command (pid 2671352) rc: 0
2025-11-01 04:23:09,129 - DEBUG - ya.test - _save_outputs: Command (pid 2671352) elapsed time (sec): 5.262016773223877
2025-11-01 04:23:09,129 - DEBUG - ya.test - _save_outputs: Command (pid 2671352) idrss: 0
2025-11-01 04:23:09,129 - DEBUG - ya.test - _save_outputs: Command (pid 2671352) inblock: 0
2025-11-01 04:23:09,130 - DEBUG - ya.test - _save_outputs: Command (pid 2671352) isrss: 0
2025-11-01 04:23:09,130 - DEBUG - ya.test - _save_outputs: Command (pid 2671352) ixrss: 0
2025-11-01 04:23:09,130 - DEBUG - ya.test - _save_outputs: Command (pid 2671352) majflt: 0
2025-11-01 04:23:09,130 - DEBUG - ya.test - _save_outputs: Command (pid 2671352) maxrss: 546804
2025-11-01 04:23:09,130 - DEBUG - ya.test - _save_outputs: Command (pid 2671352) minflt: 18274
2025-11-01 04:23:09,131 - DEBUG - ya.test - _save_outputs: Command (pid 2671352) msgrcv: 0
2025-11-01 04:23:09,131 - DEBUG - ya.test - _save_outputs: Command (pid 2671352) msgsnd: 0
2025-11-01 04:23:09,131 - DEBUG - ya.test - _save_outputs: Command (pid 2671352) nivcsw: 587
2025-11-01 04:23:09,131 - DEBUG - ya.test - _save_outputs: Command (pid 2671352) nsignals: 0
2025-11-01 04:23:09,131 - DEBUG - ya.test - _save_outputs: Command (pid 2671352) nswap: 0
2025-11-01 04:23:09,131 - DEBUG - ya.test - _save_outputs: Command (pid 2671352) nvcsw: 124
2025-11-01 04:23:09,132 - DEBUG - ya.test - _save_outputs: Command (pid 2671352) oublock: 8
2025-11-01 04:23:09,132 - DEBUG - ya.test - _save_outputs: Command (pid 2671352) stime: 4.735562
2025-11-01 04:23:09,132 - DEBUG - ya.test - _save_outputs: Command (pid 2671352) utime: 0.11484
2025-11-01 04:23:09,132 - DEBUG - ya.test - _save_outputs: Command (pid 2671352) wtime: 5.269
2025-11-01 04:23:09,132 - DEBUG - ya.test - _save_outputs: Command (pid 2671352) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-01 04:23:09,132 - DEBUG - ya.test - _save_outputs: Command (pid 2671352) errors:

2025-11-01 04:23:09,133 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root2: {'dynamic_storage_pool:1': 'hdd'}
2025-11-01 04:23:09,198 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-11-01 04:23:09,245 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd
2025-11-01 04:23:09,246 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/13347
2025-11-01 04:23:09,246 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/3802
2025-11-01 04:23:09,246 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/16369
2025-11-01 04:23:09,247 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/19542
2025-11-01 04:23:09,247 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/2511
2025-11-01 04:23:09,248 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/g81u/004d6f/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-11-01 04:23:09,248 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:2836 --tenant=/Root2/db1 --log-file-name=/home/runner/.ya/build/build_root/g81u/004d6f/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_a3jl80g7.log --grpc-port=13347 --mon-port=3802 --ic-port=16369
2025-11-01 04:23:09,248 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/g81u/004d6f/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-11-01 04:23:09,248 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:2836 --tenant=/Root2/db1 --log-file-name=/home/runner/.ya/build/build_root/g81u/004d6f/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_a3jl80g7.log --grpc-port=13347 --mon-port=3802 --ic-port=16369
2025-11-01 04:23:09,249 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/g81u/004d6f/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:2836', '--tenant=/Root2/db1', '--log-file-name=/home/runner/.ya/build/build_root/g81u/004d6f/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_a3jl80g7.log', '--grpc-port=13347', '--mon-port=3802', '--ic-port=16369')' in '/home/runner/.ya/build/build_root/g81u/004d6f/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-11-01 04:23:09,253 - DEBUG - ya.test - execute: Command pid: 2673537
2025-11-01 04:23:09,253 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:13347/1
2025-11-01 04:23:09,255 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.8
2025-11-01 04:23:09,255 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.8
2025-11-01 04:23:09,255 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 04:23:09,256 - DEBUG - ya.test - execute: Command pid: 2673538
2025-11-01 04:23:10,581 - DEBUG - ya.test - _save_outputs: Command (pid 2673538) rc: 0
2025-11-01 04:23:10,581 - DEBUG - ya.test - _save_outputs: Command (pid 2673538) elapsed time (sec): 1.3238563537597656
2025-11-01 04:23:10,582 - DEBUG - ya.test - _save_outputs: Command (pid 2673538) idrss: 0
2025-11-01 04:23:10,582 - DEBUG - ya.test - _save_outputs: Command (pid 2673538) inblock: 0
2025-11-01 04:23:10,582 - DEBUG - ya.test - _save_outputs: Command (pid 2673538) isrss: 0
2025-11-01 04:23:10,582 - DEBUG - ya.test - _save_outputs: Command (pid 2673538) ixrss: 0
2025-11-01 04:23:10,582 - DEBUG - ya.test - _save_outputs: Command (pid 2673538) majflt: 0
2025-11-01 04:23:10,583 - DEBUG - ya.test - _save_outputs: Command (pid 2673538) maxrss: 538372
2025-11-01 04:23:10,583 - DEBUG - ya.test - _save_outputs: Command (pid 2673538) minflt: 16139
2025-11-01 04:23:10,583 - DEBUG - ya.test - _save_outputs: Command (pid 2673538) msgrcv: 0
2025-11-01 04:23:10,583 - DEBUG - ya.test - _save_outputs: Command (pid 2673538) msgsnd: 0
2025-11-01 04:23:10,583 - DEBUG - ya.test - _save_outputs: Command (pid 2673538) nivcsw: 142
2025-11-01 04:23:10,584 - DEBUG - ya.test - _save_outputs: Command (pid 2673538) nsignals: 0
2025-11-01 04:23:10,584 - DEBUG - ya.test - _save_outputs: Command (pid 2673538) nswap: 0
2025-11-01 04:23:10,584 - DEBUG - ya.test - _save_outputs: Command (pid 2673538) nvcsw: 21
2025-11-01 04:23:10,584 - DEBUG - ya.test - _save_outputs: Command (pid 2673538) oublock: 8
2025-11-01 04:23:10,584 - DEBUG - ya.test - _save_outputs: Command (pid 2673538) stime: 0.992389
2025-11-01 04:23:10,585 - DEBUG - ya.test - _save_outputs: Command (pid 2673538) utime: 0.127283
2025-11-01 04:23:10,585 - DEBUG - ya.test - _save_outputs: Command (pid 2673538) wtime: 1.325
2025-11-01 04:23:10,585 - DEBUG - ya.test - _save_outputs: Command (pid 2673538) output:
Git info:
    Commit: 767d72532e5716ba790791cf237fdadb24b0e578
    Branch: 
    Author: Innokentii Mokin <enjection@ya.ru>
    Summary: Merge 96af589a3c3d7740081955df0fe84da0a7b35651 into 2afee58ebdae8491f810ad53605d37376c4e5de6

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

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

2025-11-01 04:23:10,586 - DEBUG - ya.test - _save_outputs: Command (pid 2673538) errors:

2025-11-01 04:23:10,586 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 767d72532e5716ba790791cf237fdadb24b0e578
    Branch: 
    Author: Innokentii Mokin <enjection@ya.ru>
    Summary: Merge 96af589a3c3d7740081955df0fe84da0a7b35651 into 2afee58ebdae8491f810ad53605d37376c4e5de6
2025-11-01 04:23:10,586 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 04:23:10,592 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 04:23:10,593 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_ydb_backup.py::TestDatabaseBackupRestore, test_name: test_database_backup_restore)
2025-11-01 04:23:10,599 - DEBUG - ydb.table.SessionPool - subscribe: Active session queue is empty, subscribe waiter for a session
2025-11-01 04:23:10,599 - DEBUG - ydb.table.SessionPool - subscribe: Subscribe waiter <Future at 0x7fce4ffe5410 state=pending>
2025-11-01 04:23:10,600 - DEBUG - ydb.table.SessionPool - subscribe: Session pool is not large enough (active_count < size: 0 < 100). will create a new session.
2025-11-01 04:23:10,600 - DEBUG - ydb.table.SessionPool - _create: Created session <ydb.table.Session object at 0x7fce4ffe4650>
2025-11-01 04:23:10,600 - DEBUG - ydb.table.SessionPool - _prepare: Preparing session <ydb.table.Session object at 0x7fce4ffe4650>
2025-11-01 04:23:10,601 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 67cba876-3632-450f-b5c3-3d374ed22b2d, ghrun-i4gyxlpqdu.auto.internal:63312): creating call state
2025-11-01 04:23:10,601 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 67cba876-3632-450f-b5c3-3d374ed22b2d, ghrun-i4gyxlpqdu.auto.internal:63312): request = { operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-11-01 04:23:10,609 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, 67cba876-3632-450f-b5c3-3d374ed22b2d, ghrun-i4gyxlpqdu.auto.internal:63312): on response callback started
2025-11-01 04:23:10,610 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 67cba876-3632-450f-b5c3-3d374ed22b2d, ghrun-i4gyxlpqdu.auto.internal:63312): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=50000&id=NzY1YTkyZDUtN2ZkZmM0YTYtYzIxYTYwOTMtYWFmZTY0Njc=" } } } }
2025-11-01 04:23:10,611 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, 67cba876-3632-450f-b5c3-3d374ed22b2d, ghrun-i4gyxlpqdu.auto.internal:63312): on response callback success
2025-11-01 04:23:10,611 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fce4ffe4650>
2025-11-01 04:23:10,611 - DEBUG - ydb.table.SessionPool - put: Replying to waiter with a session <ydb.table.Session object at 0x7fce4ffe4650>
2025-11-01 04:23:10,611 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, d83e5c49-b3b2-4093-8b90-983745c5af88, ghrun-i4gyxlpqdu.auto.internal:63312): creating call state
2025-11-01 04:23:10,612 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, d83e5c49-b3b2-4093-8b90-983745c5af88, ghrun-i4gyxlpqdu.auto.internal:63312): request = { session_id: "ydb://session/3?node_id=50000&id=NzY1YTkyZDUtN2ZkZmM0YTYtYzIxYTYwOTMtYWFmZTY0Njc=" yql_text: "CREATE GROUP people" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:23:10,614 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-11-01 04:23:10,614 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, ac4b5ff9-36f7-4680-8b17-a4804fbdfc57, localhost:2836): creating call state
2025-11-01 04:23:10,615 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, ac4b5ff9-36f7-4680-8b17-a4804fbdfc57, localhost:2836): request = { database: "/Root2/db1" }
2025-11-01 04:23:10,617 - DEBUG - ydb.connection - _rpc_error_handler: RpcState(ListEndpoints, ac4b5ff9-36f7-4680-8b17-a4804fbdfc57, localhost:2836): received error, <_InactiveRpcError of RPC that terminated with:
	status = StatusCode.UNAUTHENTICATED
	details = "unauthenticated, unauthenticated, Unknown database"
	debug_error_string = "UNKNOWN:Error received from peer  {file:"/home/runner/actions_runner/_work/ydb/ydb/contrib/libs/grpc/src/core/lib/surface/call.cc", file_line:1211, created_time:"2025-11-01T04:23:10.61675623+00:00", grpc_status:16, grpc_message:"unauthenticated, unauthenticated, Unknown database"}"
>
2025-11-01 04:23:10,617 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:2836". Error details:
 unauthenticated, unauthenticated, Unknown database
2025-11-01 04:23:10,617 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:2836
2025-11-01 04:23:10,634 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, d83e5c49-b3b2-4093-8b90-983745c5af88, ghrun-i4gyxlpqdu.auto.internal:63312): response = { operation { ready: true status: SUCCESS } }
2025-11-01 04:23:10,635 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, 0a7a72ec-d670-47fd-a92d-4bb486b21a1c, ghrun-i4gyxlpqdu.auto.internal:63312): creating call state
2025-11-01 04:23:10,635 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, 0a7a72ec-d670-47fd-a92d-4bb486b21a1c, ghrun-i4gyxlpqdu.auto.internal:63312): request = { session_id: "ydb://session/3?node_id=50000&id=NzY1YTkyZDUtN2ZkZmM0YTYtYzIxYTYwOTMtYWFmZTY0Njc=" yql_text: "CREATE USER alice PASSWORD \'1234\'" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:23:10,673 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, 0a7a72ec-d670-47fd-a92d-4bb486b21a1c, ghrun-i4gyxlpqdu.auto.internal:63312): response = { operation { ready: true status: SUCCESS } }
2025-11-01 04:23:10,674 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, 9e1f94a6-647d-413e-8066-914b08733acd, ghrun-i4gyxlpqdu.auto.internal:63312): creating call state
2025-11-01 04:23:10,675 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, 9e1f94a6-647d-413e-8066-914b08733acd, ghrun-i4gyxlpqdu.auto.internal:63312): request = { session_id: "ydb://session/3?node_id=50000&id=NzY1YTkyZDUtN2ZkZmM0YTYtYzIxYTYwOTMtYWFmZTY0Njc=" yql_text: "CREATE USER bob PASSWORD \'1234\'" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:23:10,701 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, 9e1f94a6-647d-413e-8066-914b08733acd, ghrun-i4gyxlpqdu.auto.internal:63312): response = { operation { ready: true status: SUCCESS } }
2025-11-01 04:23:10,702 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, d8075766-ab9a-4f7a-8882-b28bb445987f, ghrun-i4gyxlpqdu.auto.internal:63312): creating call state
2025-11-01 04:23:10,703 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, d8075766-ab9a-4f7a-8882-b28bb445987f, ghrun-i4gyxlpqdu.auto.internal:63312): request = { session_id: "ydb://session/3?node_id=50000&id=NzY1YTkyZDUtN2ZkZmM0YTYtYzIxYTYwOTMtYWFmZTY0Njc=" yql_text: "ALTER GROUP people ADD USER alice" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:23:10,723 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, d8075766-ab9a-4f7a-8882-b28bb445987f, ghrun-i4gyxlpqdu.auto.internal:63312): response = { operation { ready: true status: SUCCESS } }
2025-11-01 04:23:10,724 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, e3f9cc94-bb6f-411b-a118-0be4328bafd6, ghrun-i4gyxlpqdu.auto.internal:63312): creating call state
2025-11-01 04:23:10,724 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, e3f9cc94-bb6f-411b-a118-0be4328bafd6, ghrun-i4gyxlpqdu.auto.internal:63312): request = { session_id: "ydb://session/3?node_id=50000&id=NzY1YTkyZDUtN2ZkZmM0YTYtYzIxYTYwOTMtYWFmZTY0Njc=" yql_text: "ALTER GROUP people ADD USER bob" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:23:10,758 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, e3f9cc94-bb6f-411b-a118-0be4328bafd6, ghrun-i4gyxlpqdu.auto.internal:63312): response = { operation { ready: true status: SUCCESS } }
2025-11-01 04:23:10,759 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, 8bb3553f-c154-4811-9069-286813b735c9, ghrun-i4gyxlpqdu.auto.internal:63312): creating call state
2025-11-01 04:23:10,759 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, 8bb3553f-c154-4811-9069-286813b735c9, ghrun-i4gyxlpqdu.auto.internal:63312): request = { session_id: "ydb://session/3?node_id=50000&id=NzY1YTkyZDUtN2ZkZmM0YTYtYzIxYTYwOTMtYWFmZTY0Njc=" yql_text: "CREATE GROUP dbadmins" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:23:10,771 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, 8bb3553f-c154-4811-9069-286813b735c9, ghrun-i4gyxlpqdu.auto.internal:63312): response = { operation { ready: true status: SUCCESS } }
2025-11-01 04:23:10,772 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, 2f1ac37e-ecdb-4267-9ae1-db3e653412ae, ghrun-i4gyxlpqdu.auto.internal:63312): creating call state
2025-11-01 04:23:10,772 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, 2f1ac37e-ecdb-4267-9ae1-db3e653412ae, ghrun-i4gyxlpqdu.auto.internal:63312): request = { session_id: "ydb://session/3?node_id=50000&id=NzY1YTkyZDUtN2ZkZmM0YTYtYzIxYTYwOTMtYWFmZTY0Njc=" yql_text: "CREATE USER dbadmin1" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:23:10,793 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, 2f1ac37e-ecdb-4267-9ae1-db3e653412ae, ghrun-i4gyxlpqdu.auto.internal:63312): response = { operation { ready: true status: SUCCESS } }
2025-11-01 04:23:10,794 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, b6051b4a-c9a4-4f20-b30c-ab11595d852d, ghrun-i4gyxlpqdu.auto.internal:63312): creating call state
2025-11-01 04:23:10,794 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, b6051b4a-c9a4-4f20-b30c-ab11595d852d, ghrun-i4gyxlpqdu.auto.internal:63312): request = { session_id: "ydb://session/3?node_id=50000&id=NzY1YTkyZDUtN2ZkZmM0YTYtYzIxYTYwOTMtYWFmZTY0Njc=" yql_text: "CREATE USER dbadmin2 PASSWORD \'1234\'" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:23:10,813 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, b6051b4a-c9a4-4f20-b30c-ab11595d852d, ghrun-i4gyxlpqdu.auto.internal:63312): response = { operation { ready: true status: SUCCESS } }
2025-11-01 04:23:10,813 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, 2228ab4d-87f9-4ee4-b0e0-27a47482d764, ghrun-i4gyxlpqdu.auto.internal:63312): creating call state
2025-11-01 04:23:10,814 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, 2228ab4d-87f9-4ee4-b0e0-27a47482d764, ghrun-i4gyxlpqdu.auto.internal:63312): request = { session_id: "ydb://session/3?node_id=50000&id=NzY1YTkyZDUtN2ZkZmM0YTYtYzIxYTYwOTMtYWFmZTY0Njc=" yql_text: "ALTER GROUP dbadmins ADD USER dbadmin1" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:23:10,821 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, 2228ab4d-87f9-4ee4-b0e0-27a47482d764, ghrun-i4gyxlpqdu.auto.internal:63312): response = { operation { ready: true status: SUCCESS } }
2025-11-01 04:23:10,821 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, 18760cc3-52b7-45a7-a7ea-b851953afed0, ghrun-i4gyxlpqdu.auto.internal:63312): creating call state
2025-11-01 04:23:10,822 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, 18760cc3-52b7-45a7-a7ea-b851953afed0, ghrun-i4gyxlpqdu.auto.internal:63312): request = { session_id: "ydb://session/3?node_id=50000&id=NzY1YTkyZDUtN2ZkZmM0YTYtYzIxYTYwOTMtYWFmZTY0Njc=" yql_text: "ALTER GROUP dbadmins ADD USER dbadmin2" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:23:10,828 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, 18760cc3-52b7-45a7-a7ea-b851953afed0, ghrun-i4gyxlpqdu.auto.internal:63312): response = { operation { ready: true status: SUCCESS } }
2025-11-01 04:23:10,829 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, ee233bb9-3de8-442d-a557-14af58dd9944, ghrun-i4gyxlpqdu.auto.internal:63312): creating call state
2025-11-01 04:23:10,829 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, ee233bb9-3de8-442d-a557-14af58dd9944, ghrun-i4gyxlpqdu.auto.internal:63312): request = { session_id: "ydb://session/3?node_id=50000&id=NzY1YTkyZDUtN2ZkZmM0YTYtYzIxYTYwOTMtYWFmZTY0Njc=" yql_text: "GRANT \"ydb.generic.use\" on `/Root/db1` TO dbadmins" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:23:10,838 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, ee233bb9-3de8-442d-a557-14af58dd9944, ghrun-i4gyxlpqdu.auto.internal:63312): response = { operation { ready: true status: SUCCESS } }
2025-11-01 04:23:10,838 - DEBUG - ydb.connection - _prepare_call: RpcState(ModifyPermissions, 44f66ef0-3188-47d1-a340-4476e70f3a9a, ghrun-i4gyxlpqdu.auto.internal:63312): creating call state
2025-11-01 04:23:10,839 - DEBUG - ydb.connection - _log_request: RpcState(ModifyPermissions, 44f66ef0-3188-47d1-a340-4476e70f3a9a, ghrun-i4gyxlpqdu.auto.internal:63312): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/db1" actions { change_owner: "dbadmins" } }
2025-11-01 04:23:10,845 - DEBUG - ydb.connection - _log_response: RpcState(ModifyPermissions, 44f66ef0-3188-47d1-a340-4476e70f3a9a, ghrun-i4gyxlpqdu.auto.internal:63312): response = { operation { ready: true status: SUCCESS } }
2025-11-01 04:23:10,846 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fce4ffe4650>
2025-11-01 04:23:10,846 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 9ea092e2-98d6-4a38-a541-8520a4c6bdf8, ghrun-i4gyxlpqdu.auto.internal:63312): creating call state
2025-11-01 04:23:10,847 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 9ea092e2-98d6-4a38-a541-8520a4c6bdf8, ghrun-i4gyxlpqdu.auto.internal:63312): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:23:10,849 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 9ea092e2-98d6-4a38-a541-8520a4c6bdf8, ghrun-i4gyxlpqdu.auto.internal:63312): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=50000&id=NTkyYzAwOGItNGQ0OGY0OGEtNWQ4ZWNjOTMtZmMwNmY4NWU=" } } } }
2025-11-01 04:23:10,850 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, c1a371fa-7ff8-451a-ad17-14b5b14af026, ghrun-i4gyxlpqdu.auto.internal:63312): creating call state
2025-11-01 04:23:10,850 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, c1a371fa-7ff8-451a-ad17-14b5b14af026, ghrun-i4gyxlpqdu.auto.internal:63312): request = { session_id: "ydb://session/3?node_id=50000&id=NTkyYzAwOGItNGQ0OGY0OGEtNWQ4ZWNjOTMtZmMwNmY4NWU=" 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-11-01 04:23:10,886 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, c1a371fa-7ff8-451a-ad17-14b5b14af026, ghrun-i4gyxlpqdu.auto.internal:63312): response = { operation { ready: true status: SUCCESS } }
2025-11-01 04:23:10,887 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, c1ddd0f9-1f9f-4f61-a060-fb059c96d2cd, ghrun-i4gyxlpqdu.auto.internal:63312): creating call state
2025-11-01 04:23:10,888 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, c1ddd0f9-1f9f-4f61-a060-fb059c96d2cd, ghrun-i4gyxlpqdu.auto.internal:63312): request = { session_id: "ydb://session/3?node_id=50000&id=NTkyYzAwOGItNGQ0OGY0OGEtNWQ4ZWNjOTMtZmMwNmY4NWU=" 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-11-01 04:23:10,926 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, c1ddd0f9-1f9f-4f61-a060-fb059c96d2cd, ghrun-i4gyxlpqdu.auto.internal:63312): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-11-01 04:23:10,927 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydb/ydb
2025-11-01 04:23:10,928 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out
2025-11-01 04:23:10,928 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err
2025-11-01 04:23:10,928 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydb/ydb', '--verbose', '--endpoint', 'grpc://localhost:10118', '--database', '/Root', 'admin', 'cluster', 'dump', '--output', '/home/runner/.ya/build/build_root/g81u/004d6f/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-11-01 04:23:10,930 - DEBUG - ya.test - execute: Command pid: 2674420
2025-11-01 04:23:11,313 - DEBUG - ya.test - _save_outputs: Command (pid 2674420) rc: 0
2025-11-01 04:23:11,313 - DEBUG - ya.test - _save_outputs: Command (pid 2674420) elapsed time (sec): 0.38283300399780273
2025-11-01 04:23:11,314 - DEBUG - ya.test - _save_outputs: Command (pid 2674420) idrss: 0
2025-11-01 04:23:11,314 - DEBUG - ya.test - _save_outputs: Command (pid 2674420) inblock: 0
2025-11-01 04:23:11,314 - DEBUG - ya.test - _save_outputs: Command (pid 2674420) isrss: 0
2025-11-01 04:23:11,314 - DEBUG - ya.test - _save_outputs: Command (pid 2674420) ixrss: 0
2025-11-01 04:23:11,314 - DEBUG - ya.test - _save_outputs: Command (pid 2674420) majflt: 0
2025-11-01 04:23:11,314 - DEBUG - ya.test - _save_outputs: Command (pid 2674420) maxrss: 172384
2025-11-01 04:23:11,315 - DEBUG - ya.test - _save_outputs: Command (pid 2674420) minflt: 3647
2025-11-01 04:23:11,315 - DEBUG - ya.test - _save_outputs: Command (pid 2674420) msgrcv: 0
2025-11-01 04:23:11,315 - DEBUG - ya.test - _save_outputs: Command (pid 2674420) msgsnd: 0
2025-11-01 04:23:11,315 - DEBUG - ya.test - _save_outputs: Command (pid 2674420) nivcsw: 18
2025-11-01 04:23:11,315 - DEBUG - ya.test - _save_outputs: Command (pid 2674420) nsignals: 0
2025-11-01 04:23:11,315 - DEBUG - ya.test - _save_outputs: Command (pid 2674420) nswap: 0
2025-11-01 04:23:11,315 - DEBUG - ya.test - _save_outputs: Command (pid 2674420) nvcsw: 318
2025-11-01 04:23:11,316 - DEBUG - ya.test - _save_outputs: Command (pid 2674420) oublock: 72
2025-11-01 04:23:11,316 - DEBUG - ya.test - _save_outputs: Command (pid 2674420) stime: 0.031486
2025-11-01 04:23:11,316 - DEBUG - ya.test - _save_outputs: Command (pid 2674420) utime: 0.06279599999999999
2025-11-01 04:23:11,316 - DEBUG - ya.test - _save_outputs: Command (pid 2674420) wtime: 0.384
2025-11-01 04:23:11,316 - DEBUG - ya.test - _save_outputs: Command (pid 2674420) output:

2025-11-01 04:23:11,316 - DEBUG - ya.test - _save_outputs: Command (pid 2674420) errors:
Using auth method "token" from YDB_TOKEN enviroment variable
2025-11-01T04:23:11.036458Z :INFO: Backup cluster to "/home/runner/.ya/build/build_root/g81u/004d6f/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/cluster_backup"
2025-11-01T04:23:11.044398Z :INFO: Backup cluster root "/Root" to /home/runner/.ya/build/build_root/g81u/004d6f/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/cluster_backup
2025-11-01T04:23:11.097938Z :DEBUG: Write users into "/home/runner/.ya/build/build_root/g81u/004d6f/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-11-01T04:23:11.130819Z :DEBUG: Write groups into "/home/runner/.ya/build/build_root/g81u/004d6f/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-11-01T04:23:11.156778Z :DEBUG: Write group members into "/home/runner/.ya/build/build_root/g81u/004d6f/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-11-01T04:23:11.160041Z :DEBUG: Write ACL into "/home/runner/.ya/build/build_root/g81u/004d6f/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/cluster_backup/permissions.pb"
2025-11-01T04:23:11.166529Z :INFO: Backup database "/Root/db1" to "/home/runner/.ya/build/build_root/g81u/004d6f/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/cluster_backup/Root/db1"
2025-11-01T04:23:11.179942Z :DEBUG: Write database description into "/home/runner/.ya/build/build_root/g81u/004d6f/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-11-01T04:23:11.240157Z :DEBUG: Write users into "/home/runner/.ya/build/build_root/g81u/004d6f/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-11-01T04:23:11.262197Z :DEBUG: Write groups into "/home/runner/.ya/build/build_root/g81u/004d6f/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-11-01T04:23:11.286159Z :DEBUG: Write group members into "/home/runner/.ya/build/build_root/g81u/004d6f/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-11-01T04:23:11.288742Z :DEBUG: Write ACL into "/home/runner/.ya/build/build_root/g81u/004d6f/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-11-01T04:23:11.292942Z :INFO: Backup cluster is completed successfully

2025-11-01 04:23:11,317 - DEBUG - __tests__.test_ydb_backup - fs_recursive_list: prefix# /home/runner/.ya/build/build_root/g81u/004d6f/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/cluster_backup path# 
2025-11-01 04:23:11,318 - DEBUG - __tests__.test_ydb_backup - fs_recursive_list: prefix# /home/runner/.ya/build/build_root/g81u/004d6f/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/cluster_backup path# Root
2025-11-01 04:23:11,318 - DEBUG - __tests__.test_ydb_backup - fs_recursive_list: prefix# /home/runner/.ya/build/build_root/g81u/004d6f/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-11-01 04:23:11,318 - DEBUG - __tests__.test_ydb_backup - create_backup: std_out:

2025-11-01 04:23:11,318 - 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-11-01 04:23:11,318 - 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-11-01 04:23:11,319 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydb/ydb
2025-11-01 04:23:11,320 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.0
2025-11-01 04:23:11,320 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.0
2025-11-01 04:23:11,320 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/g81u/004d6f/ydb/apps/ydb/ydb', '--verbose', '--endpoint', 'grpc://localhost:10118', '--database', '/Root/db1', '--user', 'dbadmin1', '--no-password', 'admin', 'database', 'dump', '--output', '/home/runner/.ya/build/build_root/g81u/004d6f/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-11-01 04:23:11,321 - DEBUG - ya.test - execute: Command pid: 2674624
2025-11-01 04:23:11,640 - DEBUG - ya.test - _save_outputs: Command (pid 2674624) rc: 1
2025-11-01 04:23:11,640 - DEBUG - ya.test - _save_outputs: Command (pid 2674624) elapsed time (sec): 0.3185455799102783
2025-11-01 04:23:11,641 - DEBUG - ya.test - _save_outputs: Command (pid 2674624) idrss: 0
2025-11-01 04:23:11,641 - DEBUG - ya.test - _save_outputs: Command (pid 2674624) inblock: 0
2025-11-01 04:23:11,641 - DEBUG - ya.test - _save_outputs: Command (pid 2674624) isrss: 0
2025-11-01 04:23:11,641 - DEBUG - ya.test - _save_outputs: Command (pid 2674624) ixrss: 0
2025-11-01 04:23:11,641 - DEBUG - ya.test - _save_outputs: Command (pid 2674624) majflt: 0
2025-11-01 04:23:11,641 - DEBUG - ya.test - _save_outputs: Command (pid 2674624) maxrss: 172384
2025-11-01 04:23:11,642 - DEBUG - ya.test - _save_outputs: Command (pid 2674624) minflt: 3420
2025-11-01 04:23:11,642 - DEBUG - ya.test - _save_outputs: Command (pid 2674624) msgrcv: 0
2025-11-01 04:23:11,642 - DEBUG - ya.test - _save_outputs: Command (pid 2674624) msgsnd: 0
2025-11-01 04:23:11,642 - DEBUG - ya.test - _save_outputs: Command (pid 2674624) nivcsw: 38
2025-11-01 04:23:11,642 - DEBUG - ya.test - _save_outputs: Command (pid 2674624) nsignals: 0
2025-11-01 04:23:11,642 - DEBUG - ya.test - _save_outputs: Command (pid 2674624) nswap: 0
2025-11-01 04:23:11,643 - DEBUG - ya.test - _save_outputs: Command (pid 2674624) nvcsw: 133
2025-11-01 04:23:11,643 - DEBUG - ya.test - _save_outputs: Command (pid 2674624) oublock: 8
2025-11-01 04:23:11,643 - DEBUG - ya.test - _save_outputs: Command (pid 2674624) stime: 0.026237
2025-11-01 04:23:11,643 - DEBUG - ya.test - _save_outputs: Command (pid 2674624) utime: 0.052475
2025-11-01 04:23:11,643 - DEBUG - ya.test - _save_outputs: Command (pid 2674624) wtime: 0.319
2025-11-01 04:23:11,643 - DEBUG - ya.test - _save_outputs: Command (pid 2674624) output:

2025-11-01 04:23:11,644 - DEBUG - ya.test - _save_outputs: Command (pid 2674624) 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-11-01T04:23:11.601286Z :INFO: Backup database "/Root/db1" to "/home/runner/.ya/build/build_root/g81u/004d6f/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/database_backup"
2025-11-01T04:23:11.601533Z :ERROR: Backup failed
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:10118
<main>: Error: Endpoint list is empty for database /Root/db1, cluster endpoint localhost:10118.

2025-11-01 04:23:11,644 - 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-11-01T04:23:11.601286Z :INFO: Backup database "/Root/db1" to "/home/runner/.ya/build/build_root/g81u/004d6f/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/database_backup"\n2025-11-01T04:23:11.601533Z :ERROR: Backup failed\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:10118\n<main>: Error: Endpoint list is empty for database /Root/db1, cluster endpoint localhost:10118.\n'

2025-11-01 04:23:12,205 - ERROR - ya.test - logreport: ydb/tests/functional/ydb_cli/test_ydb_backup.py:1608: in test_database_backup_restore
    self.create_database_backup(output="database_backup", expected_files=[
ydb/tests/functional/ydb_cli/test_ydb_backup.py:1396: in create_database_backup
    cls.create_backup(
ydb/tests/functional/ydb_cli/test_ydb_backup.py:1353: in create_backup
    execution = 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/g81u/004d6f/ydb/apps/ydb/ydb --verbose --endpoint grpc://localhost:10118 --database /Root/db1 --user dbadmin1 --no-password admin database dump --output /home/runner/.ya/build/build_root/g81u/004d6f/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/database_backup' 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-11-01T04:23:11.601286Z :INFO: Backup database "/Root/db1" to "/home/runner/.ya/build/build_root/g81u/004d6f/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk9/testing_out_stuff/TestDatabaseBackupRestore/database_backup"
E   2025-11-01T04:23:11.601533Z :ERROR: Backup failed
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:10118
E   <main>: Error: Endpoint list is empty for database /Root/db1, cluster endpoint localhost:10118.
2025-11-01 04:23:12,212 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-11-01 04:23:12,663 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 04:23:12,664 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 04:23:12,676 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-11-01 04:23:12,677 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 00e3b7ad-308a-44b7-ae45-780c0ef09ed3, localhost:2836): creating call state
2025-11-01 04:23:12,679 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 00e3b7ad-308a-44b7-ae45-780c0ef09ed3, localhost:2836): request = { database: "/Root2/db1" }
2025-11-01 04:23:12,682 - DEBUG - ydb.connection - _rpc_error_handler: RpcState(ListEndpoints, 00e3b7ad-308a-44b7-ae45-780c0ef09ed3, localhost:2836): 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-11-01T04:23:12.681581205+00:00", file_line:1211, file:"/home/runner/actions_runner/_work/ydb/ydb/contrib/libs/grpc/src/core/lib/surface/call.cc"}"
>
2025-11-01 04:23:12,682 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:2836". Error details:
 unauthenticated, unauthenticated, Unknown database
2025-11-01 04:23:12,683 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:2836
2025-11-01 04:23:14,088 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 04:23:14,089 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 04:23:14,095 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-11-01 04:23:14,096 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 19c10f71-dcff-4534-aec2-3d1c61732beb, localhost:2836): creating call state
2025-11-01 04:23:14,096 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 19c10f71-dcff-4534-aec2-3d1c61732beb, localhost:2836): request = { database: "/Root2/db1" }
2025-11-01 04:23:14,098 - DEBUG - ydb.connection - _rpc_error_handler: RpcState(ListEndpoints, 19c10f71-dcff-4534-aec2-3d1c61732beb, localhost:2836): received error, <_InactiveRpcError of RPC that terminated with:
	status = StatusCode.UNAUTHENTICATED
	details = "unauthenticated, unauthenticated, Unknown database"
	debug_error_string = "UNKNOWN:Error received from peer  {file:"/home/runner/actions_runner/_work/ydb/ydb/contrib/libs/grpc/src/core/lib/surface/call.cc", file_line:1211, created_time:"2025-11-01T04:23:14.097951606+00:00", grpc_status:16, grpc_message:"unauthenticated, unauthenticated, Unknown database"}"
>
2025-11-01 04:23:14,099 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:2836". Error details:
 unauthenticated, unauthenticated, Unknown database
2025-11-01 04:23:14,099 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:2836
2025-11-01 04:23:15,223 - DEBUG - library.python.cores - recover_core_dump_file: hostname = 'ghrun-i4gyxlpqdu'
2025-11-01 04:23:15,224 - DEBUG - library.python.cores - recover_core_dump_file: rlimit_core = '(0, -1)'
2025-11-01 04:23:15,224 - DEBUG - library.python.cores - recover_core_dump_file: core_pattern = '|/usr/share/apport/apport -p%p -s%s -c%c -d%d -P%P -u%u -g%g -F%F -- %E'
2025-11-01 04:23:15,224 - DEBUG - library.python.cores - recover_core_dump_file: core_uses_pid = '1'
2025-11-01 04:23:15,225 - DEBUG - library.python.cores - recover_core_dump_file: Core dump dir (/home/runner/.ya/build/build_root/g81u/004d6f/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) permission mask: 0o40755 (expected: 0o41777 (0o40000-dir, 0o1000-sticky bit))
2025-11-01 04:23:15,225 - DEBUG - library.python.cores - recover_core_dump_file: Search for core dump files match pattern 'core.2673537' in '/home/runner/.ya/build/build_root/g81u/004d6f/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'
2025-11-01 04:23:15,226 - DEBUG - library.python.cores - recover_core_dump_file: Matched core dump files (0/3): [] (mismatched samples: stderr, stdout, logfile_a3jl80g7.log)
2025-11-01 04:23:15,226 - WARNING - library.python.cores - recover_core_dump_file: Core dump dir doesn't exist: /coredumps
2025-11-01 04:23:15,234 - WARNING - library.python.cores - recover_core_dump_file: Core dump dir doesn't exist: /var/tmp/cores
2025-11-01 04:23:15,235 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:13347/1
2025-11-01 04:23:15,586 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 04:23:15,587 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 04:23:15,602 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root2/db1
2025-11-01 04:23:15,603 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, e57f6cb9-ceeb-44b1-a53a-f9c33ea6bf03, localhost:2836): creating call state
2025-11-01 04:23:15,603 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, e57f6cb9-ceeb-44b1-a53a-f9c33ea6bf03, localhost:2836): request = { database: "/Root2/db1" }
2025-11-01 04:23:15,610 - DEBUG - ydb.connection - _rpc_error_handler: RpcState(ListEndpoints, e57f6cb9-ceeb-44b1-a53a-f9c33ea6bf03, localhost:2836): received error, <_InactiveRpcError of RPC that terminated with:
	status = StatusCode.CANCELLED
	details = "Cancelled on the server side"
	debug_error_string = "UNKNOWN:Error received from peer  {file:"/home/runner/actions_runner/_work/ydb/ydb/contrib/libs/grpc/src/core/lib/surface/call.cc", file_line:1211, created_time:"2025-11-01T04:23:15.609898325+00:00", grpc_status:1, grpc_message:"Cancelled on the server side"}"
>
2025-11-01 04:23:15,610 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to resolve endpoints for database /Root2/db1. Endpoint: "localhost:2836". Error details:
 Cancelled on the server side
2025-11-01 04:23:15,611 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:2836
2025-11-01 04:23:16,751 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 04:23:16,751 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 04:23:22,239 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:2836/1
2025-11-01 04:23:22,241 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/2511
2025-11-01 04:23:22,241 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/19542
2025-11-01 04:23:22,241 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/16369
2025-11-01 04:23:22,241 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/3802
2025-11-01 04:23:22,242 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/13347
2025-11-01 04:23:22,242 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/9921
2025-11-01 04:23:22,242 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/26524
2025-11-01 04:23:22,242 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/1497
2025-11-01 04:23:22,242 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/2836
2025-11-01 04:23:22,243 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/31478
2025-11-01 04:23:26,755 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:2836
2025-11-01 04:23:26,764 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:2836". Check endpoint correctness.
2025-11-01 04:23:28,108 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 04:23:28,109 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 04:23:38,124 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:2836
2025-11-01 04:23:38,166 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:2836". Check endpoint correctness.
2025-11-01 04:23:39,251 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:63312/1
2025-11-01 04:23:39,911 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 04:23:39,923 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 04:23:46,263 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:7108/2
2025-11-01 04:23:49,930 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:2836
2025-11-01 04:23:49,994 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:2836". Check endpoint correctness.
2025-11-01 04:23:51,049 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 04:23:51,051 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 04:23:53,267 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:17919/3
2025-11-01 04:23:56,269 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:10118/1
2025-11-01 04:23:56,270 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/26690
2025-11-01 04:23:56,270 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/26136
2025-11-01 04:23:56,271 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/24456
2025-11-01 04:23:56,271 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/10209
2025-11-01 04:23:56,271 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/17919
2025-11-01 04:23:56,271 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/28622
2025-11-01 04:23:56,272 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/15391
2025-11-01 04:23:56,272 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/8045
2025-11-01 04:23:56,272 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/24965
2025-11-01 04:23:56,272 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/7108
2025-11-01 04:23:56,272 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/29429
2025-11-01 04:23:56,273 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/62598
2025-11-01 04:23:56,273 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/23505
2025-11-01 04:23:56,273 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/29663
2025-11-01 04:23:56,273 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/63312
2025-11-01 04:23:56,273 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/10226
2025-11-01 04:23:56,274 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/64412
2025-11-01 04:23:56,274 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/31906
2025-11-01 04:23:56,274 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/10118
2025-11-01 04:23:56,275 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/8837
