07-Apr 21:00 bl13-dir JobId 734: Start Backup JobId 734, Job=SccwHome.2014-04-07_21.00.00_44
07-Apr 21:01 bl13-dir JobId 734: Using Device "lto1" to write.
07-Apr 21:01 bl13-dir JobId 734: Sending Accurate information.
07-Apr 21:01 bl13-sd JobId 734: 3304 Issuing autochanger "load slot 4, drive 1" command.
07-Apr 21:02 bl13-sd JobId 734: 3305 Autochanger "load slot 4, drive 1", status is OK.
07-Apr 21:02 bl13-dir JobId 734: Max configured use duration=604,800 sec. exceeded. Marking Volume "000529L4" as Used.
07-Apr 21:02 bl13-dir JobId 734: There are no more Jobs associated with Volume "000506L4". Marking it purged.
07-Apr 21:02 bl13-dir JobId 734: All records pruned from Volume "000506L4"; marking it "Purged"
07-Apr 21:02 bl13-dir JobId 734: Recycled volume "000506L4"
07-Apr 21:02 bl13-sd JobId 734: Recycled volume "000529L4" on device "lto1" (/dev/nlto1), all previous data lost.
07-Apr 21:02 bl13-dir JobId 734: Max configured use duration=604,800 sec. exceeded. Marking Volume "000529L4" as Used.
07-Apr 21:02 bl13-sd JobId 734: Spooling data ...
07-Apr 21:04 bl13-sd JobId 734: User specified Job spool size reached: JobSpoolSize=10,000,031,919 MaxJobSpoolSize=10,000,000,000
07-Apr 21:04 bl13-sd JobId 734: Writing spooled data to Volume. Despooling 10,000,031,919 bytes ...
08-Apr 09:57 bl13-sd JobId 734: Despooling elapsed time = 00:02:03, Transfer rate = 81.30 M Bytes/second
08-Apr 09:57 bl13-sd JobId 734: Spooling data again ...
08-Apr 10:00 bl13-sd JobId 734: Committing spooled data to Volume "000506L4". Despooling 7,938,365,967 bytes ...
08-Apr 10:04 bl13-sd JobId 734: Despooling elapsed time = 00:01:13, Transfer rate = 108.7 M Bytes/second
08-Apr 10:04 bl13-sd JobId 734: Elapsed time=13:02:08, Transfer rate=382.0 K Bytes/second
08-Apr 10:04 bl13-sd JobId 734: Alert: TapeAlert: OK
08-Apr 10:04 bl13-sd JobId 734: Sending spooled attrs to the Director. Despooling 79,631 bytes ...
08-Apr 10:04 bl13-dir JobId 734: Bacula bl13-dir 5.2.13 (19Jan13):