Bacula-users

Re: [Bacula-users] Backup error

2011-01-27 16:39:41
Subject: Re: [Bacula-users] Backup error
From: Arunav Mandal <dibun AT hotmail DOT com>
To: <drescherjm AT gmail DOT com>
Date: Thu, 27 Jan 2011 22:36:58 +0100

 
> Date: Thu, 27 Jan 2011 05:31:27 -0500
> Subject: Re: [Bacula-users] Backup error
> From: drescherjm AT gmail DOT com
> To: dibun AT hotmail DOT com
> CC: bacula-users AT lists.sourceforge DOT net
>
> 2011/1/27 Arunav Mandal <dibun AT hotmail DOT com>:
> >
> >
> >
> >
> >
> >
> > Ø  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
> >
> >
> >
> >
> >
> > Ø
> > +---------+------------+-----------+---------+-------------------+----------+--------------+---------+------+-----------+-----------+---------------------+
> >
> > Ø  | 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?
> >
>
> Tapes are marked Full at the point that a write failed. It is assumed
> at that point that the tape is full. Remember with a streaming tape
> drive that holds a variable amount of space due to compression and
> other factors its not easy to determine that the tape is full. In your
> case I would check your dmesg to look for any scsi or other errors
> that could be causing this..
>
> John
 
I purged and recycled the first tape which was successfull last week then again the same problem with the first tape. That means the media is fine. Now I don't know where to look for.
 
Any help is appreciated,
 
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
<Prev in Thread] Current Thread [Next in Thread>