ContributionsMost RecentMost LikesSolutionsRe: Catalog backups fail after NBU 7.1 migration Heya, I agree, the reboot more than likely fixed the issue. The SQL query comm failure was probably due toincorrect credentials and once the new Catalog backup policy was created with correct credentials it required the reboot. This is still odd though, unless a Catalog restore following the migration does not pass on the credentials of the original Catalog backup policy as the credentials had not changed from the original. To answer your question of wether or not other policies were working on other Media servers, we are actually just running a single Master/Media server. I was at odds fora bit there. Here I was ready to provide logs requested and I could not get the policy to fail...hehe. I guess all is good. Thanks very much for your help and the reminder to turn logging down. -Glen Solution: Recreated Catalog backup policy with a reboot. Re: Catalog backups fail after NBU 7.1 migration Thanks. I created another Catalog Backup policy and ran it manually. The job failed again but this time with additional errors. So I then increased logging to maximum, rebooted the server and re-ran the Catalog backup policy. This time it succeeded, but I do not know if the logged details are to be expected. I pasted Detailed Status logs of both the initial failure and the following success runs of the policy. The logs from bpbkar, bpbrm and bptm are attached. 7/12/2012 2:42:15 PM - Info nbjm(pid=1480) starting backup job (jobid=237) for client evamanager, policy CatalogHotBackups, schedule Full 7/12/2012 2:42:15 PM - Info nbjm(pid=1480) requesting STANDARD_RESOURCE resources from RB for backup job (jobid=237, request id:{F60A515A-25BF-4A8A-AA7D-D0D17F3E1FDD}) 7/12/2012 2:42:15 PM - requesting resource Any 7/12/2012 2:42:15 PM - requesting resource evamanager.NBU_CLIENT.MAXJOBS.evamanager 7/12/2012 2:42:15 PM - requesting resource evamanager.NBU_POLICY.MAXJOBS.CatalogHotBackups 7/12/2012 2:42:15 PM - granted resource evamanager.NBU_CLIENT.MAXJOBS.evamanager 7/12/2012 2:42:15 PM - granted resource evamanager.NBU_POLICY.MAXJOBS.CatalogHotBackups 7/12/2012 2:42:15 PM - granted resource 000058 7/12/2012 2:42:15 PM - granted resource HP.ULTRIUM3-SCSI.000 7/12/2012 2:42:15 PM - granted resource evamanager-hcart3-robot-tld-0 7/12/2012 2:42:16 PM - Info bpbrm(pid=1204) evamanager is the host to backup data from 7/12/2012 2:42:16 PM - Info bpbrm(pid=1204) reading file list from client 7/12/2012 2:42:16 PM - Info bpbrm(pid=1204) listening for client connection 7/12/2012 2:42:16 PM - Info bpbrm(pid=1204) INF - Client read timeout = 300 7/12/2012 2:42:16 PM - estimated 0 Kbytes needed 7/12/2012 2:42:16 PM - Info nbjm(pid=1480) started backup job for client evamanager, policy CatalogHotBackups, schedule Full on storage unit evamanager-hcart3-robot-tld-0 7/12/2012 2:42:16 PM - started process bpbrm (1204) 7/12/2012 2:42:16 PM - connecting 7/12/2012 2:42:17 PM - Info bpbrm(pid=1204) accepted connection from client 7/12/2012 2:42:17 PM - Info bpbrm(pid=1204) start bpbkar on client 7/12/2012 2:42:17 PM - connected; connect time: 00:00:01 7/12/2012 2:42:20 PM - Info bphdb(pid=876) Backup started 7/12/2012 2:42:20 PM - Info bphdb(pid=976) Backup started 7/12/2012 2:42:20 PM - Info bptm(pid=1008) start 7/12/2012 2:42:20 PM - Info bptm(pid=1008) using 65536 data buffer size 7/12/2012 2:42:20 PM - Info bptm(pid=1008) setting receive network buffer to 263168 bytes 7/12/2012 2:42:20 PM - Info bptm(pid=1008) using 256 data buffers 7/12/2012 2:42:21 PM - Info bptm(pid=1008) start backup 7/12/2012 2:42:21 PM - Info bptm(pid=1008) Waiting for mount of media id 000058 (copy 1) on server evamanager. 7/12/2012 2:42:21 PM - mounting 000058 7/12/2012 2:42:50 PM - Error bptm(pid=1008) NBEMM returned an extended error status: SQL query returned client unable to establish connection (2007054) 7/12/2012 2:42:50 PM - Error bptm(pid=1008) error requesting media, TpErrno = Mount canceled, device daemon is terminating client process aborted(50) ---------------------------------------------------------------------------------------------- 7/12/2012 2:49:30 PM - Info nbjm(pid=168) starting backup job (jobid=241) for client evamanager, policy CatalogHotBackups, schedule Full 7/12/2012 2:49:30 PM - Info nbjm(pid=168) requesting STANDARD_RESOURCE resources from RB for backup job (jobid=241, request id:{2BED3F2B-E19A-42CA-9D08-30E04143F7A4}) 7/12/2012 2:49:30 PM - requesting resource Any 7/12/2012 2:49:30 PM - requesting resource evamanager.NBU_CLIENT.MAXJOBS.evamanager 7/12/2012 2:49:30 PM - requesting resource evamanager.NBU_POLICY.MAXJOBS.CatalogHotBackups 7/12/2012 2:49:30 PM - awaiting resource Any - No drives are available 7/12/2012 2:50:15 PM - Info bpbrm(pid=5972) evamanager is the host to backup data from 7/12/2012 2:50:15 PM - Info bpbrm(pid=5972) reading file list from client 7/12/2012 2:50:15 PM - granted resource evamanager.NBU_CLIENT.MAXJOBS.evamanager 7/12/2012 2:50:15 PM - granted resource evamanager.NBU_POLICY.MAXJOBS.CatalogHotBackups 7/12/2012 2:50:15 PM - granted resource 000058 7/12/2012 2:50:15 PM - granted resource HP.ULTRIUM3-SCSI.000 7/12/2012 2:50:15 PM - granted resource evamanager-hcart3-robot-tld-0 7/12/2012 2:50:15 PM - estimated 0 Kbytes needed 7/12/2012 2:50:15 PM - Info nbjm(pid=168) started backup job for client evamanager, policy CatalogHotBackups, schedule Full on storage unit evamanager-hcart3-robot-tld-0 7/12/2012 2:50:15 PM - started process bpbrm (5972) 7/12/2012 2:50:15 PM - connecting 7/12/2012 2:50:16 PM - Info bpbrm(pid=5972) starting bpbkar32 on client 7/12/2012 2:50:16 PM - connected; connect time: 00:00:01 7/12/2012 2:50:18 PM - Info bpbkar32(pid=6060) Backup started 7/12/2012 2:50:18 PM - Info bptm(pid=6028) start 7/12/2012 2:50:19 PM - Info bptm(pid=6028) using 65536 data buffer size 7/12/2012 2:50:19 PM - Info bptm(pid=6028) setting receive network buffer to 263168 bytes 7/12/2012 2:50:19 PM - Info bptm(pid=6028) using 256 data buffers 7/12/2012 2:50:19 PM - Info bptm(pid=6028) start backup 7/12/2012 2:50:19 PM - Info bptm(pid=6028) Waiting for mount of media id 000058 (copy 1) on server evamanager. 7/12/2012 2:50:19 PM - Warning bpbrm(pid=5972) from client evamanager: WRN - old TIR info file 'D:\Veritas\NetBackup\tir_info\DB\NetBackup_file_info.CatalogHotBackups' is missing. Backing up everything in 'root' 7/12/2012 2:50:19 PM - mounting 000058 7/12/2012 2:50:53 PM - Info bptm(pid=6028) media id 000058 mounted on drive index 0, drivepath {3,0,0,1}, drivename HP.ULTRIUM3-SCSI.000, copy 1 7/12/2012 2:50:53 PM - mounted; mount time: 00:00:34 7/12/2012 2:50:56 PM - positioning 000058 to file 23 7/12/2012 2:51:31 PM - positioned 000058; position time: 00:00:35 7/12/2012 2:51:31 PM - begin writing 7/12/2012 2:53:55 PM - Info bptm(pid=6028) waited for full buffer 1687 times, delayed 2217 times 7/12/2012 2:53:55 PM - Info bpbkar32(pid=6060) bpbkar waited 173 times for empty buffer, delayed 173 times. 7/12/2012 2:54:12 PM - Info bptm(pid=6028) EXITING with status 0 <---------- 7/12/2012 2:54:12 PM - Info bpbrm(pid=5972) validating image for client evamanager 7/12/2012 2:54:13 PM - end writing; write time: 00:02:42 the requested operation was successfully completed(0) 7/12/2012 2:54:18 PM - Info bpbkar32(pid=6060) done. status: 0: the requested operation was successfully completed Catalog backups fail after NBU 7.1 migration Server 2003 R2 NetBackup 7.1 (*base installation. No hotfix/EEB applied) Heya, following a migration of NBU 7.1 to new hardware we are experiencing failed Catalog backups. Prior to the migration, the Catalog backups worked flawlessly. On the new server, with exception to the Catalog backups, all policies backup and complete successfully. Any assistance is appreciated. The errors are as follows. -------------------------------------------------------------------------------------------- 7/12/2012 12:22:39 PM - Info nbjm(pid=1480) starting backup job (jobid=230) for client evamanager, policy CatalogHotBackup, schedule Full 7/12/2012 12:22:39 PM - Info nbjm(pid=1480) requesting CATALOG_BACKUP_RESOURCE resources from RB for backup job (jobid=230, request id:{ABE69B8D-D8AF-4CAA-842B-278C6E125C93}) 7/12/2012 12:22:39 PM - requesting resource evamanager.NBU_CATALOG.MAXJOBS 7/12/2012 12:22:39 PM - granted resource evamanager.NBU_CATALOG.MAXJOBS 7/12/2012 12:22:39 PM - estimated 9349879 Kbytes needed 7/12/2012 12:22:39 PM - begin Parent Job 7/12/2012 12:22:39 PM - begin Catalog Backup, Start Notify Script 7/12/2012 12:22:40 PM - Info RUNCMD(pid=5800) started 7/12/2012 12:22:40 PM - Info RUNCMD(pid=5800) exiting with status: 0 Status 0 7/12/2012 12:22:40 PM - end Catalog Backup, Start Notify Script; elapsed time: 00:00:01 7/12/2012 12:22:40 PM - begin Catalog Backup, DBM Query Status 2 7/12/2012 12:24:21 PM - end Catalog Backup, DBM Query; elapsed time: 00:01:41 7/12/2012 12:24:21 PM - begin Catalog Backup, Stop On Error Status 0 7/12/2012 12:24:21 PM - end Catalog Backup, Stop On Error; elapsed time: 00:00:00 7/12/2012 12:24:21 PM - begin Catalog Backup, End Notify Script 7/12/2012 12:24:22 PM - Info RUNCMD(pid=4376) started 7/12/2012 12:24:22 PM - Info RUNCMD(pid=4376) exiting with status: 0 Status 0 7/12/2012 12:24:22 PM - end Catalog Backup, End Notify Script; elapsed time: 00:00:01 Status 2 7/12/2012 12:24:22 PM - end Parent Job; elapsed time: 00:01:43 none of the requested files were backed up(2) -------------------------------------------------------------------------------------------------------------------- 7/12/2012 10:07:04 AM - Info nbjm(pid=1480) starting backup job (jobid=229) for client evamanager, policy CatalogHotBackup, schedule Full 7/12/2012 10:07:04 AM - Info nbjm(pid=1480) requesting STANDARD_RESOURCE resources from RB for backup job (jobid=229, request id:{125E3491-B175-4DA5-B745-2E3CDA1851CF}) 7/12/2012 10:07:04 AM - requesting resource evamanager-hcart3-robot-tld-0 7/12/2012 10:07:04 AM - requesting resource evamanager.NBU_CLIENT.MAXJOBS.evamanager 7/12/2012 10:07:04 AM - requesting resource evamanager.NBU_POLICY.MAXJOBS.CatalogHotBackup 7/12/2012 10:07:04 AM - granted resource evamanager.NBU_CLIENT.MAXJOBS.evamanager 7/12/2012 10:07:04 AM - granted resource evamanager.NBU_POLICY.MAXJOBS.CatalogHotBackup 7/12/2012 10:07:04 AM - granted resource 000058 7/12/2012 10:07:04 AM - granted resource HP.ULTRIUM3-SCSI.000 7/12/2012 10:07:04 AM - granted resource evamanager-hcart3-robot-tld-0 7/12/2012 10:07:05 AM - Info bpbrm(pid=620) evamanager is the host to backup data from 7/12/2012 10:07:05 AM - Info bpbrm(pid=620) reading file list from client 7/12/2012 10:07:05 AM - Info bpbrm(pid=620) listening for client connection 7/12/2012 10:07:05 AM - Info bpbrm(pid=620) INF - Client read timeout = 300 7/12/2012 10:07:05 AM - estimated 0 Kbytes needed 7/12/2012 10:07:05 AM - Info nbjm(pid=1480) started backup job for client evamanager, policy CatalogHotBackup, schedule Full on storage unit evamanager-hcart3-robot-tld-0 7/12/2012 10:07:05 AM - started process bpbrm (620) 7/12/2012 10:07:05 AM - connecting 7/12/2012 10:07:06 AM - Info bpbrm(pid=620) accepted connection from client 7/12/2012 10:07:06 AM - Info bpbrm(pid=620) start bpbkar on client 7/12/2012 10:07:06 AM - connected; connect time: 00:00:01 7/12/2012 10:07:08 AM - Info bphdb(pid=5628) Backup started 7/12/2012 10:07:08 AM - Info bphdb(pid=5248) Backup started 7/12/2012 10:07:09 AM - Info bptm(pid=1400) start 7/12/2012 10:07:09 AM - Info bptm(pid=1400) using 65536 data buffer size 7/12/2012 10:07:09 AM - Info bptm(pid=1400) setting receive network buffer to 263168 bytes 7/12/2012 10:07:09 AM - Info bptm(pid=1400) using 256 data buffers 7/12/2012 10:07:09 AM - Info bptm(pid=1400) start backup 7/12/2012 10:07:09 AM - Info bptm(pid=1400) Waiting for mount of media id 000058 (copy 1) on server evamanager. 7/12/2012 10:07:09 AM - mounting 000058 7/12/2012 10:07:45 AM - Info bptm(pid=1400) media id 000058 mounted on drive index 0, drivepath {3,0,0,1}, drivename HP.ULTRIUM3-SCSI.000, copy 1 7/12/2012 10:07:45 AM - mounted; mount time: 00:00:36 7/12/2012 10:07:48 AM - positioning 000058 to file 19 7/12/2012 10:08:23 AM - positioned 000058; position time: 00:00:35 7/12/2012 10:08:23 AM - begin writing 7/12/2012 10:08:27 AM - Info bphdb(pid=5248) bpbkar waited 1 times for empty buffer, delayed 1 times. 7/12/2012 10:08:27 AM - Info bphdb(pid=5248) done. status: 0 7/12/2012 10:08:27 AM - Info bptm(pid=1400) waited for full buffer 0 times, delayed 0 times 7/12/2012 10:08:34 AM - Info bptm(pid=1400) EXITING with status 0 <---------- 7/12/2012 10:08:34 AM - Info bpbrm(pid=620) validating image for client evamanager 7/12/2012 10:08:34 AM - end writing; write time: 00:00:11 the requested operation was successfully completed(0) 7/12/2012 10:08:39 AM - Info bphdb(pid=5248) done. status: 0: the requested operation was successfully completed ---------------------------------------------------------------------------------------------------------------- 7/12/2012 12:22:40 PM - Info bpdbm(pid=944) staging relational database files for catalog backup 7/12/2012 12:22:40 PM - Info bpdbm(pid=944) staging BMRDB backup to D:\Veritas\NetBackupDB\staging 7/12/2012 12:22:42 PM - Info bpdbm(pid=944) done staging BMRDB backup to D:\Veritas\NetBackupDB\staging 7/12/2012 12:22:43 PM - Info bpdbm(pid=944) done staging NBAZDB backup to D:\Veritas\NetBackupDB\staging 7/12/2012 12:22:43 PM - Info bpdbm(pid=944) staging NBDB backup to D:\Veritas\NetBackupDB\staging 7/12/2012 12:22:48 PM - Info bpdbm(pid=944) done staging NBDB backup to D:\Veritas\NetBackupDB\staging none of the requested files were backed up(2) ------------------------------------------------------------------------------------------------------------------ 7/12/2012 12:22:51 PM - Info nbjm(pid=1480) starting backup job (jobid=232) for client evamanager, policy CatalogHotBackup, schedule Full 7/12/2012 12:22:51 PM - Info nbjm(pid=1480) requesting STANDARD_RESOURCE resources from RB for backup job (jobid=232, request id:{47E7FCE6-A2B1-485E-8685-A7FEB2462862}) 7/12/2012 12:22:51 PM - requesting resource evamanager-hcart3-robot-tld-0 7/12/2012 12:22:51 PM - requesting resource evamanager.NBU_CLIENT.MAXJOBS.evamanager 7/12/2012 12:22:51 PM - requesting resource evamanager.NBU_POLICY.MAXJOBS.CatalogHotBackup 7/12/2012 12:22:51 PM - granted resource evamanager.NBU_CLIENT.MAXJOBS.evamanager 7/12/2012 12:22:51 PM - granted resource evamanager.NBU_POLICY.MAXJOBS.CatalogHotBackup 7/12/2012 12:22:51 PM - granted resource 000058 7/12/2012 12:22:51 PM - granted resource HP.ULTRIUM3-SCSI.000 7/12/2012 12:22:51 PM - granted resource evamanager-hcart3-robot-tld-0 7/12/2012 12:22:52 PM - Info bpbrm(pid=6112) evamanager is the host to backup data from 7/12/2012 12:22:52 PM - Info bpbrm(pid=6112) reading file list from client 7/12/2012 12:22:52 PM - Info bpbrm(pid=6112) listening for client connection 7/12/2012 12:22:52 PM - Info bpbrm(pid=6112) INF - Client read timeout = 300 7/12/2012 12:22:52 PM - estimated 0 Kbytes needed 7/12/2012 12:22:52 PM - Info nbjm(pid=1480) started backup job for client evamanager, policy CatalogHotBackup, schedule Full on storage unit evamanager-hcart3-robot-tld-0 7/12/2012 12:22:52 PM - started process bpbrm (6112) 7/12/2012 12:22:52 PM - connecting 7/12/2012 12:22:53 PM - Info bpbrm(pid=6112) accepted connection from client 7/12/2012 12:22:53 PM - Info bpbrm(pid=6112) start bpbkar on client 7/12/2012 12:22:53 PM - connected; connect time: 00:00:01 7/12/2012 12:22:56 PM - Info bphdb(pid=1696) Backup started 7/12/2012 12:22:56 PM - Info bphdb(pid=944) Backup started 7/12/2012 12:22:56 PM - Info bptm(pid=1372) start 7/12/2012 12:22:57 PM - Info bptm(pid=1372) using 65536 data buffer size 7/12/2012 12:22:57 PM - Info bptm(pid=1372) setting receive network buffer to 263168 bytes 7/12/2012 12:22:57 PM - Info bptm(pid=1372) using 256 data buffers 7/12/2012 12:22:57 PM - Info bptm(pid=1372) start backup 7/12/2012 12:22:57 PM - Info bptm(pid=1372) Waiting for mount of media id 000058 (copy 1) on server evamanager. 7/12/2012 12:22:57 PM - mounting 000058 7/12/2012 12:23:31 PM - Info bptm(pid=1372) media id 000058 mounted on drive index 0, drivepath {3,0,0,1}, drivename HP.ULTRIUM3-SCSI.000, copy 1 7/12/2012 12:23:31 PM - mounted; mount time: 00:00:34 7/12/2012 12:23:34 PM - positioning 000058 to file 20 7/12/2012 12:24:09 PM - positioned 000058; position time: 00:00:35 7/12/2012 12:24:09 PM - begin writing 7/12/2012 12:24:13 PM - Info bphdb(pid=944) bpbkar waited 1 times for empty buffer, delayed 1 times. 7/12/2012 12:24:13 PM - Info bphdb(pid=944) done. status: 0 7/12/2012 12:24:13 PM - Info bptm(pid=1372) waited for full buffer 1 times, delayed 29 times 7/12/2012 12:24:19 PM - Info bptm(pid=1372) EXITING with status 0 <---------- 7/12/2012 12:24:19 PM - Info bpbrm(pid=6112) validating image for client evamanager 7/12/2012 12:24:20 PM - end writing; write time: 00:00:11 7/12/2012 12:24:25 PM - Info bphdb(pid=944) done. status: 0: the requested operation was successfully completed the requested operation was successfully completed(0) SolvedRe: Netbackup Backup & Restore: Cannot see dated backup image.Thanks for your response Marianne. As it was, Phase2 of the Import did not succeed the first time. When Import Phase2 was initiated and complete the data was available for restoration. I took into consideration your solution and have awarded it.Re: Netbackup Backup & Restore: Cannot see dated backup image.Well, apparently Phase 2 of the Import did not initiate, probably my fault (didn't confirm Phase 2), and is now under way. This is probably the issue I am having as I have extended the expiry date of the media and the images already.Netbackup Backup & Restore: Cannot see dated backup image.I just completed an import of old images on from tape media <Catalog=>Import> and confirmed the images from the Reports on the specific media. What I am trying to do now is restore a single file from the newly imported images <from 2006>. When i goto Backup & Restore there is no option to view or search from this date. The backups were made prior on an older NBU version (which one I can't remember) and the policy that was used to back them up is long gone. I would expect that since the images are confirmed from the Images on Media report that I should be able to view them from Backup & Restore. I am probably missing something here as I don't spend a lot of time in Netbackup. Thanks.Solved