Hello, On 4/10/2007 9:51 AM, Maria McKinley wrote: > Hello, > > I can't quite figure out what happened here. I have occasionally had the > problem that the bacula mounts a tape, and then can't seem to tell that > it is mounted.
Most of the time, this might be because of a timing problem - the autochanger is ready, mtx-changer thinks everything's ok, but the tape drive has not recognized the tape, so subsequent reads fail. Check your mtx-changer - it should use the wait_for_drive function, or at least use a long sleep time after loading a tape. > When this happens, usually it says it can't find any > media, and I eject the tape back into the autochanger by hand, and have > bacula re-mount and this solves the problem. This seems a bit different, > but can't tell really tell what happened or how to prevent it next time. > It seems like it got confused as to what volumes were in what slots. D1 > was in slot 5 and D3 in slot 6. Forgive me for not looking very closely at your job output - the volume names are too similar for me right now :-) Anyway, what does your catalog say is loaded? With 1.36 (and you should consider an upgrade!) there is, AFAIR, no out-of-the box query for the volumes inside the autochanger... if it is, try it. Did you manually change the changers contents and forgot the 'update slots' command? This is the only reason I encountered for a catalog not matching the actual slot inventory... Arno > Seems like I should erase these tapes, and re-run the backup? > > cheers, > maria > > -------- Original Message -------- > Subject: Bacula: Backup Fatal Error of billie-fd Full > Date: Sat, 07 Apr 2007 16:39:47 -0700 > From: (Bacula) [EMAIL PROTECTED] > To: [EMAIL PROTECTED] > > 07-Apr 01:05 billie-dir: Start Backup JobId 1226, > Job=NightlySave.2007-04-07_01.05.01 > 07-Apr 01:05 billie-dir: Max configured use duration exceeded. Marking > Volume "C0000004" as Used. > 07-Apr 01:05 billie-sd: 3301 Issuing autochanger "loaded drive 0" command. > 07-Apr 01:05 billie-sd: 3302 Autochanger "loaded drive 0", result is Slot 4. > 07-Apr 01:05 billie-sd: Wrote label to prelabeled Volume "G0000001" on > device "/dev/nst0" > 07-Apr 06:56 billie-sd: End of Volume "G0000001" at 99:14753 on device > /dev/nst0. Write of 64512 bytes got -1. > 07-Apr 06:57 billie-sd: Re-read of last block succeeded. > 07-Apr 06:57 billie-sd: End of medium on Volume "G0000001" > Bytes=99,945,403,940 Blocks=1,549,253 at 07-Apr-2007 06:57. > 07-Apr 07:00 billie-dir: Recycled volume "C0000001" > 07-Apr 07:00 billie-sd: Please mount Volume "C0000001" on Storage Device > "Exabyte" for Job NightlySave.2007-04-07_01.05.01 > 07-Apr 08:00 billie-sd: Please mount Volume "C0000001" on Storage Device > "Exabyte" for Job NightlySave.2007-04-07_01.05.01 > 07-Apr 09:35 billie-sd: NightlySave.2007-04-07_01.05.01 Warning: > Director wanted Volume "C0000001". > Current Volume "G0000001" not acceptable because: > 1998 Volume "G0000001" status is Full, but should be Append, Purged > or Recycle. > 07-Apr 09:35 billie-dir: Recycled volume "D0000001" > 07-Apr 09:35 billie-sd: 3301 Issuing autochanger "loaded drive 0" command. > 07-Apr 09:35 billie-sd: 3302 Autochanger "loaded drive 0", result is Slot 4. > 07-Apr 09:35 billie-sd: 3303 Issuing autochanger "unload slot 4, drive > 0" command. > 07-Apr 09:36 billie-sd: 3304 Issuing autochanger "load slot 6, drive 0" > command. > 07-Apr 09:37 billie-sd: 3305 Autochanger "load slot 6, drive 0", status > is OK. > 07-Apr 09:37 billie-dir: Recycled current volume "D0000003" > 07-Apr 09:37 billie-sd: Recycled volume "D0000003" on device > "/dev/nst0", all previous data lost. > 07-Apr 09:37 billie-sd: New volume "D0000003" mounted on device > /dev/nst0 at 07-Apr-2007 09:37. > 07-Apr 11:46 billie-fd: NightlySave.2007-04-07_01.05.01 Error: Read > error on file /home/mike/Documents/Rebecca Hendrickson > Archive/Applications/Metrowerks CodeWarrior 6.0/Metrowerks > CodeWarrior/MacOS > Support/Universal/Interfaces/PInterfaces/.AppleDouble/OpenTptAppleTalk.p. > ERR=Input/output error > 07-Apr 16:35 billie-sd: End of Volume "D0000003" at 96:8350 on device > /dev/nst0. Write of 64512 bytes got -1. > 07-Apr 16:35 billie-sd: Re-read of last block succeeded. > 07-Apr 16:35 billie-sd: End of medium on Volume "D0000003" > Bytes=96,532,524,613 Blocks=1,496,350 at 07-Apr-2007 16:35. > 07-Apr 16:38 billie-sd: 3301 Issuing autochanger "loaded drive 0" command. > 07-Apr 16:38 billie-sd: 3302 Autochanger "loaded drive 0", result is Slot 6. > 07-Apr 16:39 billie-sd: NightlySave.2007-04-07_01.05.01 Warning: > Director wanted Volume "D0000001". > Current Volume "D0000003" not acceptable because: > 1998 Volume "D0000003" status is Full, but should be Append, Purged > or Recycle. > 07-Apr 16:39 billie-sd: 3301 Issuing autochanger "loaded drive 0" command. > 07-Apr 16:39 billie-sd: 3302 Autochanger "loaded drive 0", result is Slot 6. > 07-Apr 16:39 billie-sd: NightlySave.2007-04-07_01.05.01 Warning: > Director wanted Volume "D0000001". > Current Volume "D0000003" not acceptable because: > 1998 Volume "D0000003" status is Full, but should be Append, Purged > or Recycle. > 07-Apr 16:39 billie-sd: 3301 Issuing autochanger "loaded drive 0" command. > 07-Apr 16:39 billie-sd: 3302 Autochanger "loaded drive 0", result is Slot 6. > 07-Apr 16:39 billie-sd: NightlySave.2007-04-07_01.05.01 Warning: > Director wanted Volume "D0000001". > Current Volume "D0000003" not acceptable because: > 1998 Volume "D0000003" status is Full, but should be Append, Purged > or Recycle. > 07-Apr 16:39 billie-sd: 3301 Issuing autochanger "loaded drive 0" command. > 07-Apr 16:39 billie-sd: 3302 Autochanger "loaded drive 0", result is Slot 6. > 07-Apr 16:39 billie-sd: NightlySave.2007-04-07_01.05.01 Warning: > Director wanted Volume "D0000001". > Current Volume "D0000003" not acceptable because: > 1998 Volume "D0000003" status is Full, but should be Append, Purged > or Recycle. > 07-Apr 16:39 billie-sd: 3301 Issuing autochanger "loaded drive 0" command. > 07-Apr 16:39 billie-sd: 3302 Autochanger "loaded drive 0", result is Slot 6. > 07-Apr 16:39 billie-sd: NightlySave.2007-04-07_01.05.01 Warning: > Director wanted Volume "D0000001". > Current Volume "D0000003" not acceptable because: > 1998 Volume "D0000003" status is Full, but should be Append, Purged > or Recycle. > 07-Apr 16:39 billie-sd: NightlySave.2007-04-07_01.05.01 Fatal error: Too > many errors trying to mount device /dev/nst0. > 07-Apr 16:39 billie-sd: NightlySave.2007-04-07_01.05.01 Fatal error: > Fatal device error: ERR=askdir.c:478 Cannot request another volume: no > volume name given. > > 07-Apr 16:39 billie-sd: NightlySave.2007-04-07_01.05.01 Fatal error: > askdir.c:219 NULL Volume name. This shouldn't happen!!! > 07-Apr 16:39 billie-fd: NightlySave.2007-04-07_01.05.01 Fatal error: > backup.c:477 Network send error 32768 to SD. ERR=Broken pipe > 07-Apr 16:39 billie-dir: NightlySave.2007-04-07_01.05.01 Error: Bacula > 1.36.3 (22Apr05): 07-Apr-2007 16:39:46 > JobId: 1226 > Job: NightlySave.2007-04-07_01.05.01 > Backup Level: Full > Client: billie-fd > FileSet: "Full Set" 2007-01-09 01:05:02 > Pool: "Monthly" > Storage: "Exabyte" > Start time: 07-Apr-2007 01:05:03 > End time: 07-Apr-2007 16:39:46 > FD Files Written: 783,225 > SD Files Written: 783,225 > FD Bytes Written: 196,133,205,671 > SD Bytes Written: 196,271,602,653 > Rate: 3497.2 KB/s > Software Compression: None > Volume name(s): G0000001|D0000003 > Volume Session Id: 31 > Volume Session Time: 1174640386 > Last Volume Bytes: 1 > Non-fatal FD errors: 1 > SD Errors: 0 > FD termination status: Error > SD termination status: Error > Termination: *** Backup Error *** > > > ------------------------------------------------------------------------- > Take Surveys. Earn Cash. Influence the Future of IT > Join SourceForge.net's Techsay panel and you'll get the chance to share your > opinions on IT & business topics through brief surveys-and earn cash > http://www.techsay.com/default.php?page=join.php&p=sourceforge&CID=DEVDEV > _______________________________________________ > Bacula-users mailing list > Bacula-users@lists.sourceforge.net > https://lists.sourceforge.net/lists/listinfo/bacula-users -- IT-Service Lehmann [EMAIL PROTECTED] Arno Lehmann http://www.its-lehmann.de ------------------------------------------------------------------------- Take Surveys. Earn Cash. Influence the Future of IT Join SourceForge.net's Techsay panel and you'll get the chance to share your opinions on IT & business topics through brief surveys-and earn cash http://www.techsay.com/default.php?page=join.php&p=sourceforge&CID=DEVDEV _______________________________________________ Bacula-users mailing list Bacula-users@lists.sourceforge.net https://lists.sourceforge.net/lists/listinfo/bacula-users
