I am running Bacula 5.0.3 with LTO-5 tape drive. I am backing up a Win 2008 server and from past 2 days the backup ended with error. The error is given below.
26-Jan 06:14 pentagram-new-sd JobId 18: Job write elapsed time = 03:48:12, Transfer rate = 89.06 M Bytes/second
26-Jan 06:11 virtual-fd JobId 18: VSS Writer (BackupComplete): "ASR Writer", State: 0x1 (VSS_WS_STABLE)
26-Jan 06:14 pentagram-new-sd JobId 18: Committing spooled data to Volume "A00004". Despooling 1,220,642,983,163 bytes ...
26-Jan 06:11 virtual-fd JobId 18: VSS Writer (BackupComplete): "System Writer", State: 0x1 (VSS_WS_STABLE)
26-Jan 06:11 virtual-fd JobId 18: VSS Writer (BackupComplete): "Shadow Copy Optimization Writer", State: 0x1 (VSS_WS_STABLE)
26-Jan 06:11 virtual-fd JobId 18: VSS Writer (BackupComplete): "WMI Writer", State: 0x1 (VSS_WS_STABLE)
26-Jan 06:11 virtual-fd JobId 18: VSS Writer (BackupComplete): "COM+ REGDB Writer", State: 0x1 (VSS_WS_STABLE)
26-Jan 06:11 virtual-fd JobId 18: VSS Writer (BackupComplete): "Registry Writer", State: 0x1 (VSS_WS_STABLE)
26-Jan 06:11 virtual-fd JobId 18: VSS Writer (BackupComplete): "BITS Writer", State: 0x1 (VSS_WS_STABLE)
26-Jan 09:14 pentagram-new-sd JobId 18: Error: block.c:577 Write error at 164:32010 on device "LTO-5" (/etc/bacula/DEVICES/LTO5). ERR=Input/output error.
26-Jan 09:16 pentagram-new-sd JobId 18: Fatal error: Re-read of last block: block numbers differ by more than one.
Probable tape misconfiguration and data loss. Read block=10011242 Want block=10014492.
26-Jan 09:16 pentagram-new-sd JobId 18: Fatal error: spool.c:301 Fatal append error on device "LTO-5" (/etc/bacula/DEVICES/LTO5): ERR=
26-Jan 09:16 pentagram-new-sd JobId 18: Despooling elapsed time = 03:01:26, Transfer rate = 112.1 M Bytes/second
26-Jan 09:18 heptagram-new-dir JobId 18: Error: Bacula heptagram-new-dir 5.0.3 (04Aug10): 26-Jan-2011 09:18:23
Build OS: x86_64-unknown-linux-gnu redhat
JobId: 18
Job: backup-virtual.2011-01-26_02.28.00_11
Backup Level: Full
Client: "virtual-fd" 5.0.3 (04Aug10) Linux,Cross-compile,Win64
FileSet: "win2k" 2011-01-22 00:12:17
Pool: "daily" (From Job resource)
Catalog: "bacula-catalog" (From Client resource)
Storage: "LTO-5" (From Job resource)
Scheduled time: 26-Jan-2011 02:28:00
Start time: 26-Jan-2011 02:28:03
End time: 26-Jan-2011 09:18:23
Elapsed time: 6 hours 50 mins 20 secs
Priority: 10
FD Files Written: 202,584
SD Files Written: 202,584
FD Bytes Written: 1,219,460,586,610 (1.219 TB)
SD Bytes Written: 1,219,505,454,401 (1.219 TB)
Rate: 49531.3 KB/s
Software Compression: None
VSS: yes
Encryption: no
Accurate: no
Volume name(s): A00004
Volume Session Id: 5
Volume Session Time: 1295990785
Last Volume Bytes: 646,231,541,760 (646.2 GB)
Non-fatal FD errors: 8902
SD Errors: 1
FD termination status: OK
SD termination status: Error
Termination: *** Backup Error ***
List media
+---------+------------+-----------+---------+-------------------+----------+--------------+---------+------+-----------+-----------+---------------------+
| MediaId | VolumeName | VolStatus | Enabled | VolBytes | VolFiles | VolRetention | Recycle | Slot | InChanger | MediaType | LastWritten |
+---------+------------+-----------+---------+-------------------+----------+--------------+---------+------+-----------+-----------+---------------------+
| 1 | A00001 | Full | 1 | 1,422,857,576,448 | 360 | 2,592,000 | 1 | 1 | 1 | LTO-5 | 2011-01-23 05:33:45 |
| 2 | A00002 | Full | 1 | 1,445,831,073,792 | 362 | 2,592,000 | 1 | 2 | 1 | LTO-5 | 2011-01-24 06:42:07 |
| 3 | A00003 | Full | 1 | 1,261,585,059,840 | 318 | 2,592,000 | 1 | 3 | 1 | LTO-5 | 2011-01-25 07:30:10 |
| 4 | A00004 | Full | 1 | 646,231,541,760 | 165 | 2,592,000 | 1 | 4 | 1 | LTO-5 | 2011-01-26 09:15:35 |
| 5 | A00005 | Purged | 1 | 101,799,936 | 1 | 2,592,000 | 1 | 5 | 1 | LTO-5 | 2011-01-25 22:33:44 |
| 6 | A00006 | Append | 1 | 64,512 | 0 | 2,592,000 | 1 | 6 | 1 | LTO-5 | 0000-00-00 00:00:00 |
Also tape A00004 is full at 646GB. Why is that?
Arunav.
