I ran into an odd tape mount problem this morning. I'm using version
2.0.1 of bacula on RHEL-4 in a configuration that's been fairly stable
for months now. Here's how events seem to have unfolded:
- At 03:15, Bacula successfully unloaded drive 0 from a two-drive jukebox.
- At 03:16, Bacula successfully unloaded volume A00102L3 from drive 1
into slot 7 of the same jukebox.
- By 03:19, Bacula had successfully loaded this same volume from slot
7 into drive 0, which while not really necessary shouldn't hurt
anything.
- After successfully loading volume A00102L3 from slot 7 into drive 0,
Bacula repeatidly queried the jukebox to verify that the correct
tape is loaded. Each time, Bacula receives an indication that the
correct volume is loaded.
- After ten rapid-fire repetitions of this query, Bacula gives up, and
sends an "intervention required" email message asking that the tape
volume that is currently in drive 0 be mounted in drive 0.
- At 10:25 I had looked the situation over and used the bconsole
program to issue a simple "mount" command, hitting "Return" in
response to the "Enter autochanger drive[0]: " and "Enter
autochanger slot:" prompts.
- At this point, Bacula resumed operations, and the original stuck job
and all subsequent jobs ran without error.
I saw a similar pattern about a month ago, but don't know what
triggers this situation or how to go about getting a better handle on
what might be causing it. The job log is included below, in case
anyone might have an idea of what's going on here.
----
21-Feb 03:14 bubba-dir: Start Backup JobId 16238, Job=footon.2007-02-21_00.45.14
21-Feb 03:15 bubba-sd: 3307 Issuing autochanger "unload slot 37, drive 0"
command.
21-Feb 03:16 bubba-sd: 3307 Issuing autochanger "unload slot 7, drive 1"
command.
21-Feb 03:18 bubba-sd: 3304 Issuing autochanger "load slot 7, drive 0" command.
21-Feb 03:19 bubba-sd: 3305 Autochanger "load slot 7, drive 0", status is OK.
21-Feb 03:19 bubba-sd: 3301 Issuing autochanger "loaded? drive 0" command.
21-Feb 03:19 bubba-sd: 3302 Autochanger "loaded? drive 0", result is Slot 7.
21-Feb 03:19 bubba-sd: 3301 Issuing autochanger "loaded? drive 0" command.
21-Feb 03:19 bubba-sd: 3302 Autochanger "loaded? drive 0", result is Slot 7.
[ ... seven additional repetitions snipped ... ]
21-Feb 03:19 bubba-sd: 3301 Issuing autochanger "loaded? drive 0" command.
21-Feb 03:19 bubba-sd: 3302 Autochanger "loaded? drive 0", result is Slot 7.
21-Feb 03:19 bubba-sd: Please mount Volume "A00102L3" on Storage Device
"drive-0" (/dev/nst0) for Job footon.2007-02-21_00.45.14
21-Feb 04:24 bubba-sd: Please mount Volume "A00102L3" on Storage Device
"drive-0" (/dev/nst0) for Job footon.2007-02-21_00.45.14
21-Feb 06:24 bubba-sd: Please mount Volume "A00102L3" on Storage Device
"drive-0" (/dev/nst0) for Job footon.2007-02-21_00.45.14
21-Feb 10:24 bubba-sd: Please mount Volume "A00102L3" on Storage Device
"drive-0" (/dev/nst0) for Job footon.2007-02-21_00.45.14
21-Feb 10:25 bubba-sd: 3301 Issuing autochanger "loaded? drive 0" command.
21-Feb 10:25 bubba-sd: 3302 Autochanger "loaded? drive 0", result is Slot 7.
21-Feb 10:25 bubba-sd: Volume "A00102L3" previously written, moving to end of
data.
21-Feb 10:26 bubba-sd: Ready to append to end of Volume "A00102L3" at file=493.
21-Feb 10:26 bubba-sd: Spooling data ...
21-Feb 10:33 bubba-sd: Job write elapsed time = 00:06:48, Transfer rate = 3.766
M bytes/second
21-Feb 10:33 bubba-sd: Committing spooled data to Volume "A00102L3". Despooling
1,538,311,382 bytes ...
21-Feb 10:33 bubba-sd: Despooling elapsed time = 00:00:31, Transfer rate =
49.62 M bytes/second
21-Feb 10:33 bubba-sd: Sending spooled attrs to the Director. Despooling
195,580 bytes ...
-------------------------------------------------------------------------
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
