From: Chris W. <chr...@cf...> - 2006-02-18 22:40:53
|
Good call Dan. I'd neglected to re-modify the mtx-changer script after upgrading. (In particular, my Exabyte 480 requires the tape to be placed "offline" before unloading it.) Thanks for the insight. -Chris -----Original Message----- From: Dan Langille [mailto:da...@la...] Sent: Saturday, February 18, 2006 3:35 PM To: Chris Wilson Cc: bac...@li... Subject: Re: [Bacula-users] Bacula fatal error On 18 Feb 2006 at 11:22, Chris Wilson wrote: > Hi, > > I received the following fatal error last night backing up my Bacula > catalog. What's really interesting is the "Bad autochanger" error -- notice > the slot number in the error (14) is different than the slot (24) specified > in the preceding "Issuing unload" command. > > Notice in the first case it's trying to unload slot 14 and gets an error. > The second case, it's trying to load slot 14 (which is where the next needed > volume - 000013 - resides). > > This discrepancy in the slot number during the tape unload has happened each > night for the last week (since I upgraded from 1.38.2 to 1.38.5). In all > other instances, it just resulted in an "Intervention needed..." message to > have me manually mount the correct tape. Since I upgraded, I have yet to > have my entire backup set (approx 7 machines) complete without getting some > type of "Intervention needed" message. > > The slot numbers aren't always off by 10; usually just by one. > > Looks like a bug to me... Thoughts? > > -Chris > > -----Original Message----- > From: bacula@linuxapp1 [mailto:bacula@linuxapp1] On Behalf Of Bacula > Sent: Friday, February 17, 2006 10:04 PM > To: chr...@cf... > Subject: Bacula: Backup Fatal Error of Backup_Bacula_Catalog Full > > 17-Feb 21:19 linuxapp1-dir: Start Backup JobId 459, > Job=Backup_Bacula_Catalog.2006-02-16_23.10.00 > 17-Feb 21:20 linuxapp1-sd: 3301 Issuing autochanger "loaded drive 0" > command. > 17-Feb 21:21 linuxapp1-sd: 3302 Autochanger "loaded drive 0", result is Slot > 24. > 17-Feb 21:21 linuxapp1-sd: 3307 Issuing autochanger "unload slot 24, drive > 0" command. > 17-Feb 21:22 linuxapp1-sd: 3995 Bad autochanger "unload slot 14, drive 0": > ERR=Child exited with code 1. > 17-Feb 21:22 linuxapp1-sd: Please mount Volume "000013" on Storage Device > "Drive-1" (/dev/nst0) for Job Backup_Bacula_Catalog.2006-02-16_23.10.00 > 17-Feb 22:03 linuxapp1-sd: 3301 Issuing autochanger "loaded drive 0" > command. > 17-Feb 22:03 linuxapp1-sd: 3302 Autochanger "loaded drive 0", result is Slot > 24. > 17-Feb 22:03 linuxapp1-sd: 3301 Issuing autochanger "loaded drive 0" > command. > 17-Feb 22:03 linuxapp1-sd: 3302 Autochanger "loaded drive 0", result is Slot > 24. > 17-Feb 22:03 linuxapp1-sd: 3301 Issuing autochanger "loaded drive 0" > command. > 17-Feb 22:03 linuxapp1-sd: 3302 Autochanger "loaded drive 0", result is Slot > 24. > 17-Feb 22:03 linuxapp1-sd: 3307 Issuing autochanger "unload slot 24, drive > 0" command. > 17-Feb 22:03 linuxapp1-sd: 3304 Issuing autochanger "load slot 14, drive 0" > command. > 17-Feb 22:04 linuxapp1-sd: Backup_Bacula_Catalog.2006-02-16_23.10.00 Fatal > error: 3992 Bad autochanger "load slot 14, drive 0": ERR=Child exited with > code 1. > 17-Feb 22:04 linuxapp1-fd: Backup_Bacula_Catalog.2006-02-16_23.10.00 Fatal > error: job.c:1602 Bad response to Append Data command. Wanted 3000 OK data > , got 3903 Error append data > > 17-Feb 22:04 linuxapp1-dir: Backup_Bacula_Catalog.2006-02-16_23.10.00 Error: > Bacula 1.38.5 (18Jan06): 17-Feb-2006 22:04:12 > JobId: 459 > Job: Backup_Bacula_Catalog.2006-02-16_23.10.00 > Backup Level: Full > Client: "linuxapp1-fd" i686-pc-linux-gnu,redhat, > FileSet: "Bacula Catalog" 2005-12-15 13:04:33 > Pool: "Full Backups" > Storage: "Exabyte-480" > Scheduled time: 16-Feb-2006 23:10:00 > Start time: 17-Feb-2006 21:18:17 > End time: 17-Feb-2006 22:04:12 > Priority: 11 > FD Files Written: 0 > SD Files Written: 0 > FD Bytes Written: 0 > SD Bytes Written: 0 > Rate: 0.0 KB/s > Software Compression: None > Volume name(s): > Volume Session Id: 15 > Volume Session Time: 1140043902 > Last Volume Bytes: 17,028,895,343 > Non-fatal FD errors: 0 > SD Errors: 0 > FD termination status: Error > SD termination status: Error > Termination: *** Backup Error *** Have you ensured that your change works properly with whatever script you are using to change tapes? This may be an autochanger script problem, not a Bacula issue. There is a section in the manual regarding testing your autochanger. I know because I've been testing two tape libraries this past week. -- Dan Langille : Software Developer looking for work my resume: http://www.freebsddiary.org/dan_langille.php |