Restore Failure - 2850
Previously, I could queue a restore, have NBU suggest a tape, recall the tape from offsite, and complete the restore days later. Now, if the tape and a drive is not immediately available, the following occurs:
Mar 31, 2025 10:15:22 AM - begin Restore Mar 31, 2025 10:15:22 AM - number of images required: 1 Mar 31, 2025 10:15:22 AM - media needed: 6081L9 Mar 31, 2025 10:15:22 AM - Info bprd (pid=937) Restoring from copy 2 of image created Sat Nov 2 00:02:09 2024 from policy PolicyA
Mar 31, 2025 10:15:23 AM - restoring from image ServerA_1730530929
Mar 31, 2025 10:15:23 AM - Info bpbrm (pid=1030) ServerA is the host to restore to
Mar 31, 2025 10:15:23 AM - Info bpbrm (pid=1030) telling media manager to start restore on client Mar 31, 2025 10:15:23 AM - Info bpbrm (pid=1030) spawning a brm child process
Mar 31, 2025 10:15:23 AM - Info bpbrm (pid=1030) child pid: 1044
Mar 31, 2025 10:15:23 AM - connecting
Mar 31, 2025 10:15:23 AM - requesting resource 6081L9
Mar 31, 2025 10:15:23 AM - awaiting resource 6081L9. A pending request has been generated for this resource request. Operator action may be required. Pending Action: No action, Media ID: 6081L9, Barcode: EC6081L9, Density: hcart3, Access Mode: Read, Action Drive Name: N/A, Action Media Server: nb5250master, Robot Type(Number): 0(N/A), Volume Group: ---, Action Acs: N/A, Action Lsm: N/A
Mar 31, 2025 10:15:24 AM - Info bpbrm (pid=1044) start tar on client
Mar 31, 2025 10:15:24 AM - Info tar (pid=1856850) Restore started.
Mar 31, 2025 10:15:24 AM - connected; connect time: 0:00:00
Mar 31, 2025 10:16:23 AM - awaiting resource 6081L9. A pending request has been generated for this resource request. Operator action may be required. Pending Action: No action, Media ID: 6081L9, Barcode: EC6081L9, Density: hcart3, Access Mode: Read, Action Drive Name: N/A, Action Media Server: nb5250master, Robot Type(Number): 0(N/A), Volume Group: ---, Action Acs: N/A, Action Lsm: N/A
Mar 31, 2025 10:25:23 AM - Info bpbrm (pid=1030) Sending SIGHUP to media manager 1033 Mar 31, 2025 10:25:23 AM - Info bpbrm (pid=1030) terminating bpbrm child 1044 jobid=15017390 Mar 31, 2025 10:25:27 AM - Error bptm (pid=1033) media manager terminated by parent process
Mar 31, 2025 10:25:27 AM - Error bptm (pid=1040) The following files/folders were not restored: Mar 31, 2025 10:25:27 AM - Error bptm (pid=1040) UTF - /path/to/restore/local.login Mar 31, 2025 10:25:27 AM - restored from image ServerA_1730530929; restore time: 0:10:04
Mar 31, 2025 10:25:27 AM - Warning bprd (pid=937) Restore must be resumed prior to first image expiration on Mon 02 Nov 2026 12:02:09 AM MST
Mar 31, 2025 10:25:27 AM - end Restore; elapsed time 0:10:05
Restore error (2850)
10 minutes after queuing the restore, if fails. This is very consistent behavior. If the required media is available in the tape library and NBU is aware of it (inventoried robot) and a drive is free, the restore will complete.
Running NBU 9.1.01 on a Veritas 5250 Appliance, connected to a SpectraLogic Stack LTO9. The tape library is newish, and we had some issues getting it working properly with NBU. These restore failures may be a side-effect of trouble-shooting with Veritas Support.
