2014-08-20 22:05:02 - requesting resource LCM_TLD 2014-08-20 22:05:02 - granted resource LCM_TLD 2014-08-20 22:05:03 - begin Duplicate 2014-08-20 22:05:03 - started process RUNCMD (13072) 2014-08-20 22:05:03 - ended process 0 (13072) 2014-08-20 22:05:04 - requesting resource TLD 2014-08-20 22:05:04 - requesting resource @aaab3 2014-08-20 22:05:04 - reserving resource @aaab3 2014-08-20 22:05:07 - awaiting resource TLD - No drives are available 2014-08-20 22:09:39 - awaiting resource TLD Reason: Drives are in use, Media Server: adm-media04, Robot Number: 0, Robot Type: TLD, Media ID: N/A, Drive Name: N/A, Volume Pool: ESF_for_ever, Storage Unit: adm-media04-hcart2-robot-tld-1, Drive Scan Host: N/A 2014-08-20 22:13:55 - awaiting resource TLD - No drives are available 2014-08-20 22:40:59 - awaiting resource TLD Reason: Drives are in use, Media Server: adm-media04, Robot Number: 0, Robot Type: TLD, Media ID: N/A, Drive Name: N/A, Volume Pool: ESF_for_ever, Storage Unit: adm-media04-hcart2-robot-tld-1, Drive Scan Host: N/A 2014-08-20 22:43:57 - awaiting resource TLD - No drives are available 2014-08-20 22:49:20 - reserved resource @aaab3 2014-08-20 22:49:20 - granted resource XO0308 2014-08-20 22:49:20 - granted resource IBM.ULT3580-TD5.Drive4 2014-08-20 22:49:20 - granted resource adm-master01-hcart2-robot-tld-1 2014-08-20 22:49:20 - granted resource MediaID=@aaab3;DiskVolume=PureDiskVolume;DiskPool=Applicance1-DP;Path=PureDiskVolume;StorageServer=appliance1;MediaServer=adm-media03 2014-08-20 22:49:22 - Info bpduplicate(pid=13072) Suspend window close behavior is not supported when the target destination is a storage unit group 2014-08-20 22:49:22 - Info bpduplicate(pid=13072) window close behavior: Continue processing the current image 2014-08-20 22:49:22 - Info bptm(pid=11160) start 2014-08-20 22:49:22 - started process bptm (11160) 2014-08-20 22:49:22 - Info bptm(pid=11160) using 262144 data buffer size 2014-08-20 22:49:22 - Info bptm(pid=11160) using 64 data buffers 2014-08-20 22:49:22 - Info bptm(pid=11160) start backup 2014-08-20 22:49:24 - Info bptm(pid=11160) backup child process is pid 10132.13576 2014-08-20 22:49:24 - Info bptm(pid=11160) Waiting for mount of media id XO0308 (copy 2) on server adm-master01. 2014-08-20 22:49:24 - started process bptm (11160) 2014-08-20 22:49:24 - mounting XO0308 2014-08-20 22:49:24 - Info bptm(pid=11160) INF - Waiting for mount of media id XO0308 on server adm-master01 for writing. 2014-08-20 22:49:24 - Info bptm(pid=10132) start 2014-08-20 22:49:24 - started process bptm (10132) 2014-08-20 22:49:26 - Info bpdm(pid=6272) started 2014-08-20 22:49:26 - started process bpdm (6272) 2014-08-20 22:49:26 - Info bpdm(pid=6272) reading backup image 2014-08-20 22:49:27 - Info bpdm(pid=6272) using 64 data buffers 2014-08-20 22:49:27 - Info bpdm(pid=6272) spawning a child process 2014-08-20 22:49:27 - Info bpbrm(pid=6272) child pid: 6936 2014-08-20 22:49:27 - Info bpdm(pid=6272) requesting nbjm for media 2014-08-20 22:49:27 - Info bpdm(pid=6936) started 2014-08-20 22:49:27 - started process bpdm (6936) 2014-08-20 22:49:29 - begin reading 2014-08-20 23:05:48 - Error bptm(pid=11160) error requesting media, TpErrno = Robot operation failed 2014-08-20 23:06:28 - Warning bptm(pid=11160) media id XO0308 load operation reported an error 2014-08-20 23:06:28 - current media XO0308 complete, requesting next resource Any 2014-08-20 23:36:56 - Error nbjm(pid=7920) NBU status: 98, EMM status: The media server reported a system error 2014-08-20 23:36:57 - Info bptm(pid=11160) EXITING with status 98 <---------- 2014-08-20 23:36:57 - Error bpduplicate(pid=13072) host adm-media03 backup id p250-1.esf.se_1405985416 read failed, termination requested by administrator (150). 2014-08-20 23:36:57 - Error bpduplicate(pid=13072) host adm-master01 backupid p250-1.esf.se_1405985416 write failed, error requesting media (tpreq) (98). 2014-08-20 23:36:57 - Error bpduplicate(pid=13072) Duplicate of backupid p250-1.esf.se_1405985416 failed, error requesting media (tpreq) (98). 2014-08-20 23:36:57 - requesting resource @aaab3 2014-08-20 23:36:57 - granted resource MediaID=@aaab3;DiskVolume=PureDiskVolume;DiskPool=Applicance1-DP;Path=PureDiskVolume;StorageServer=appliance1;MediaServer=adm-media03 2014-08-20 23:36:58 - Info bptm(pid=11456) start 2014-08-20 23:36:58 - started process bptm (11456) 2014-08-20 23:36:58 - requesting resource adm-master01-hcart2-robot-tld-1 2014-08-20 23:36:58 - awaiting resource adm-master01-hcart2-robot-tld-1 - No drives are available 2014-08-20 23:38:54 - awaiting resource adm-master01-hcart2-robot-tld-1 Reason: Robotic library is down on server, Media Server: adm-master01, Robot Number: 0, Robot Type: TLD, Media ID: N/A, Drive Name: N/A, Volume Pool: ESF_for_ever, Storage Unit: adm-master01-hcart2-robot-tld-1, Drive Scan Host: N/A 2014-08-20 23:39:00 - awaiting resource adm-master01-hcart2-robot-tld-1 - No drives are available 2014-08-20 23:40:30 - Info bptm(pid=11456) using 262144 data buffer size 2014-08-20 23:40:30 - Info bptm(pid=11456) using 64 data buffers 2014-08-20 23:40:30 - Info bptm(pid=11456) start backup 2014-08-20 23:40:30 - granted resource XO0308 2014-08-20 23:40:30 - granted resource IBM.ULT3580-TD5.Drive1 2014-08-20 23:40:30 - granted resource adm-master01-hcart2-robot-tld-1 2014-08-20 23:40:32 - Info bptm(pid=11456) backup child process is pid 13412.10036 2014-08-20 23:40:32 - Info bptm(pid=11456) Waiting for mount of media id XO0308 (copy 2) on server adm-master01. 2014-08-20 23:40:32 - started process bptm (11456) 2014-08-20 23:40:32 - mounting XO0308 2014-08-20 23:40:32 - Info bptm(pid=11456) INF - Waiting for mount of media id XO0308 on server adm-master01 for writing. 2014-08-20 23:40:32 - Info bptm(pid=13412) start 2014-08-20 23:40:32 - started process bptm (13412) 2014-08-20 23:40:34 - Info bpdm(pid=7652) started 2014-08-20 23:40:34 - started process bpdm (7652) 2014-08-20 23:40:35 - Info bpdm(pid=7652) reading backup image 2014-08-20 23:40:35 - Info bpdm(pid=7652) using 64 data buffers 2014-08-20 23:40:35 - Info bpdm(pid=7652) spawning a child process 2014-08-20 23:40:35 - Info bpbrm(pid=7652) child pid: 7392 2014-08-20 23:40:35 - Info bpdm(pid=7652) requesting nbjm for media 2014-08-20 23:40:35 - Info bpdm(pid=7392) started 2014-08-20 23:40:35 - started process bpdm (7392) 2014-08-20 23:40:38 - begin reading 2014-08-20 23:56:33 - Error bptm(pid=11456) error requesting media, TpErrno = Robot operation failed 2014-08-20 23:57:13 - Warning bptm(pid=11456) media id XO0308 load operation reported an error 2014-08-20 23:57:13 - current media XO0308 complete, requesting next resource Any 2014-08-21 00:27:54 - Error nbjm(pid=7920) NBU status: 98, EMM status: The media server reported a system error 2014-08-21 00:27:55 - Info bptm(pid=11456) EXITING with status 98 <---------- 2014-08-21 00:27:56 - Error bpduplicate(pid=13072) host adm-media03 backup id p250-1.esf.se_1406071808 read failed, termination requested by administrator (150). 2014-08-21 00:27:56 - Error bpduplicate(pid=13072) host adm-master01 backupid p250-1.esf.se_1406071808 write failed, error requesting media (tpreq) (98). 2014-08-21 00:27:56 - Error bpduplicate(pid=13072) Duplicate of backupid p250-1.esf.se_1406071808 failed, error requesting media (tpreq) (98). 2014-08-21 00:27:56 - Info bptm(pid=6716) start 2014-08-21 00:27:56 - started process bptm (6716) 2014-08-21 00:27:56 - requesting resource @aaab3 2014-08-21 00:27:56 - granted resource MediaID=@aaab3;DiskVolume=PureDiskVolume;DiskPool=Applicance1-DP;Path=PureDiskVolume;StorageServer=appliance1;MediaServer=adm-media03 2014-08-21 00:27:56 - requesting resource adm-master01-hcart2-robot-tld-1 2014-08-21 00:27:57 - awaiting resource adm-master01-hcart2-robot-tld-1 Reason: Tape media server is not active, Media Server: adm-master01, Robot Number: 0, Robot Type: TLD, Media ID: N/A, Drive Name: N/A, Volume Pool: ESF_for_ever, Storage Unit: adm-master01-hcart2-robot-tld-1, Drive Scan Host: N/A 2014-08-21 00:29:03 - awaiting resource adm-master01-hcart2-robot-tld-1 - No drives are available 2014-08-21 00:41:44 - awaiting resource adm-master01-hcart2-robot-tld-1 Reason: Drives are in use, Media Server: adm-master01, Robot Number: 0, Robot Type: TLD, Media ID: N/A, Drive Name: N/A, Volume Pool: ESF_for_ever, Storage Unit: adm-master01-hcart2-robot-tld-1, Drive Scan Host: N/A 2014-08-21 00:41:52 - awaiting resource adm-master01-hcart2-robot-tld-1 - No drives are available 2014-08-21 00:56:38 - Info bptm(pid=6716) using 262144 data buffer size 2014-08-21 00:56:38 - Info bptm(pid=6716) using 64 data buffers 2014-08-21 00:56:38 - Info bptm(pid=6716) start backup 2014-08-21 00:56:38 - granted resource XO0308 2014-08-21 00:56:38 - granted resource IBM.ULT3580-TD5.Drive2 2014-08-21 00:56:38 - granted resource adm-master01-hcart2-robot-tld-1 2014-08-21 00:56:40 - Info bptm(pid=6716) backup child process is pid 8516.11560 2014-08-21 00:56:40 - Info bptm(pid=8516) start 2014-08-21 00:56:40 - Info bptm(pid=6716) Waiting for mount of media id XO0308 (copy 2) on server adm-master01. 2014-08-21 00:56:40 - started process bptm (8516) 2014-08-21 00:56:40 - started process bptm (6716) 2014-08-21 00:56:40 - mounting XO0308 2014-08-21 00:56:40 - Info bptm(pid=6716) INF - Waiting for mount of media id XO0308 on server adm-master01 for writing. 2014-08-21 00:56:42 - Info bpdm(pid=6624) started 2014-08-21 00:56:42 - started process bpdm (6624) 2014-08-21 00:56:43 - Info bpdm(pid=6624) reading backup image 2014-08-21 00:56:43 - Info bpdm(pid=6624) using 64 data buffers 2014-08-21 00:56:43 - Info bpdm(pid=6624) spawning a child process 2014-08-21 00:56:43 - Info bpbrm(pid=6624) child pid: 6172 2014-08-21 00:56:43 - Info bpdm(pid=6624) requesting nbjm for media 2014-08-21 00:56:43 - Info bpdm(pid=6172) started 2014-08-21 00:56:43 - started process bpdm (6172) 2014-08-21 00:56:46 - begin reading 2014-08-21 01:13:06 - Error bptm(pid=6716) error requesting media, TpErrno = Robot operation failed 2014-08-21 01:13:46 - Warning bptm(pid=6716) media id XO0308 load operation reported an error 2014-08-21 01:13:46 - current media XO0308 complete, requesting next resource Any 2014-08-21 01:44:15 - Error nbjm(pid=7920) NBU status: 98, EMM status: The media server reported a system error 2014-08-21 01:44:16 - Info bptm(pid=6716) EXITING with status 98 <---------- 2014-08-21 01:44:16 - Error bpduplicate(pid=13072) host adm-media03 backup id esf-sql01.esf.se_1406078511 read failed, termination requested by administrator (150). 2014-08-21 01:44:16 - Error bpduplicate(pid=13072) host adm-master01 backupid esf-sql01.esf.se_1406078511 write failed, error requesting media (tpreq) (98). 2014-08-21 01:44:17 - Error bpduplicate(pid=13072) Duplicate of backupid esf-sql01.esf.se_1406078511 failed, error requesting media (tpreq) (98). 2014-08-21 01:44:17 - requesting resource @aaab3 2014-08-21 01:44:17 - granted resource MediaID=@aaab3;DiskVolume=PureDiskVolume;DiskPool=Applicance1-DP;Path=PureDiskVolume;StorageServer=appliance1;MediaServer=adm-media03 2014-08-21 01:44:17 - Info bptm(pid=9280) start 2014-08-21 01:44:17 - started process bptm (9280) 2014-08-21 01:44:17 - requesting resource adm-master01-hcart2-robot-tld-1 2014-08-21 01:44:18 - awaiting resource adm-master01-hcart2-robot-tld-1 - No drives are available 2014-08-21 01:44:19 - Info adm-media03(pid=6624) StorageServer=PureDisk:appliance1; Report=PDDO Stats for (appliance1): read: 38912 KB, CR received: 15940 KB, CR received over FC: 0 KB, dedup: 0.0% 2014-08-21 02:15:47 - Info bptm(pid=9280) using 262144 data buffer size 2014-08-21 02:15:47 - Info bptm(pid=9280) using 64 data buffers 2014-08-21 02:15:47 - granted resource XO0308 2014-08-21 02:15:47 - granted resource IBM.ULT3580-TD5.Drive4 2014-08-21 02:15:47 - granted resource adm-master01-hcart2-robot-tld-1 2014-08-21 02:15:47 - Info bptm(pid=9280) start backup 2014-08-21 02:15:48 - Info bptm(pid=9280) backup child process is pid 10028.8760 2014-08-21 02:15:48 - Info bptm(pid=9280) Waiting for mount of media id XO0308 (copy 2) on server adm-master01. 2014-08-21 02:15:48 - started process bptm (9280) 2014-08-21 02:15:48 - mounting XO0308 2014-08-21 02:15:48 - Info bptm(pid=9280) INF - Waiting for mount of media id XO0308 on server adm-master01 for writing. 2014-08-21 02:15:48 - Info bptm(pid=10028) start 2014-08-21 02:15:49 - started process bptm (10028) 2014-08-21 02:15:51 - Info bpdm(pid=1060) started 2014-08-21 02:15:51 - started process bpdm (1060) 2014-08-21 02:15:51 - Info bpdm(pid=1060) reading backup image 2014-08-21 02:15:51 - Info bpdm(pid=1060) using 64 data buffers 2014-08-21 02:15:51 - Info bpdm(pid=1060) spawning a child process 2014-08-21 02:15:51 - Info bpbrm(pid=1060) child pid: 7208 2014-08-21 02:15:51 - Info bpdm(pid=1060) requesting nbjm for media 2014-08-21 02:15:51 - Info bpdm(pid=7208) started 2014-08-21 02:15:51 - started process bpdm (7208) 2014-08-21 02:15:56 - begin reading 2014-08-21 02:33:23 - Error bptm(pid=9280) error requesting media, TpErrno = Robot operation failed 2014-08-21 02:34:03 - Warning bptm(pid=9280) media id XO0308 load operation reported an error 2014-08-21 02:34:03 - current media XO0308 complete, requesting next resource Any 2014-08-21 03:04:38 - Error nbjm(pid=7920) NBU status: 98, EMM status: The media server reported a system error 2014-08-21 03:04:39 - Info bptm(pid=9280) EXITING with status 98 <---------- 2014-08-21 03:04:40 - Error bpduplicate(pid=13072) host adm-media03 backup id esf-sql01.esf.se_1406079305 read failed, socket write failed (24). 2014-08-21 03:04:40 - Error bpduplicate(pid=13072) host adm-master01 backupid esf-sql01.esf.se_1406079305 write failed, error requesting media (tpreq) (98). 2014-08-21 03:04:40 - Error bpduplicate(pid=13072) Duplicate of backupid esf-sql01.esf.se_1406079305 failed, error requesting media (tpreq) (98). 2014-08-21 03:04:40 - requesting resource @aaab3 2014-08-21 03:04:40 - granted resource MediaID=@aaab3;DiskVolume=PureDiskVolume;DiskPool=Applicance1-DP;Path=PureDiskVolume;StorageServer=appliance1;MediaServer=adm-media03 2014-08-21 03:04:41 - Info bptm(pid=8784) start 2014-08-21 03:04:41 - started process bptm (8784) 2014-08-21 03:04:41 - requesting resource adm-master01-hcart2-robot-tld-1 2014-08-21 03:04:41 - awaiting resource adm-master01-hcart2-robot-tld-1 - No drives are available 2014-08-21 03:05:09 - awaiting resource adm-master01-hcart2-robot-tld-1 Reason: Robotic library is down on server, Media Server: adm-master01, Robot Number: 0, Robot Type: TLD, Media ID: N/A, Drive Name: N/A, Volume Pool: ESF_for_ever, Storage Unit: adm-master01-hcart2-robot-tld-1, Drive Scan Host: N/A 2014-08-21 03:07:12 - awaiting resource adm-master01-hcart2-robot-tld-1 - No drives are available 2014-08-21 04:04:11 - Info bptm(pid=8784) using 262144 data buffer size 2014-08-21 04:04:11 - Info bptm(pid=8784) using 64 data buffers 2014-08-21 04:04:11 - granted resource XO0308 2014-08-21 04:04:11 - granted resource IBM.ULT3580-TD5.Drive4 2014-08-21 04:04:11 - granted resource adm-master01-hcart2-robot-tld-1 2014-08-21 04:04:12 - Info bptm(pid=8784) start backup 2014-08-21 04:04:13 - Info bptm(pid=8784) backup child process is pid 11404.10340 2014-08-21 04:04:13 - Info bptm(pid=8784) Waiting for mount of media id XO0308 (copy 2) on server adm-master01. 2014-08-21 04:04:13 - started process bptm (8784) 2014-08-21 04:04:13 - mounting XO0308 2014-08-21 04:04:13 - Info bptm(pid=8784) INF - Waiting for mount of media id XO0308 on server adm-master01 for writing. 2014-08-21 04:04:13 - Info bptm(pid=11404) start 2014-08-21 04:04:13 - started process bptm (11404) 2014-08-21 04:04:16 - Info bpdm(pid=5484) started 2014-08-21 04:04:16 - started process bpdm (5484) 2014-08-21 04:04:16 - Info bpdm(pid=5484) reading backup image 2014-08-21 04:04:16 - Info bpdm(pid=5484) using 64 data buffers 2014-08-21 04:04:16 - Info bpdm(pid=7732) started 2014-08-21 04:04:16 - Info bpdm(pid=5484) spawning a child process 2014-08-21 04:04:16 - started process bpdm (7732) 2014-08-21 04:04:16 - Info bpbrm(pid=5484) child pid: 7732 2014-08-21 04:04:16 - Info bpdm(pid=5484) requesting nbjm for media 2014-08-21 04:04:19 - begin reading 2014-08-21 04:04:20 - end reading; read time: 0:00:01 2014-08-21 04:04:20 - Info bpdm(pid=5484) completed reading backup image 2014-08-21 04:05:56 - Error bptm(pid=8784) error requesting media, TpErrno = Robot operation failed 2014-08-21 04:06:36 - Warning bptm(pid=8784) media id XO0308 load operation reported an error 2014-08-21 04:06:36 - current media XO0308 complete, requesting next resource Any 2014-08-21 04:09:04 - Info bptm(pid=8784) Waiting for mount of media id XO0308 (copy 2) on server adm-master01. 2014-08-21 04:09:04 - started process bptm (8784) 2014-08-21 04:09:04 - mounting XO0308 2014-08-21 04:09:04 - Info bptm(pid=8784) INF - Waiting for mount of media id XO0308 on server adm-master01 for writing. 2014-08-21 04:09:04 - granted resource XO0308 2014-08-21 04:09:04 - granted resource IBM.ULT3580-TD5.Drive4 2014-08-21 04:09:04 - granted resource adm-master01-hcart2-robot-tld-1 2014-08-21 04:10:56 - Error bptm(pid=8784) error requesting media, TpErrno = Robot operation failed 2014-08-21 04:11:36 - Warning bptm(pid=8784) media id XO0308 load operation reported an error 2014-08-21 04:11:36 - current media XO0308 complete, requesting next resource Any 2014-08-21 04:14:04 - Info bptm(pid=8784) Waiting for mount of media id XO0308 (copy 2) on server adm-master01. 2014-08-21 04:14:04 - started process bptm (8784) 2014-08-21 04:14:04 - mounting XO0308 2014-08-21 04:14:04 - Info bptm(pid=8784) INF - Waiting for mount of media id XO0308 on server adm-master01 for writing. 2014-08-21 04:14:04 - granted resource XO0308 2014-08-21 04:14:04 - granted resource IBM.ULT3580-TD5.Drive4 2014-08-21 04:14:04 - granted resource adm-master01-hcart2-robot-tld-1 2014-08-21 04:15:41 - Error bptm(pid=8784) error requesting media, TpErrno = Robot operation failed 2014-08-21 04:16:21 - Warning bptm(pid=8784) media id XO0308 load operation reported an error 2014-08-21 04:16:21 - current media XO0308 complete, requesting next resource Any 2014-08-21 04:18:49 - Info bptm(pid=8784) Waiting for mount of media id XO0308 (copy 2) on server adm-master01. 2014-08-21 04:18:49 - started process bptm (8784) 2014-08-21 04:18:49 - mounting XO0308 2014-08-21 04:18:49 - Info bptm(pid=8784) INF - Waiting for mount of media id XO0308 on server adm-master01 for writing. 2014-08-21 04:18:49 - granted resource XO0308 2014-08-21 04:18:49 - granted resource IBM.ULT3580-TD5.Drive4 2014-08-21 04:18:49 - granted resource adm-master01-hcart2-robot-tld-1 2014-08-21 04:20:41 - Error bptm(pid=8784) error requesting media, TpErrno = Robot operation failed 2014-08-21 04:21:21 - Warning bptm(pid=8784) media id XO0308 load operation reported an error 2014-08-21 04:21:21 - current media XO0308 complete, requesting next resource Any 2014-08-21 04:23:50 - Info bptm(pid=8784) Waiting for mount of media id XO0308 (copy 2) on server adm-master01. 2014-08-21 04:23:50 - started process bptm (8784) 2014-08-21 04:23:50 - mounting XO0308 2014-08-21 04:23:50 - Info bptm(pid=8784) INF - Waiting for mount of media id XO0308 on server adm-master01 for writing. 2014-08-21 04:23:50 - granted resource XO0308 2014-08-21 04:23:50 - granted resource IBM.ULT3580-TD5.Drive4 2014-08-21 04:23:50 - granted resource adm-master01-hcart2-robot-tld-1 2014-08-21 04:25:41 - Error bptm(pid=8784) error requesting media, TpErrno = Robot operation failed 2014-08-21 04:26:21 - Warning bptm(pid=8784) media id XO0308 load operation reported an error 2014-08-21 04:26:21 - current media XO0308 complete, requesting next resource Any 2014-08-21 04:27:51 - Info bptm(pid=8784) Waiting for mount of media id XO0354 (copy 2) on server adm-master01. 2014-08-21 04:27:51 - started process bptm (8784) 2014-08-21 04:27:51 - mounting XO0354 2014-08-21 04:27:51 - Info bptm(pid=8784) INF - Waiting for mount of media id XO0354 on server adm-master01 for writing. 2014-08-21 04:27:51 - granted resource XO0354 2014-08-21 04:27:51 - granted resource IBM.ULT3580-TD5.Drive4 2014-08-21 04:27:51 - granted resource adm-master01-hcart2-robot-tld-1 2014-08-21 04:37:27 - Error bptm(pid=8784) error requesting media, TpErrno = No robot daemon or robotics are unavailable 2014-08-21 04:38:07 - Warning bptm(pid=8784) media id XO0354 load operation reported an error 2014-08-21 04:38:07 - current media XO0354 complete, requesting next resource Any 2014-08-21 05:08:39 - Info bptm(pid=8784) EXITING with status 98 <---------- 2014-08-21 05:08:39 - Error bpduplicate(pid=13072) host adm-master01 backupid esf-sql01.esf.se_1406079528 write failed, error requesting media (tpreq) (98). 2014-08-21 05:08:39 - Error bpduplicate(pid=13072) Duplicate of backupid esf-sql01.esf.se_1406079528 failed, error requesting media (tpreq) (98). 2014-08-21 05:08:39 - Info bptm(pid=12852) start 2014-08-21 05:08:39 - Error nbjm(pid=7920) NBU status: 98, EMM status: The media server reported a system error 2014-08-21 05:08:40 - started process bptm (12852) 2014-08-21 05:08:40 - requesting resource adm-master01-hcart2-robot-tld-1 2014-08-21 05:08:40 - awaiting resource adm-master01-hcart2-robot-tld-1 - No drives are available 2014-08-21 05:32:17 - awaiting resource adm-master01-hcart2-robot-tld-1 Reason: Drives are in use, Media Server: adm-master01, Robot Number: 0, Robot Type: TLD, Media ID: N/A, Drive Name: N/A, Volume Pool: ESF_for_ever, Storage Unit: adm-master01-hcart2-robot-tld-1, Drive Scan Host: N/A 2014-08-21 05:32:25 - awaiting resource adm-master01-hcart2-robot-tld-1 - No drives are available 2014-08-21 05:56:37 - awaiting resource adm-master01-hcart2-robot-tld-1 Reason: Drives are in use, Media Server: adm-master01, Robot Number: 0, Robot Type: TLD, Media ID: N/A, Drive Name: N/A, Volume Pool: ESF_for_ever, Storage Unit: adm-master01-hcart2-robot-tld-1, Drive Scan Host: N/A 2014-08-21 05:56:44 - awaiting resource adm-master01-hcart2-robot-tld-1 - No drives are available 2014-08-21 06:20:02 - awaiting resource adm-master01-hcart2-robot-tld-1 Reason: Drives are in use, Media Server: adm-master01, Robot Number: 0, Robot Type: TLD, Media ID: N/A, Drive Name: N/A, Volume Pool: ESF_for_ever, Storage Unit: adm-master01-hcart2-robot-tld-1, Drive Scan Host: N/A 2014-08-21 06:21:08 - awaiting resource adm-master01-hcart2-robot-tld-1 - No drives are available 2014-08-21 07:16:45 - granted resource XO0354 2014-08-21 07:16:45 - granted resource IBM.ULT3580-TD5.Drive2 2014-08-21 07:16:45 - granted resource adm-master01-hcart2-robot-tld-1 2014-08-21 07:16:46 - Info bptm(pid=12852) using 262144 data buffer size 2014-08-21 07:16:46 - Info bptm(pid=12852) using 64 data buffers 2014-08-21 07:16:46 - Info bptm(pid=12852) start backup 2014-08-21 07:16:46 - Info bptm(pid=12852) backup child process is pid 9520.14236 2014-08-21 07:16:46 - Info bptm(pid=12852) Waiting for mount of media id XO0354 (copy 2) on server adm-master01. 2014-08-21 07:16:46 - started process bptm (12852) 2014-08-21 07:16:46 - mounting XO0354 2014-08-21 07:16:46 - Info bptm(pid=12852) INF - Waiting for mount of media id XO0354 on server adm-master01 for writing. 2014-08-21 07:16:46 - Info bptm(pid=9520) start 2014-08-21 07:16:46 - started process bptm (9520) 2014-08-21 07:16:49 - Info bpdm(pid=5484) using 64 data buffers 2014-08-21 07:16:49 - Info bpdm(pid=5484) spawning a child process 2014-08-21 07:16:49 - Info bpbrm(pid=5484) child pid: 7780 2014-08-21 07:16:49 - Info bpdm(pid=7780) started 2014-08-21 07:16:49 - started process bpdm (7780) 2014-08-21 07:16:50 - begin reading 2014-08-21 07:16:50 - end reading; read time: 0:00:00 2014-08-21 07:16:51 - Info bpdm(pid=5484) completed reading backup image 2014-08-21 07:31:47 - Error bptm(pid=12852) error requesting media, TpErrno = Robot operation failed 2014-08-21 07:32:27 - Warning bptm(pid=12852) media id XO0354 load operation reported an error 2014-08-21 07:32:27 - current media XO0354 complete, requesting next resource Any 2014-08-21 08:02:58 - Info bptm(pid=12852) EXITING with status 98 <---------- 2014-08-21 08:02:58 - Error bpduplicate(pid=13072) host adm-master01 backupid esf-sql01.esf.se_1406079596 write failed, error requesting media (tpreq) (98). 2014-08-21 08:02:58 - Error nbjm(pid=7920) NBU status: 98, EMM status: The media server reported a system error 2014-08-21 08:02:59 - Error bpduplicate(pid=13072) Duplicate of backupid esf-sql01.esf.se_1406079596 failed, error requesting media (tpreq) (98). 2014-08-21 08:02:59 - Info bptm(pid=11280) start 2014-08-21 08:02:59 - started process bptm (11280) 2014-08-21 08:02:59 - requesting resource adm-master01-hcart2-robot-tld-1 2014-08-21 08:02:59 - awaiting resource adm-master01-hcart2-robot-tld-1 - No drives are available 2014-08-21 09:22:57 - Info bptm(pid=11280) using 262144 data buffer size 2014-08-21 09:22:57 - Info bptm(pid=11280) using 64 data buffers 2014-08-21 09:22:57 - granted resource XO0354 2014-08-21 09:22:57 - granted resource IBM.ULT3580-TD5.Drive4 2014-08-21 09:22:57 - granted resource adm-master01-hcart2-robot-tld-1 2014-08-21 09:22:58 - Info bptm(pid=11280) start backup 2014-08-21 09:22:58 - Info bptm(pid=11280) backup child process is pid 6920.9776 2014-08-21 09:22:58 - Info bptm(pid=11280) Waiting for mount of media id XO0354 (copy 2) on server adm-master01. 2014-08-21 09:22:58 - started process bptm (11280) 2014-08-21 09:22:58 - mounting XO0354 2014-08-21 09:22:58 - Info bptm(pid=11280) INF - Waiting for mount of media id XO0354 on server adm-master01 for writing. 2014-08-21 09:22:58 - Info bptm(pid=6920) start 2014-08-21 09:22:58 - started process bptm (6920) 2014-08-21 09:23:01 - Info bpdm(pid=5484) using 64 data buffers 2014-08-21 09:23:01 - Info bpdm(pid=5484) spawning a child process 2014-08-21 09:23:01 - Info bpbrm(pid=5484) child pid: 6476 2014-08-21 09:23:01 - Info bpdm(pid=6476) started 2014-08-21 09:23:01 - started process bpdm (6476) 2014-08-21 09:23:02 - begin reading 2014-08-21 09:23:02 - end reading; read time: 0:00:00 2014-08-21 09:23:02 - Info bpdm(pid=5484) completed reading backup image 2014-08-21 09:23:22 - Info bptm(pid=11280) media id XO0354 mounted on drive index 8, drivepath {3,0,9,0}, drivename IBM.ULT3580-TD5.Drive4, copy 2 2014-08-21 09:23:22 - Info bptm(pid=11280) INF - Waiting for positioning of media id XO0354 on server adm-master01 for writing. 2014-08-21 09:28:39 - Warning bptm(pid=11280) cannot locate on drive index 8, No more data is on the tape. 2014-08-21 09:56:17 - Error bptm(pid=11280) cannot position media id XO0354 for write 2014-08-21 09:56:17 - Error bpduplicate(pid=13072) host adm-master01 backupid esf-sql01.esf.se_1406079669 write failed, media position error (86). 2014-08-21 09:56:17 - Info bptm(pid=11280) EXITING with status 86 <---------- 2014-08-21 09:56:17 - Error bpduplicate(pid=13072) Duplicate of backupid esf-sql01.esf.se_1406079669 failed, media position error (86). 2014-08-21 09:56:17 - Info bptm(pid=12172) start 2014-08-21 09:56:17 - started process bptm (12172) 2014-08-21 09:56:17 - requesting resource adm-master01-hcart2-robot-tld-1 2014-08-21 09:56:17 - awaiting resource adm-master01-hcart2-robot-tld-1 - No drives are available 2014-08-21 09:57:30 - granted resource XO0354 2014-08-21 09:57:30 - granted resource IBM.ULT3580-TD5.Drive2 2014-08-21 09:57:30 - granted resource adm-master01-hcart2-robot-tld-1 2014-08-21 09:57:31 - Info bptm(pid=12172) using 262144 data buffer size 2014-08-21 09:57:31 - Info bptm(pid=12172) using 64 data buffers 2014-08-21 09:57:31 - Info bptm(pid=12172) start backup 2014-08-21 09:57:31 - Info bptm(pid=12172) backup child process is pid 13660.12440 2014-08-21 09:57:31 - Info bptm(pid=12172) Waiting for mount of media id XO0354 (copy 2) on server adm-master01. 2014-08-21 09:57:31 - started process bptm (12172) 2014-08-21 09:57:31 - mounting XO0354 2014-08-21 09:57:31 - Info bptm(pid=13660) start 2014-08-21 09:57:31 - Info bptm(pid=12172) INF - Waiting for mount of media id XO0354 on server adm-master01 for writing. 2014-08-21 09:57:31 - started process bptm (13660) 2014-08-21 09:57:34 - Info bpdm(pid=5484) using 64 data buffers 2014-08-21 09:57:34 - Info bpdm(pid=5484) spawning a child process 2014-08-21 09:57:34 - Info bpbrm(pid=5484) child pid: 7456 2014-08-21 09:57:35 - Info bpdm(pid=7456) started 2014-08-21 09:57:35 - started process bpdm (7456) 2014-08-21 09:57:35 - begin reading 2014-08-21 09:57:35 - end reading; read time: 0:00:00 2014-08-21 09:57:36 - Info bpdm(pid=5484) completed reading backup image 2014-08-21 09:57:54 - Info bptm(pid=12172) media id XO0354 mounted on drive index 0, drivepath {3,0,7,0}, drivename IBM.ULT3580-TD5.Drive2, copy 2 2014-08-21 09:57:54 - Info bptm(pid=12172) INF - Waiting for positioning of media id XO0354 on server adm-master01 for writing. 2014-08-21 10:03:13 - Warning bptm(pid=12172) cannot locate on drive index 0, No more data is on the tape. 2014-08-21 10:30:51 - Error bptm(pid=12172) cannot position media id XO0354 for write 2014-08-21 10:30:51 - Error bpduplicate(pid=13072) host adm-master01 backupid esf-sql01.esf.se_1406079743 write failed, media position error (86). 2014-08-21 10:30:51 - Info bptm(pid=12172) EXITING with status 86 <---------- 2014-08-21 10:30:51 - Error bpduplicate(pid=13072) Duplicate of backupid esf-sql01.esf.se_1406079743 failed, media position error (86). 2014-08-21 10:30:52 - Info bptm(pid=9428) start 2014-08-21 10:30:52 - started process bptm (9428) 2014-08-21 10:30:52 - requesting resource adm-master01-hcart2-robot-tld-1 2014-08-21 10:30:52 - awaiting resource adm-master01-hcart2-robot-tld-1 - No drives are available 2014-08-21 10:37:30 - Info bptm(pid=9428) using 262144 data buffer size 2014-08-21 10:37:30 - Info bptm(pid=9428) using 64 data buffers 2014-08-21 10:37:30 - Info bptm(pid=9428) start backup 2014-08-21 10:37:30 - granted resource XO0354 2014-08-21 10:37:30 - granted resource IBM.ULT3580-TD5.Drive3 2014-08-21 10:37:30 - granted resource adm-master01-hcart2-robot-tld-1 2014-08-21 10:37:31 - Info bptm(pid=9428) backup child process is pid 13916.9440 2014-08-21 10:37:31 - Info bptm(pid=9428) Waiting for mount of media id XO0354 (copy 2) on server adm-master01. 2014-08-21 10:37:31 - started process bptm (9428) 2014-08-21 10:37:31 - mounting XO0354 2014-08-21 10:37:31 - Info bptm(pid=9428) INF - Waiting for mount of media id XO0354 on server adm-master01 for writing. 2014-08-21 10:37:31 - Info bptm(pid=13916) start 2014-08-21 10:37:31 - started process bptm (13916) 2014-08-21 10:37:34 - Info bpdm(pid=5484) using 64 data buffers 2014-08-21 10:37:34 - Info bpdm(pid=5484) spawning a child process 2014-08-21 10:37:34 - Info bpbrm(pid=5484) child pid: 6076 2014-08-21 10:37:34 - Info bpdm(pid=6076) started 2014-08-21 10:37:34 - started process bpdm (6076) 2014-08-21 10:37:34 - begin reading 2014-08-21 10:37:35 - end reading; read time: 0:00:01 2014-08-21 10:37:35 - Info bpdm(pid=5484) completed reading backup image 2014-08-21 10:37:54 - Info bptm(pid=9428) media id XO0354 mounted on drive index 6, drivepath {3,0,8,0}, drivename IBM.ULT3580-TD5.Drive3, copy 2 2014-08-21 10:37:54 - Info bptm(pid=9428) INF - Waiting for positioning of media id XO0354 on server adm-master01 for writing. 2014-08-21 10:43:13 - Warning bptm(pid=9428) cannot locate on drive index 6, No more data is on the tape. 2014-08-21 11:10:53 - Error bptm(pid=9428) cannot position media id XO0354 for write 2014-08-21 11:10:53 - Error bpduplicate(pid=13072) host adm-master01 backupid esf-sql01.esf.se_1406079818 write failed, media position error (86). 2014-08-21 11:10:53 - Info bptm(pid=9428) EXITING with status 86 <---------- 2014-08-21 11:10:53 - Error bpduplicate(pid=13072) Duplicate of backupid esf-sql01.esf.se_1406079818 failed, media position error (86). 2014-08-21 11:10:53 - Info bptm(pid=13996) start 2014-08-21 11:10:53 - started process bptm (13996) 2014-08-21 11:10:53 - requesting resource adm-master01-hcart2-robot-tld-1 2014-08-21 11:10:53 - awaiting resource adm-master01-hcart2-robot-tld-1 - No drives are available 2014-08-21 11:26:06 - awaiting resource adm-master01-hcart2-robot-tld-1 Reason: Drives are in use, Media Server: adm-master01, Robot Number: 0, Robot Type: TLD, Media ID: N/A, Drive Name: N/A, Volume Pool: ESF_for_ever, Storage Unit: adm-master01-hcart2-robot-tld-1, Drive Scan Host: N/A 2014-08-21 11:26:12 - awaiting resource adm-master01-hcart2-robot-tld-1 - No drives are available 2014-08-21 11:36:09 - Info bptm(pid=13996) using 262144 data buffer size 2014-08-21 11:36:09 - Info bptm(pid=13996) using 64 data buffers 2014-08-21 11:36:09 - granted resource IBM029 2014-08-21 11:36:09 - granted resource IBM.ULT3580-TD5.Drive5 2014-08-21 11:36:09 - granted resource adm-master01-hcart2-robot-tld-1 2014-08-21 11:36:10 - Info bptm(pid=13996) start backup 2014-08-21 11:36:10 - Info bptm(pid=13996) backup child process is pid 11964.10132 2014-08-21 11:36:10 - Info bptm(pid=13996) Waiting for mount of media id IBM029 (copy 2) on server adm-master01. 2014-08-21 11:36:10 - started process bptm (13996) 2014-08-21 11:36:10 - Info bptm(pid=11964) start 2014-08-21 11:36:10 - mounting IBM029 2014-08-21 11:36:10 - Info bptm(pid=13996) INF - Waiting for mount of media id IBM029 on server adm-master01 for writing. 2014-08-21 11:36:10 - started process bptm (11964) 2014-08-21 11:36:13 - Info bpdm(pid=5484) using 64 data buffers 2014-08-21 11:36:13 - Info bpdm(pid=5484) spawning a child process 2014-08-21 11:36:13 - Info bpbrm(pid=5484) child pid: 1504 2014-08-21 11:36:13 - Info bpdm(pid=1504) started 2014-08-21 11:36:14 - started process bpdm (1504) 2014-08-21 11:36:14 - begin reading 2014-08-21 11:36:14 - end reading; read time: 0:00:00 2014-08-21 11:36:14 - Info bpdm(pid=5484) completed reading backup image 2014-08-21 11:36:33 - Info bptm(pid=13996) media id IBM029 mounted on drive index 7, drivepath {3,0,10,0}, drivename IBM.ULT3580-TD5.Drive5, copy 2 2014-08-21 11:36:33 - Info bptm(pid=13996) INF - Waiting for positioning of media id IBM029 on server adm-master01 for writing. 2014-08-21 11:41:31 - Warning bptm(pid=13996) cannot locate on drive index 7, No more data is on the tape. 2014-08-21 12:08:09 - Error bptm(pid=13996) cannot position media id IBM029 for write 2014-08-21 12:08:09 - Error bpduplicate(pid=13072) host adm-master01 backupid esf-sql01.esf.se_1406079917 write failed, media position error (86). 2014-08-21 12:08:09 - Info bptm(pid=13996) EXITING with status 86 <---------- 2014-08-21 12:08:09 - Error bpduplicate(pid=13072) Duplicate of backupid esf-sql01.esf.se_1406079917 failed, media position error (86). 2014-08-21 12:08:09 - Info bptm(pid=6792) start 2014-08-21 12:08:09 - started process bptm (6792) 2014-08-21 12:08:09 - requesting resource adm-master01-hcart2-robot-tld-1 2014-08-21 12:08:10 - awaiting resource adm-master01-hcart2-robot-tld-1 - No drives are available 2014-08-21 12:21:48 - Info bptm(pid=6792) using 262144 data buffer size 2014-08-21 12:21:48 - Info bptm(pid=6792) using 64 data buffers 2014-08-21 12:21:48 - granted resource IBM029 2014-08-21 12:21:48 - granted resource IBM.ULT3580-TD5.Drive1 2014-08-21 12:21:48 - granted resource adm-master01-hcart2-robot-tld-1 2014-08-21 12:21:49 - Info bptm(pid=6792) start backup 2014-08-21 12:21:49 - Info bptm(pid=6792) backup child process is pid 13328.3772 2014-08-21 12:21:49 - Info bptm(pid=6792) Waiting for mount of media id IBM029 (copy 2) on server adm-master01. 2014-08-21 12:21:49 - started process bptm (6792) 2014-08-21 12:21:49 - mounting IBM029 2014-08-21 12:21:49 - Info bptm(pid=6792) INF - Waiting for mount of media id IBM029 on server adm-master01 for writing. 2014-08-21 12:21:49 - Info bptm(pid=13328) start 2014-08-21 12:21:49 - started process bptm (13328) 2014-08-21 12:21:52 - Info bpdm(pid=5484) using 64 data buffers 2014-08-21 12:21:52 - Info bpdm(pid=5484) spawning a child process 2014-08-21 12:21:52 - Info bpbrm(pid=5484) child pid: 5524 2014-08-21 12:21:53 - Info bpdm(pid=5524) started 2014-08-21 12:21:53 - started process bpdm (5524) 2014-08-21 12:21:53 - begin reading 2014-08-21 12:21:53 - end reading; read time: 0:00:00 2014-08-21 12:21:53 - Info bpdm(pid=5484) completed reading backup image 2014-08-21 12:22:14 - Info bptm(pid=6792) media id IBM029 mounted on drive index 4, drivepath {3,0,6,0}, drivename IBM.ULT3580-TD5.Drive1, copy 2 2014-08-21 12:22:14 - Info bptm(pid=6792) INF - Waiting for positioning of media id IBM029 on server adm-master01 for writing. 2014-08-21 12:27:11 - Warning bptm(pid=6792) cannot locate on drive index 4, No more data is on the tape. 2014-08-21 12:53:49 - Error bptm(pid=6792) cannot position media id IBM029 for write 2014-08-21 12:53:50 - Error bpduplicate(pid=13072) host adm-master01 backupid esf-sql01.esf.se_1406080075 write failed, media position error (86). 2014-08-21 12:53:50 - Info bptm(pid=6792) EXITING with status 86 <---------- 2014-08-21 12:53:50 - Error bpduplicate(pid=13072) Duplicate of backupid esf-sql01.esf.se_1406080075 failed, media position error (86). 2014-08-21 12:53:50 - Info bptm(pid=13696) start 2014-08-21 12:53:50 - started process bptm (13696) 2014-08-21 12:53:50 - requesting resource adm-master01-hcart2-robot-tld-1 2014-08-21 12:53:50 - awaiting resource adm-master01-hcart2-robot-tld-1 - No drives are available 2014-08-21 12:54:21 - awaiting resource adm-master01-hcart2-robot-tld-1 Reason: Drives are in use, Media Server: adm-master01, Robot Number: 0, Robot Type: TLD, Media ID: N/A, Drive Name: N/A, Volume Pool: ESF_for_ever, Storage Unit: adm-master01-hcart2-robot-tld-1, Drive Scan Host: N/A 2014-08-21 12:54:39 - awaiting resource adm-master01-hcart2-robot-tld-1 - No drives are available 2014-08-21 12:57:12 - awaiting resource adm-master01-hcart2-robot-tld-1 Reason: Drives are in use, Media Server: adm-master01, Robot Number: 0, Robot Type: TLD, Media ID: N/A, Drive Name: N/A, Volume Pool: ESF_for_ever, Storage Unit: adm-master01-hcart2-robot-tld-1, Drive Scan Host: N/A 2014-08-21 12:57:17 - awaiting resource adm-master01-hcart2-robot-tld-1 - No drives are available 2014-08-21 13:19:16 - awaiting resource adm-master01-hcart2-robot-tld-1 Reason: Drives are in use, Media Server: adm-master01, Robot Number: 0, Robot Type: TLD, Media ID: N/A, Drive Name: N/A, Volume Pool: ESF_for_ever, Storage Unit: adm-master01-hcart2-robot-tld-1, Drive Scan Host: N/A 2014-08-21 13:19:22 - awaiting resource adm-master01-hcart2-robot-tld-1 - No drives are available 2014-08-21 13:22:18 - awaiting resource adm-master01-hcart2-robot-tld-1 Reason: Drives are in use, Media Server: adm-master01, Robot Number: 0, Robot Type: TLD, Media ID: N/A, Drive Name: N/A, Volume Pool: ESF_for_ever, Storage Unit: adm-master01-hcart2-robot-tld-1, Drive Scan Host: N/A 2014-08-21 13:22:20 - awaiting resource adm-master01-hcart2-robot-tld-1 - No drives are available 2014-08-21 13:23:51 - awaiting resource adm-master01-hcart2-robot-tld-1 Reason: Drives are in use, Media Server: adm-master01, Robot Number: 0, Robot Type: TLD, Media ID: N/A, Drive Name: N/A, Volume Pool: ESF_for_ever, Storage Unit: adm-master01-hcart2-robot-tld-1, Drive Scan Host: N/A 2014-08-21 13:23:57 - awaiting resource adm-master01-hcart2-robot-tld-1 - No drives are available 2014-08-21 13:24:08 - Info bptm(pid=13696) using 262144 data buffer size 2014-08-21 13:24:08 - Info bptm(pid=13696) using 64 data buffers 2014-08-21 13:24:08 - granted resource IBM029 2014-08-21 13:24:08 - granted resource IBM.ULT3580-TD5.Drive3 2014-08-21 13:24:08 - granted resource adm-master01-hcart2-robot-tld-1 2014-08-21 13:24:09 - Info bptm(pid=13696) start backup 2014-08-21 13:24:09 - Info bptm(pid=13696) backup child process is pid 13500.9952 2014-08-21 13:24:09 - Info bptm(pid=13696) Waiting for mount of media id IBM029 (copy 2) on server adm-master01. 2014-08-21 13:24:09 - started process bptm (13696) 2014-08-21 13:24:09 - mounting IBM029 2014-08-21 13:24:09 - Info bptm(pid=13696) INF - Waiting for mount of media id IBM029 on server adm-master01 for writing. 2014-08-21 13:24:09 - Info bptm(pid=13500) start 2014-08-21 13:24:09 - started process bptm (13500) 2014-08-21 13:24:12 - Info bpdm(pid=5484) using 64 data buffers 2014-08-21 13:24:12 - Info bpdm(pid=5484) spawning a child process 2014-08-21 13:24:12 - Info bpbrm(pid=5484) child pid: 5148 2014-08-21 13:24:12 - Info bpdm(pid=5148) started 2014-08-21 13:24:13 - started process bpdm (5148) 2014-08-21 13:24:13 - begin reading 2014-08-21 13:24:13 - end reading; read time: 0:00:00 2014-08-21 13:24:13 - Info bpdm(pid=5484) completed reading backup image 2014-08-21 13:24:32 - Info bptm(pid=13696) media id IBM029 mounted on drive index 6, drivepath {3,0,8,0}, drivename IBM.ULT3580-TD5.Drive3, copy 2 2014-08-21 13:24:32 - Info bptm(pid=13696) INF - Waiting for positioning of media id IBM029 on server adm-master01 for writing. 2014-08-21 13:29:31 - Warning bptm(pid=13696) cannot locate on drive index 6, No more data is on the tape. 2014-08-21 13:56:09 - Error bptm(pid=13696) cannot position media id IBM029 for write 2014-08-21 13:56:09 - Info bptm(pid=13696) EXITING with status 86 <---------- 2014-08-21 13:56:09 - Error bpduplicate(pid=13072) host adm-master01 backupid esf-sql01.esf.se_1406080160 write failed, media position error (86). 2014-08-21 13:56:09 - Error bpduplicate(pid=13072) Duplicate of backupid esf-sql01.esf.se_1406080160 failed, media position error (86). 2014-08-21 13:56:09 - Info bptm(pid=10632) start 2014-08-21 13:56:09 - started process bptm (10632) 2014-08-21 13:56:09 - requesting resource adm-master01-hcart2-robot-tld-1 2014-08-21 13:56:10 - awaiting resource adm-master01-hcart2-robot-tld-1 - No drives are available 2014-08-21 13:56:39 - Info bptm(pid=10632) using 262144 data buffer size 2014-08-21 13:56:39 - Info bptm(pid=10632) using 64 data buffers 2014-08-21 13:56:39 - granted resource IBM008 2014-08-21 13:56:39 - granted resource IBM.ULT3580-TD5.Drive3 2014-08-21 13:56:39 - granted resource adm-master01-hcart2-robot-tld-1 2014-08-21 13:56:40 - Info bptm(pid=10632) start backup 2014-08-21 13:56:40 - Info bptm(pid=10632) backup child process is pid 4564.8232 2014-08-21 13:56:40 - Info bptm(pid=10632) Waiting for mount of media id IBM008 (copy 2) on server adm-master01. 2014-08-21 13:56:40 - started process bptm (10632) 2014-08-21 13:56:40 - mounting IBM008 2014-08-21 13:56:40 - Info bptm(pid=10632) INF - Waiting for mount of media id IBM008 on server adm-master01 for writing. 2014-08-21 13:56:40 - Info bptm(pid=4564) start 2014-08-21 13:56:40 - started process bptm (4564) 2014-08-21 13:56:43 - Info bpdm(pid=5484) using 64 data buffers 2014-08-21 13:56:43 - Info bpdm(pid=5484) spawning a child process 2014-08-21 13:56:43 - Info bpbrm(pid=5484) child pid: 6900 2014-08-21 13:56:43 - Info bpdm(pid=6900) started 2014-08-21 13:56:43 - started process bpdm (6900) 2014-08-21 13:56:44 - begin reading 2014-08-21 13:56:44 - end reading; read time: 0:00:00 2014-08-21 13:56:44 - Info bpdm(pid=5484) completed reading backup image 2014-08-21 13:57:04 - Info bptm(pid=10632) media id IBM008 mounted on drive index 6, drivepath {3,0,8,0}, drivename IBM.ULT3580-TD5.Drive3, copy 2 2014-08-21 13:57:04 - Info bptm(pid=10632) INF - Waiting for positioning of media id IBM008 on server adm-master01 for writing. 2014-08-21 14:02:52 - Warning bptm(pid=10632) cannot locate on drive index 6, No more data is on the tape. 2014-08-21 14:26:35 - Error bptm(pid=10632) cannot position media id IBM008 for write 2014-08-21 14:26:35 - Info bptm(pid=10632) EXITING with status 86 <---------- 2014-08-21 14:26:35 - Error bpduplicate(pid=13072) host adm-master01 backupid esf-sql01.esf.se_1406080242 write failed, media position error (86). 2014-08-21 14:26:35 - Error bpduplicate(pid=13072) Duplicate of backupid esf-sql01.esf.se_1406080242 failed, media position error (86). 2014-08-21 14:26:35 - Info bptm(pid=9116) start 2014-08-21 14:26:35 - started process bptm (9116) 2014-08-21 14:26:35 - requesting resource adm-master01-hcart2-robot-tld-1 2014-08-21 14:26:35 - awaiting resource adm-master01-hcart2-robot-tld-1 - No drives are available 2014-08-21 14:28:10 - awaiting resource adm-master01-hcart2-robot-tld-1 Reason: Drives are in use, Media Server: adm-master01, Robot Number: 0, Robot Type: TLD, Media ID: N/A, Drive Name: N/A, Volume Pool: ESF_for_ever, Storage Unit: adm-master01-hcart2-robot-tld-1, Drive Scan Host: N/A 2014-08-21 14:28:18 - awaiting resource adm-master01-hcart2-robot-tld-1 - No drives are available 2014-08-21 14:45:36 - Info bptm(pid=9116) using 262144 data buffer size 2014-08-21 14:45:36 - Info bptm(pid=9116) using 64 data buffers 2014-08-21 14:45:36 - Info bptm(pid=9116) start backup 2014-08-21 14:45:36 - Info bptm(pid=9116) backup child process is pid 13780.7844 2014-08-21 14:45:36 - Info bptm(pid=9116) Waiting for mount of media id IBM008 (copy 2) on server adm-master01. 2014-08-21 14:45:36 - started process bptm (9116) 2014-08-21 14:45:36 - mounting IBM008 2014-08-21 14:45:36 - Info bptm(pid=9116) INF - Waiting for mount of media id IBM008 on server adm-master01 for writing. 2014-08-21 14:45:36 - Info bptm(pid=13780) start 2014-08-21 14:45:36 - started process bptm (13780) 2014-08-21 14:45:36 - granted resource IBM008 2014-08-21 14:45:36 - granted resource IBM.ULT3580-TD5.Drive4 2014-08-21 14:45:36 - granted resource adm-master01-hcart2-robot-tld-1 2014-08-21 14:45:40 - Info bpdm(pid=5484) using 64 data buffers 2014-08-21 14:45:40 - Info bpdm(pid=5232) started 2014-08-21 14:45:40 - Info bpdm(pid=5484) spawning a child process 2014-08-21 14:45:40 - started process bpdm (5232) 2014-08-21 14:45:40 - Info bpbrm(pid=5484) child pid: 5232 2014-08-21 14:45:40 - begin reading 2014-08-21 14:45:41 - end reading; read time: 0:00:01 2014-08-21 14:45:41 - Info bpdm(pid=5484) completed reading backup image 2014-08-21 14:45:58 - Info bptm(pid=9116) media id IBM008 mounted on drive index 8, drivepath {3,0,9,0}, drivename IBM.ULT3580-TD5.Drive4, copy 2 2014-08-21 14:45:58 - Info bptm(pid=9116) INF - Waiting for positioning of media id IBM008 on server adm-master01 for writing. 2014-08-21 14:51:46 - Warning bptm(pid=9116) cannot locate on drive index 8, No more data is on the tape. 2014-08-21 15:15:29 - Error bptm(pid=9116) cannot position media id IBM008 for write 2014-08-21 15:15:29 - Info bptm(pid=9116) EXITING with status 86 <---------- 2014-08-21 15:15:29 - Error bpduplicate(pid=13072) host adm-master01 backupid esf-sql01.esf.se_1406080323 write failed, media position error (86). 2014-08-21 15:15:29 - Error bpduplicate(pid=13072) Duplicate of backupid esf-sql01.esf.se_1406080323 failed, media position error (86). 2014-08-21 15:15:29 - Info bptm(pid=13528) start 2014-08-21 15:15:29 - started process bptm (13528) 2014-08-21 15:15:29 - requesting resource adm-master01-hcart2-robot-tld-1 2014-08-21 15:15:29 - awaiting resource adm-master01-hcart2-robot-tld-1 - No drives are available 2014-08-21 15:28:06 - Info bptm(pid=13528) using 262144 data buffer size 2014-08-21 15:28:06 - Info bptm(pid=13528) using 64 data buffers 2014-08-21 15:28:06 - Info bptm(pid=13528) start backup 2014-08-21 15:28:06 - Info bptm(pid=13528) backup child process is pid 7468.9832 2014-08-21 15:28:06 - Info bptm(pid=13528) Waiting for mount of media id IBM008 (copy 2) on server adm-master01. 2014-08-21 15:28:06 - started process bptm (13528) 2014-08-21 15:28:06 - mounting IBM008 2014-08-21 15:28:06 - Info bptm(pid=13528) INF - Waiting for mount of media id IBM008 on server adm-master01 for writing. 2014-08-21 15:28:06 - Info bptm(pid=7468) start 2014-08-21 15:28:06 - started process bptm (7468) 2014-08-21 15:28:06 - granted resource IBM008 2014-08-21 15:28:06 - granted resource IBM.ULT3580-TD5.Drive5 2014-08-21 15:28:06 - granted resource adm-master01-hcart2-robot-tld-1 2014-08-21 15:28:10 - Info bpdm(pid=5484) using 64 data buffers 2014-08-21 15:28:10 - Info bpdm(pid=5484) spawning a child process 2014-08-21 15:28:10 - Info bpbrm(pid=5484) child pid: 6848 2014-08-21 15:28:10 - Info bpdm(pid=6848) started 2014-08-21 15:28:10 - started process bpdm (6848) 2014-08-21 15:28:10 - begin reading 2014-08-21 15:28:11 - end reading; read time: 0:00:01 2014-08-21 15:28:11 - Info bpdm(pid=5484) completed reading backup image 2014-08-21 15:28:30 - Info bptm(pid=13528) media id IBM008 mounted on drive index 7, drivepath {3,0,10,0}, drivename IBM.ULT3580-TD5.Drive5, copy 2 2014-08-21 15:28:30 - Info bptm(pid=13528) INF - Waiting for positioning of media id IBM008 on server adm-master01 for writing. 2014-08-21 15:34:18 - Warning bptm(pid=13528) cannot locate on drive index 7, No more data is on the tape. 2014-08-21 15:58:00 - Error bptm(pid=13528) cannot position media id IBM008 for write 2014-08-21 15:58:00 - Info bptm(pid=13528) EXITING with status 86 <---------- 2014-08-21 15:58:00 - Error bpduplicate(pid=13072) host adm-master01 backupid esf-sql01.esf.se_1406080406 write failed, media position error (86). 2014-08-21 15:58:00 - Error bpduplicate(pid=13072) Duplicate of backupid esf-sql01.esf.se_1406080406 failed, media position error (86). 2014-08-21 15:58:00 - Info bptm(pid=10424) start 2014-08-21 15:58:00 - started process bptm (10424) 2014-08-21 15:58:00 - requesting resource adm-master01-hcart2-robot-tld-1 2014-08-21 15:58:00 - awaiting resource adm-master01-hcart2-robot-tld-1 - No drives are available 2014-08-21 16:20:06 - Info bptm(pid=10424) using 262144 data buffer size 2014-08-21 16:20:06 - Info bptm(pid=10424) using 64 data buffers 2014-08-21 16:20:06 - Info bptm(pid=10424) start backup 2014-08-21 16:20:06 - Info bptm(pid=10424) backup child process is pid 12680.8964 2014-08-21 16:20:06 - Info bptm(pid=10424) Waiting for mount of media id XO0354 (copy 2) on server adm-master01. 2014-08-21 16:20:06 - started process bptm (10424) 2014-08-21 16:20:06 - mounting XO0354 2014-08-21 16:20:06 - Info bptm(pid=10424) INF - Waiting for mount of media id XO0354 on server adm-master01 for writing. 2014-08-21 16:20:06 - Info bptm(pid=12680) start 2014-08-21 16:20:06 - started process bptm (12680) 2014-08-21 16:20:06 - granted resource XO0354 2014-08-21 16:20:06 - granted resource IBM.ULT3580-TD5.Drive1 2014-08-21 16:20:06 - granted resource adm-master01-hcart2-robot-tld-1 2014-08-21 16:20:10 - Info bpdm(pid=5484) using 64 data buffers 2014-08-21 16:20:10 - Info bpdm(pid=5484) spawning a child process 2014-08-21 16:20:10 - Info bpbrm(pid=5484) child pid: 6856 2014-08-21 16:20:10 - Info bpdm(pid=6856) started 2014-08-21 16:20:10 - started process bpdm (6856) 2014-08-21 16:20:10 - begin reading 2014-08-21 16:20:10 - end reading; read time: 0:00:00 2014-08-21 16:20:11 - Info bpdm(pid=5484) completed reading backup image 2014-08-21 16:20:29 - Info bptm(pid=10424) media id XO0354 mounted on drive index 4, drivepath {3,0,6,0}, drivename IBM.ULT3580-TD5.Drive1, copy 2 2014-08-21 16:20:29 - Info bptm(pid=10424) INF - Waiting for positioning of media id XO0354 on server adm-master01 for writing. 2014-08-21 16:25:48 - Warning bptm(pid=10424) cannot locate on drive index 4, No more data is on the tape. 2014-08-21 16:53:28 - Error bptm(pid=10424) cannot position media id XO0354 for write 2014-08-21 16:53:28 - Error bpduplicate(pid=13072) host adm-master01 backupid esf-sql01.esf.se_1406080483 write failed, media position error (86). 2014-08-21 16:53:28 - Info bptm(pid=10424) EXITING with status 86 <---------- 2014-08-21 16:53:28 - Error bpduplicate(pid=13072) Duplicate of backupid esf-sql01.esf.se_1406080483 failed, media position error (86). 2014-08-21 16:53:28 - Info bptm(pid=7528) start 2014-08-21 16:53:28 - started process bptm (7528) 2014-08-21 16:53:28 - requesting resource adm-master01-hcart2-robot-tld-1 2014-08-21 16:53:28 - awaiting resource adm-master01-hcart2-robot-tld-1 - No drives are available 2014-08-21 16:54:15 - Info bptm(pid=7528) using 262144 data buffer size 2014-08-21 16:54:15 - Info bptm(pid=7528) using 64 data buffers 2014-08-21 16:54:15 - Info bptm(pid=7528) start backup 2014-08-21 16:54:15 - granted resource IBM029 2014-08-21 16:54:15 - granted resource IBM.ULT3580-TD5.Drive1 2014-08-21 16:54:15 - granted resource adm-master01-hcart2-robot-tld-1 2014-08-21 16:54:16 - Info bptm(pid=7528) backup child process is pid 10744.11356 2014-08-21 16:54:16 - Info bptm(pid=7528) Waiting for mount of media id IBM029 (copy 2) on server adm-master01. 2014-08-21 16:54:16 - started process bptm (7528) 2014-08-21 16:54:16 - mounting IBM029 2014-08-21 16:54:16 - Info bptm(pid=10744) start 2014-08-21 16:54:16 - Info bptm(pid=7528) INF - Waiting for mount of media id IBM029 on server adm-master01 for writing. 2014-08-21 16:54:16 - started process bptm (10744) 2014-08-21 16:54:19 - Info bpdm(pid=5484) using 64 data buffers 2014-08-21 16:54:19 - Info bpdm(pid=6392) started 2014-08-21 16:54:19 - Info bpdm(pid=5484) spawning a child process 2014-08-21 16:54:19 - started process bpdm (6392) 2014-08-21 16:54:19 - Info bpbrm(pid=5484) child pid: 6392 2014-08-21 16:54:20 - begin reading 2014-08-21 16:54:20 - end reading; read time: 0:00:00 2014-08-21 16:54:20 - Info bpdm(pid=5484) completed reading backup image 2014-08-21 16:54:39 - Info bptm(pid=7528) media id IBM029 mounted on drive index 4, drivepath {3,0,6,0}, drivename IBM.ULT3580-TD5.Drive1, copy 2 2014-08-21 16:54:39 - Info bptm(pid=7528) INF - Waiting for positioning of media id IBM029 on server adm-master01 for writing. 2014-08-21 16:59:37 - Warning bptm(pid=7528) cannot locate on drive index 4, No more data is on the tape. 2014-08-21 17:26:15 - Error bptm(pid=7528) cannot position media id IBM029 for write 2014-08-21 17:26:15 - Error bpduplicate(pid=13072) host adm-master01 backupid esf-sql01.esf.se_1406080560 write failed, media position error (86). 2014-08-21 17:26:15 - Info bptm(pid=7528) EXITING with status 86 <---------- 2014-08-21 17:26:15 - Error bpduplicate(pid=13072) Duplicate of backupid esf-sql01.esf.se_1406080560 failed, media position error (86). 2014-08-21 17:26:15 - Info bptm(pid=11868) start 2014-08-21 17:26:15 - started process bptm (11868) 2014-08-21 17:26:15 - requesting resource adm-master01-hcart2-robot-tld-1 2014-08-21 17:26:15 - awaiting resource adm-master01-hcart2-robot-tld-1 - No drives are available 2014-08-21 17:35:40 - Info bptm(pid=11868) using 262144 data buffer size 2014-08-21 17:35:40 - Info bptm(pid=11868) using 64 data buffers 2014-08-21 17:35:40 - granted resource XO0278 2014-08-21 17:35:40 - granted resource IBM.ULT3580-TD5.Drive2 2014-08-21 17:35:40 - granted resource adm-master01-hcart2-robot-tld-1 2014-08-21 17:35:41 - Info bptm(pid=11868) start backup 2014-08-21 17:35:41 - Info bptm(pid=11868) backup child process is pid 14188.6740 2014-08-21 17:35:41 - Info bptm(pid=11868) Waiting for mount of media id XO0278 (copy 2) on server adm-master01. 2014-08-21 17:35:41 - started process bptm (11868) 2014-08-21 17:35:41 - mounting XO0278 2014-08-21 17:35:41 - Info bptm(pid=11868) INF - Waiting for mount of media id XO0278 on server adm-master01 for writing. 2014-08-21 17:35:41 - Info bptm(pid=14188) start 2014-08-21 17:35:41 - started process bptm (14188) 2014-08-21 17:35:45 - Info bpdm(pid=5484) using 64 data buffers 2014-08-21 17:35:45 - Info bpdm(pid=7516) started 2014-08-21 17:35:45 - Info bpdm(pid=5484) spawning a child process 2014-08-21 17:35:45 - started process bpdm (7516) 2014-08-21 17:35:45 - Info bpbrm(pid=5484) child pid: 7516 2014-08-21 17:35:45 - begin reading 2014-08-21 17:35:45 - end reading; read time: 0:00:00 2014-08-21 17:35:45 - Info bpdm(pid=5484) completed reading backup image 2014-08-21 17:36:04 - Info bptm(pid=11868) media id XO0278 mounted on drive index 0, drivepath {3,0,7,0}, drivename IBM.ULT3580-TD5.Drive2, copy 2 2014-08-21 17:36:04 - Info bptm(pid=11868) INF - Waiting for positioning of media id XO0278 on server adm-master01 for writing. 2014-08-21 17:39:49 - Warning bptm(pid=11868) cannot locate on drive index 0, No more data is on the tape. 2014-08-21 17:57:12 - Error bptm(pid=11868) cannot position media id XO0278 for write 2014-08-21 17:57:12 - Error bpduplicate(pid=13072) host adm-master01 backupid esf-sql01.esf.se_1406080652 write failed, media position error (86). 2014-08-21 17:57:12 - Info bptm(pid=11868) EXITING with status 86 <---------- 2014-08-21 17:57:12 - Error bpduplicate(pid=13072) Duplicate of backupid esf-sql01.esf.se_1406080652 failed, media position error (86). 2014-08-21 17:57:12 - Info bptm(pid=11288) start 2014-08-21 17:57:12 - started process bptm (11288) 2014-08-21 17:57:12 - requesting resource adm-master01-hcart2-robot-tld-1 2014-08-21 17:57:12 - awaiting resource adm-master01-hcart2-robot-tld-1 - No drives are available 2014-08-21 17:58:17 - awaiting resource adm-master01-hcart2-robot-tld-1 Reason: Drives are in use, Media Server: adm-master01, Robot Number: 0, Robot Type: TLD, Media ID: N/A, Drive Name: N/A, Volume Pool: ESF_for_ever, Storage Unit: adm-master01-hcart2-robot-tld-1, Drive Scan Host: N/A 2014-08-21 17:58:22 - awaiting resource adm-master01-hcart2-robot-tld-1 - No drives are available 2014-08-21 18:02:18 - Info bptm(pid=11288) using 262144 data buffer size 2014-08-21 18:02:18 - Info bptm(pid=11288) using 64 data buffers 2014-08-21 18:02:18 - Info bptm(pid=11288) start backup 2014-08-21 18:02:18 - Info bptm(pid=11288) backup child process is pid 13384.12616 2014-08-21 18:02:18 - Info bptm(pid=13384) start 2014-08-21 18:02:18 - Info bptm(pid=11288) Waiting for mount of media id XO0278 (copy 2) on server adm-master01. 2014-08-21 18:02:18 - granted resource XO0278 2014-08-21 18:02:18 - granted resource IBM.ULT3580-TD5.Drive1 2014-08-21 18:02:18 - granted resource adm-master01-hcart2-robot-tld-1 2014-08-21 18:02:18 - started process bptm (11288) 2014-08-21 18:02:18 - mounting XO0278 2014-08-21 18:02:18 - Info bptm(pid=11288) INF - Waiting for mount of media id XO0278 on server adm-master01 for writing. 2014-08-21 18:02:22 - Info bpdm(pid=5484) using 64 data buffers 2014-08-21 18:02:22 - Info bpdm(pid=5484) spawning a child process 2014-08-21 18:02:22 - Info bpbrm(pid=5484) child pid: 5204 2014-08-21 18:02:22 - begin reading 2014-08-21 18:02:23 - end reading; read time: 0:00:01 2014-08-21 18:02:23 - Info bpdm(pid=5484) completed reading backup image 2014-08-21 18:02:42 - Info bptm(pid=11288) media id XO0278 mounted on drive index 4, drivepath {3,0,6,0}, drivename IBM.ULT3580-TD5.Drive1, copy 2 2014-08-21 18:02:42 - Info bptm(pid=11288) INF - Waiting for positioning of media id XO0278 on server adm-master01 for writing. 2014-08-21 18:06:27 - Warning bptm(pid=11288) cannot locate on drive index 4, No more data is on the tape.