Apologies for appending to my own post, but I found
another occurence of the same pattern, I didn't notice,
in another job of some months ago, again attached to
this message. The same volumes are involved, and these,
for what I can see from my logs, are the only occurences
of the pattern.

It looks like that a volume exceeding the "use duration"
once the job has choosed the backup volume, create this
problem.

May I guess the routine "find_next_volume_for_append()"
in the source next_vol.c of the director could have
a bug, at least in the version 5.2.13 (19Jan13) I'm using?

In all the other cases I've verified, almost one year
of correctly running jobs, the "use duration"
have not been checked just after the beginning of the
job, once the director has already decided the volume
to use, but at a different time.

I may be on the wrong track, but if I'm right bacula
may overwrite a non empty, not purged volume.

Something, I guess, all the bacula users would hate,
isn't?

G. Vitillaro.


I can't understand why the bacula director, 5.2.13 under a stable updated gentoo, recycled one volume "000506L4", the correct one in the slot 9 of my changer, but instead the storage daemon recycled the current volume mounted in drive1, from slot4, volume "000529L4" and without actually doing any pruning on the volume, pruning that was correctly performed for the "000506L4" volume.

Note that the volume "000506L4" exceeded "Max configure use duration" just before the records for volume "000506L4" had been pruned.

After this I've just a sequence, complete log attached to this message, of

Recycled volume "000506L4" Recycled volume "000529L4" on device "lto1" (/dev/nlto1), all previous data lost.

This configuration of bacula had been running for quite a while without a glitch, almost 10 months now and I had not any hardware error on my library at the time of this job, at least for what I can see.

I can't understand what is going on.

Any clue?

Regards, G. Vitillaro.


--
Giuseppe Vitillaro                  |  E-Mail : giuse...@vitillaro.org
CNR - ISTM                          |  06123 Perugia  Phone:+39.075.585-5518
-----------------------------------------------------------------------------
07-Apr 21:00 bl13-dir JobId 734: Start Backup JobId 734, 
Job=SccwHome.2014-04-07_21.00.00_44
07-Apr 21:01 bl13-dir JobId 734: Using Device "lto1" to write.
07-Apr 21:01 bl13-dir JobId 734: Sending Accurate information.
07-Apr 21:01 bl13-sd JobId 734: 3304 Issuing autochanger "load slot 4, drive 1" 
command.
07-Apr 21:02 bl13-sd JobId 734: 3305 Autochanger "load slot 4, drive 1", status 
is OK.
07-Apr 21:02 bl13-dir JobId 734: Max configured use duration=604,800 sec. 
exceeded. Marking Volume "000529L4" as Used.
07-Apr 21:02 bl13-dir JobId 734: There are no more Jobs associated with Volume 
"000506L4". Marking it purged.
07-Apr 21:02 bl13-dir JobId 734: All records pruned from Volume "000506L4"; 
marking it "Purged"
07-Apr 21:02 bl13-dir JobId 734: Recycled volume "000506L4"
07-Apr 21:02 bl13-sd JobId 734: Recycled volume "000529L4" on device "lto1" 
(/dev/nlto1), all previous data lost.
07-Apr 21:02 bl13-dir JobId 734: Max configured use duration=604,800 sec. 
exceeded. Marking Volume "000529L4" as Used.
07-Apr 21:02 bl13-sd JobId 734: Spooling data ...
07-Apr 21:04 bl13-sd JobId 734: User specified Job spool size reached: 
JobSpoolSize=10,000,031,919 MaxJobSpoolSize=10,000,000,000
07-Apr 21:04 bl13-sd JobId 734: Writing spooled data to Volume. Despooling 
10,000,031,919 bytes ...
08-Apr 09:57 bl13-sd JobId 734: Despooling elapsed time = 00:02:03, Transfer 
rate = 81.30 M Bytes/second
08-Apr 09:57 bl13-sd JobId 734: Spooling data again ...
08-Apr 10:00 bl13-sd JobId 734: Committing spooled data to Volume "000506L4". 
Despooling 7,938,365,967 bytes ...
08-Apr 10:04 bl13-sd JobId 734: Despooling elapsed time = 00:01:13, Transfer 
rate = 108.7 M Bytes/second
08-Apr 10:04 bl13-sd JobId 734: Elapsed time=13:02:08, Transfer rate=382.0 K 
Bytes/second
08-Apr 10:04 bl13-sd JobId 734: Alert: TapeAlert: OK
08-Apr 10:04 bl13-sd JobId 734: Sending spooled attrs to the Director. 
Despooling 79,631 bytes ...
08-Apr 10:04 bl13-dir JobId 734: Bacula bl13-dir 5.2.13 (19Jan13):
------------------------------------------------------------------------------
Comprehensive Server Monitoring with Site24x7.
Monitor 10 servers for $9/Month.
Get alerted through email, SMS, voice calls or mobile push notifications.
Take corrective actions from your mobile device.
http://p.sf.net/sfu/Zoho
_______________________________________________
Bacula-users mailing list
Bacula-users@lists.sourceforge.net
https://lists.sourceforge.net/lists/listinfo/bacula-users

Reply via email to