2/1/2012 3:30:34 AM - Info nbjm(pid=4108) starting backup job (jobid=146955) for client VeritasNetbackup, policy CB, schedule Full 2/1/2012 3:30:34 AM - Info nbjm(pid=4108) requesting STANDARD_RESOURCE resources from RB for backup job (jobid=146955, request id:{B19CCF68-1BBF-4068-B95A-BAE9FC380600}) 2/1/2012 3:30:34 AM - requesting resource veritas-netbkup-hcart-robot-tld-0 2/1/2012 3:30:34 AM - requesting resource veritas-netbkup.NBU_CLIENT.MAXJOBS.veritas-netbkup 2/1/2012 3:30:34 AM - requesting resource veritas-netbkup.NBU_POLICY.MAXJOBS.CB 2/1/2012 3:30:34 AM - granted resource veritas-netbkup.NBU_CLIENT.MAXJOBS.veritas-netbkup 2/1/2012 3:30:34 AM - granted resource veritas-netbkup.NBU_POLICY.MAXJOBS.CB 2/1/2012 3:30:34 AM - granted resource 0014L9 2/1/2012 3:30:34 AM - granted resource IBM.ULT3580-TD5.004 2/1/2012 3:30:34 AM - granted resource veritas-netbkup-hcart-robot-tld-0 2/1/2012 3:30:34 AM - estimated 0 Kbytes needed 2/1/2012 3:30:34 AM - Info nbjm(pid=4108) started backup job for client veritas-netbkup, policy CB, schedule Full on storage unit veritas-netbkup-hcart-robot-tld-0 2/1/2012 3:30:35 AM - Info bpbrm(pid=2452) veritas-netbkup is the host to backup data from 2/1/2012 3:30:35 AM - Info bpbrm(pid=2452) reading file list from client 2/1/2012 3:30:35 AM - Info bpbrm(pid=2452) listening for client connection 2/1/2012 3:30:35 AM - Info bpbrm(pid=2452) INF - Client read timeout = 6000 2/1/2012 3:30:35 AM - Info bpbrm(pid=2452) accepted connection from client 2/1/2012 3:30:35 AM - Info bpbrm(pid=2452) start bpbkar on client 2/1/2012 3:30:35 AM - started process bpbrm (2452) 2/1/2012 3:30:35 AM - connecting 2/1/2012 3:30:35 AM - connected; connect time: 00:00:00 2/1/2012 3:30:38 AM - Info bphdb(pid=6064) Backup started 2/1/2012 3:30:38 AM - Info bphdb(pid=4244) Backup started 2/1/2012 3:30:38 AM - Info bptm(pid=5456) start 2/1/2012 3:30:38 AM - Info bptm(pid=5456) using 65536 data buffer size 2/1/2012 3:30:38 AM - Info bptm(pid=5456) setting receive network buffer to 263168 bytes 2/1/2012 3:30:38 AM - Info bptm(pid=5456) using 30 data buffers 2/1/2012 3:30:38 AM - Info bptm(pid=5456) start backup 2/1/2012 3:30:38 AM - Info bptm(pid=5456) Waiting for mount of media id 0014L9 (copy 1) on server veritas-netbkup. 2/1/2012 3:30:38 AM - mounting 0014L9 2/1/2012 3:31:14 AM - Info bptm(pid=5456) media id 0014L9 mounted on drive index 4, drivepath {4,0,6,0}, drivename IBM.ULT3580-TD5.004, copy 1 2/1/2012 3:31:14 AM - mounted; mount time: 00:00:36 2/1/2012 3:31:14 AM - positioning 0014L9 to file 356 2/1/2012 3:32:49 AM - positioned 0014L9; position time: 00:01:35 2/1/2012 3:32:49 AM - begin writing 2/1/2012 4:02:51 AM - Error bptm(pid=5456) NBEMM returned an extended error status: Database server is down (4005006) 2/1/2012 4:02:51 AM - Info bptm(pid=5456) EXITING with status 252 <---------- 2/1/2012 4:02:51 AM - Info bphdb(pid=4244) bpbkar waited 0 times for empty buffer, delayed 0 times. 2/1/2012 4:02:51 AM - Info bphdb(pid=4244) done. status: 40 2/1/2012 4:02:54 AM - Error bpbrm(pid=2452) could not send server status message 2/1/2012 4:02:54 AM - end writing; write time: 00:30:05 extended error status has been encountered, check logs(252) 2/1/2012 4:02:59 AM - Info bphdb(pid=4244) done. status: 252: extended error status has been encountered, check logs