01/02/2016 03:17:29 - Info nbjm (pid=3582) starting backup job (jobid=2386987) for client xxxx, policy PX_NPEX_ORADB_MSDP35D, schedule Default-Application-Backup 01/02/2016 03:17:29 - Info nbjm (pid=3582) requesting STANDARD_RESOURCE resources from RB for backup job (jobid=2386987, request id:{696E3CB6-B142-11E5-8E5D-9E0C2E2F0B9C}) 01/02/2016 03:17:29 - requesting resource STU_PX_NPEX_MSDP_xxxxx_ORACLE 01/02/2016 03:17:29 - requesting resource xxxxx.unix.gsm1900.org.NBU_CLIENT.MAXJOBS.xxxx 01/02/2016 03:17:29 - requesting resource xxxxx.unix.gsm1900.org.NBU_POLICY.MAXJOBS.PX_NPEX_ORADB_MSDP35D 01/02/2016 03:18:16 - awaiting resource STU_PX_NPEX_MSDP_xxxxx_ORACLE. Waiting for resources. Reason: Maximum I/O stream count has been reached for the disk volume., Media server: xxxxxx, Robot Type(Number): NONE(N/A), Media ID: N/A, Drive Name: N/A, Volume Pool: NetBackup, Storage Unit: STU_PX_NPEX_MSDP_xxxxxx_ORACLE, Drive Scan Host: N/A, Disk Pool: DP_xxxxxx, Disk Volume: PureDiskVolume 01/02/2016 03:19:29 - Info nbjm (pid=3582) Waiting in NetBackup scheduler work queue on server xxxxxxx.unix.gsm1900.org 01/02/2016 03:21:29 - Info nbjm (pid=3582) Waiting in NetBackup scheduler work queue on server xxxxx.unix.gsm1900.org " " 01/02/2016 08:51:30 - Info nbjm (pid=3582) Waiting in NetBackup scheduler work queue on server xxxx.unix.gsm1900.org 01/02/2016 08:53:30 - Info nbjm (pid=3582) Waiting in NetBackup scheduler work queue on server xxxxx.unix.gsm1900.org 01/02/2016 08:55:30 - Info nbjm (pid=3582) Waiting in NetBackup scheduler work queue on server xxxxx.unix.gsm1900.org " " " 01/02/2016 09:49:30 - Info nbjm (pid=3582) Waiting in NetBackup scheduler work queue on server xxxx.unix.gsm1900.org 01/02/2016 09:51:30 - Info nbjm (pid=3582) Waiting in NetBackup scheduler work queue on server xxxxx.unix.gsm1900.org 01/02/2016 09:51:46 - Info bpbrm (pid=11616) xxxxx is the host to backup data from 01/02/2016 09:51:46 - Info bpbrm (pid=11616) reading file list for client 01/02/2016 09:51:46 - Info bpbrm (pid=11616) listening for client connection 01/02/2016 09:51:48 - Info bpbrm (pid=11616) INF - Client read timeout = 300 01/02/2016 09:51:48 - Info bpbrm (pid=11616) accepted connection from client 01/02/2016 09:51:48 - Info dbclient (pid=13172762) Backup started 01/02/2016 09:51:48 - Info bpbrm (pid=11616) bptm pid: 11658 01/02/2016 09:51:49 - Info bptm (pid=11658) start 01/02/2016 09:51:49 - Info bptm (pid=11658) using 1048576 data buffer size 01/02/2016 09:51:49 - Info bptm (pid=11658) using 64 data buffers 01/02/2016 09:52:03 - Info bptm (pid=11658) start backup 01/02/2016 09:53:16 - Info bptm (pid=11658) backup child process is pid 22784 01/02/2016 09:53:17 - Info dbclient (pid=13172762) dbclient(pid=13172762) wrote first buffer(size=262144) 01/02/2016 09:53:17 - Info dbclient (pid=13172762) done. status: 0 01/02/2016 09:53:17 - Info bptm (pid=11658) waited for full buffer 1 times, delayed 47 times 01/02/2016 09:53:30 - Info nbjm (pid=3582) Waiting in NetBackup scheduler work queue on server xxxxx.unix.gsm1900.org 01/02/2016 09:54:07 - Info bptm (pid=11658) EXITING with status 0 <---------- 01/02/2016 09:54:07 - Info xxxxx (pid=11658) StorageServer=PureDisk:xxxxxx; Report=PDDO Stats (multi-threaded stream used) for (xxxxxx): scanned: 291 KB, CR sent: 2 KB, CR sent over FC: 0 KB, dedup: 99.3%, cache hits: 1 (33.3%) 01/02/2016 09:54:13 - Info bpbrm (pid=11616) validating image for client xxxxxx 01/02/2016 09:54:13 - Info dbclient (pid=13172762) done. status: 0: the requested operation was successfully completed 01/02/2016 09:55:30 - Info nbjm (pid=3582) Waiting in NetBackup scheduler work queue on server xxxxx.unix.gsm1900.org 01/02/2016 09:57:30 - Info nbjm (pid=3582) Waiting in NetBackup scheduler work queue on server xxxxx.unix.gsm1900.org 01/02/2016 09:59:30 - Info nbjm (pid=3582) Waiting in NetBackup scheduler work queue on server xxxxx.unix.gsm1900.org 01/02/2016 10:01:26 - granted resource xxxxx.unix.gsm1900.org.NBU_CLIENT.MAXJOBS.xxxxxx 01/02/2016 10:01:26 - granted resource xxxxx.unix.gsm1900.org.NBU_POLICY.MAXJOBS.PX_NPEX_ORADB_MSDP35D 01/02/2016 10:01:26 - granted resource MediaID=@aaaao;DiskVolume=PureDiskVolume;DiskPool=DP_xxxxx;Path=PureDiskVolume;StorageServer=xxxxxxxxxxx;MediaServer=xxxxxxxxxxx 01/02/2016 10:01:26 - granted resource STU_PX_NPEX_MSDP_xxxxxxxx_ORACLE 01/02/2016 10:01:28 - estimated 0 kbytes needed 01/02/2016 10:01:28 - Info nbjm (pid=3582) started backup (backupid=xxxxxx_1451757688) job for client xxxxxxx, policy PX_NPEX_ORADB_MSDP35D, schedule Default-Application-Backup on storage unit STU_PX_NPEX_MSDP_xxxxxxx_ORACLE 01/02/2016 10:01:29 - started process bpbrm (pid=11616) 01/02/2016 10:01:29 - connecting 01/02/2016 10:01:31 - connected; connect time: 0:00:00 01/02/2016 10:02:59 - begin writing 01/02/2016 10:03:56 - end writing; write time: 0:00:57 the requested operation was successfully completed (0)