Re: [Bacula-users] Backup error

Ø From: Arunav Mandal [mailto:dibun AT hotmail DOT com]
Sent: Wednesday, January 26, 2011 9:32 AM
To: bacula-users AT lists.sourceforge DOT net
Subject: [Bacula-users] Backup error

Ø 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

Ø +---------+------------+-----------+---------+-------------------+----------+--------------+---------+------+-----------+-----------+---------------------+

Ø +---------+------------+-----------+---------+-------------------+----------+--------------+---------+------+-----------+-----------+---------------------+

Ø | 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.

I again have the same error on a different tape.

27-Jan 04:48 pentagram-new-sd JobId 24: Committing spooled data to Volume "A00006". Despooling 1,145,330,181,564 bytes ...

27-Jan 06:14 pentagram-new-sd JobId 24: Error: block.c:577 Write error at 70:54954 on device "LTO-5" (/etc/bacula/DEVICES/LTO5). ERR=Input/output error.

27-Jan 06:15 pentagram-new-sd JobId 24: Fatal error: Re-read of last block: block numbers differ by more than one.

Probable tape misconfiguration and data loss. Read block=4329909 Want block=4333160.

27-Jan 06:15 pentagram-new-sd JobId 24: Fatal error: spool.c:301 Fatal append error on device "LTO-5" (/etc/bacula/DEVICES/LTO5): ERR=

27-Jan 06:15 pentagram-new-sd JobId 24: Despooling elapsed time = 01:26:30, Transfer rate = 220.6 M Bytes/second

27-Jan 06:17 heptagram-new-dir JobId 24: Error: Bacula heptagram-new-dir 5.0.3 (04Aug10): 27-Jan-2011 06:17:36

Any idea what it can be? The tapes are brand new.

Arunav.

------------------------------------------------------------------------------
Special Offer-- Download ArcSight Logger for FREE (a $49 USD value)!
Finally, a world-class log management solution at an even better price-free!
Download using promo code Free_Logger_4_Dev2Dev. Offer expires 
February 28th, so secure your free ArcSight Logger TODAY! 
http://p.sf.net/sfu/arcsight-sfd2d

_______________________________________________
Bacula-users mailing list
Bacula-users AT lists.sourceforge DOT net
https://lists.sourceforge.net/lists/listinfo/bacula-users