Bacula-users

[Bacula-users] 2.4.0 wrong tape recycled

2008-06-11 05:38:37
Subject: [Bacula-users] 2.4.0 wrong tape recycled
From: Thomas <thomas AT ic3s DOT de>
To: bacula-users AT lists.sourceforge DOT net
Date: Wed, 11 Jun 2008 11:38:14 +0200
Hi List,

today i noticed that bacula 2.4.0 gets confused with two autochangers.

I have one Director and two Storage-Daemons on two hosts,
and each Storage-Daemon has a autochanger with two SDLT-Drives attached.

from the logfile:

2008-06-11 08:48:43backup-sd-bb JobId 44612: End of Volume "INC021" at 426:4371 
on device "JBBB-1" (/dev/nst0). Write of 64512 bytes got -1.
2008-06-11 08:48:47backup-sd-bb JobId 44612: Re-read of last block succeeded.
2008-06-11 08:48:47backup-sd-bb JobId 44612: End of medium on Volume "INC021" 
Bytes=395,479,010,304 Blocks=6,130,316 at 11-Jun-2008 08:48.
2008-06-11 08:48:47backup-sd-bb JobId 44612: 3307 Issuing autochanger "unload 
slot 15, drive 0" command.
2008-06-11 08:49:36backup-dir JobId 44612: There are no more Jobs associated 
with Volume "INC031". Marking it purged.
2008-06-11 08:49:36backup-dir JobId 44612: All records pruned from Volume 
"INC031"; marking it "Purged"
2008-06-11 08:49:36backup-dir JobId 44612: Recycled volume "INC031"
2008-06-11 08:49:36backup-sd-bb JobId 44612: 3301 Issuing autochanger "loaded? 
drive 0" command.
2008-06-11 08:49:36backup-sd-bb JobId 44612: 3302 Autochanger "loaded? drive 
0", result: nothing loaded.
2008-06-11 08:49:36backup-sd-bb JobId 44612: 3304 Issuing autochanger "load 
slot 16, drive 0" command.
2008-06-11 08:49:55backup-sd-bb JobId 44612: 3305 Autochanger "load slot 16, 
drive 0", status is OK.
2008-06-11 08:50:05backup-sd-bb JobId 44612: Recycled volume "INC022" on device 
"JBBB-1" (/dev/nst0), all previous data lost.
2008-06-11 08:50:05backup-sd-bb JobId 44612: New volume "INC022" mounted on 
device "JBBB-1" (/dev/nst0) at 11-Jun-2008 08:50.



Volume INC021 is in Jukebox JBBB.
JBBB is the configured Storage for this Job.

Volume INC031 is in the Jukebox JBGS in Slot 16
and it is the oldest available Volume for the Pool INC.
Bacula recycled the oldest Volume (INC031)
and then it loads Slot 16 from the Jukebox JBBB
and recycles also Volume INC022.


Volume INC022 was last written 9 days ago:

2008-06-02 00:36:16backup-sd-bb JobId 43915: End of Volume "INC022" at 398:4686 
on device "JBBB-2" (/dev/nst1). Write of 64512 bytes got -1.

but the Volume Retention is 21 days, so this should not happen.

=> Bacula has recycled the oldest Volume from the Pool,
but in the wrong Storage for the Job. After that it loads
the same Slot from the correct Storage and recycles this Volume
too, without taking care of the retention periods.


I'm running this setup since ~2 years with all released Bacula versions since 
1.38,
and i never see that before, so i think it is a bug.


Regards

Thomas

-- 
[:O]###[O:]

-------------------------------------------------------------------------
Check out the new SourceForge.net Marketplace.
It's the best place to buy or sell services for
just about anything Open Source.
http://sourceforge.net/services/buy/index.php
_______________________________________________
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>