* Paul Bijnens <[EMAIL PROTECTED]> [20080110 04:40]:
> On 2008-01-09 22:55, Jean-Francois Malouin wrote:
> >Hi,
> >
> >Amanda-2.5.2p1 on both the server (Debian/Etch) and client (irix-6.5.x).
> >
> >In a amreport this morning I got a DLE with:
> >
> >FAILURE AND STRANGE DUMP SUMMARY:
> > yorick /data/nih/nih1 lev 0 FAILED [missing size line from sendbackup]
> > yorick /data/nih/nih1 lev 0 FAILED [missing size line from sendbackup]
>
>
> The backup program (gnutar for this DLE) normally should have ended with
> a last line indicating the total size of the backup. However, Amanda did
> not find that line.
>
> But because that does not mean that you want be able to do at least
> something
> with the partial backup, Amanda did not discard the whole backup image.
> (Also because, when e.g. dumping to tape, Amanda will not rewind and
> overwrite
> an invalid backup image -- too difficult and maybe some intelligent human
> can still do "something" with the partial backup.)
>
> But Amanda still marks it "FAILED", and will try next time to make a decent
> backup.
indeed, amstatus shows that a full is being done.
> >
> >DUMP SUMMARY:
> > DUMPER STATS TAPER STATS
> >HOSTNAME DISK L ORIG-MB OUT-MB COMP% MMM:SS KB/s MMM:SS
> >KB/s
> >-------------------------
> >----------------------------------------------------
> >yorick /data/nih/nih1 0 N/A 84080 -- N/A N/A 22:33
> >63615.7
> >+PARTIAL
> >
> >Checking what 'adadmin info' tells me for it:
> >
> >amadmin left2 info yorick /data/nih/nih1
> >
> >Current info for yorick /data/nih/nih1:
> > Stats: dump rates (kps), Full: 21651.2, 23245.9, 22401.7
> > Incremental: 80.9, 97.4, 157.8
> > compressed size, Full: -100.0%,-100.0%,-100.0%
> > Incremental: -100.0%,-100.0%,-100.0%
> > Dumps: lev datestmp tape file origK compK secs
> > 0 20080102 av24-2_left2_U00041L3 34 973979040 973979040 44985
> > 1 20080107 av24-2_left2_U00040L3 6 97850 97850 1209
>
> Note the date of the level 0! That is not the date of this morning.
> The level 0 from this morning is not considered a valid level 0 by Amanda.
Ah! Good eye! I missed the date and also the fact that there was a
level 1 so indeed the last tried ('partial') full backup was not
considered valid.
> >
> >Seems good but trying to restore the image to disk with amfetchdump
> >fails with:
> >
> >amfetchdump -p left2 yorick /data/nih/nih1 20080108 | tar -xpGf -
>
> So you try to restore the one from this morning...
>
>
> Need to find out why it broke off.
> Look on the client in the "sendbackup.DATETIME.debug" file
Here they come, attached, for the initial run and the retry.
What is puzzling me is that the entire image must have first
been dumped on the holding disk on the server, then taped.
Is it possible that I have hit some timeout.
amanda.conf on the server has the following timeouts:
ctimeout 360
dtimeout 12960
etimeout 12960
Notice that the first sendbackup on the client failed after 37676s
while the retry did only after 5397s...
thanks for the time,
jf
>
>
> --
> Paul Bijnens, xplanation Technology Services Tel +32 16 397.511
> Technologielaan 21 bus 2, B-3001 Leuven, BELGIUM Fax +32 16 397.512
> http://www.xplanation.com/ email: [EMAIL PROTECTED]
> ***********************************************************************
> * I think I've got the hang of it now: exit, ^D, ^C, ^\, ^Z, ^Q, ^^, *
> * F6, quit, ZZ, :q, :q!, M-Z, ^X^C, logoff, logout, close, bye, /bye, *
> * stop, end, F3, ~., ^]c, +++ ATH, disconnect, halt, abort, hangup, *
> * PF4, F20, ^X^X, :D::D, KJOB, F14-f-e, F8-e, kill -1 $$, shutdown, *
> * init 0, kill -9 1, Alt-F4, Ctrl-Alt-Del, AltGr-NumLock, Stop-A, ... *
> * ... "Are you sure?" ... YES ... Phew ... I'm out *
> ***********************************************************************
--
<° ><
sendbackup: debug 1 pid 3694238 ruid 666 euid 666: start at Tue Jan 8 23:11:36
2008
sendbackup: version 2.5.2p1
Could not open conf file "/opt/amanda/av24-2/etc/amanda/amanda-client.conf": No
such file or directory
Reading conf file "/opt/amanda/av24-2/etc/amanda/left2/amanda-client.conf".
sendbackup: debug 1 pid 3694238 ruid 666 euid 666: rename at Tue Jan 8
23:11:36 2008
sendbackup req: <GNUTAR /data/nih/nih1 0 1970:1:1:0:0:0 OPTIONS
|;auth=bsdtcp;index;>
parsed request as: program `GNUTAR'
disk `/data/nih/nih1'
device `/data/nih/nih1'
level 0
since 1970:1:1:0:0:0
options `|;auth=bsdtcp;index;'
sendbackup: start: yorick:/data/nih/nih1 lev 0
sendbackup-gnutar: time 0.058: doing level 0 dump as listed-incremental to
'/opt/amanda-av24-2/var/amanda/left2/gnutar-lists/yorick_data_nih_nih1_0.new'
sendbackup-gnutar: time 223.333: doing level 0 dump from date: 1970-01-01
0:00:00 GMT
sendbackup: time 223.769: spawning /opt/amanda/av24-2/libexec/runtar in pipeline
sendbackup: time 223.770: argument list: runtar left2 gtar --create --file -
--directory /data/nih/nih1 --one-file-system --listed-incremental
/opt/amanda-av24-2/var/amanda/left2/gnutar-lists/yorick_data_nih_nih1_0.new
--sparsesendbackup: time 223.771: started index creator: "/usr/freeware/bin/tar
-tf - 2>/dev/null | sed -e 's/^\.//'"
--ignore-failed-read --totals .
sendbackup-gnutar: time 223.775: /opt/amanda/av24-2/libexec/runtar: pid 3698427
sendbackup: time 223.775: started backup
sendbackup: time 37676.088: index tee cannot write [Broken pipe]
sendbackup: time 37676.109: pid 3714006 finish time Wed Jan 9 09:39:32 2008
sendbackup: debug 1 pid 4180223 ruid 666 euid 666: start at Wed Jan 9 09:57:17
2008
sendbackup: version 2.5.2p1
Could not open conf file "/opt/amanda/av24-2/etc/amanda/amanda-client.conf": No
such file or directory
Reading conf file "/opt/amanda/av24-2/etc/amanda/left2/amanda-client.conf".
sendbackup: debug 1 pid 4180223 ruid 666 euid 666: rename at Wed Jan 9
09:57:17 2008
sendbackup req: <GNUTAR /data/nih/nih1 0 1970:1:1:0:0:0 OPTIONS
|;auth=bsdtcp;index;>
parsed request as: program `GNUTAR'
disk `/data/nih/nih1'
device `/data/nih/nih1'
level 0
since 1970:1:1:0:0:0
options `|;auth=bsdtcp;index;'
sendbackup: start: yorick:/data/nih/nih1 lev 0
sendbackup-gnutar: time 0.075: doing level 0 dump as listed-incremental to
'/opt/amanda-av24-2/var/amanda/left2/gnutar-lists/yorick_data_nih_nih1_0.new'
sendbackup-gnutar: time 86.151: doing level 0 dump from date: 1970-01-01
0:00:00 GMT
sendbackup: time 86.300: spawning /opt/amanda/av24-2/libexec/runtar in pipeline
sendbackup: time 86.301: argument list: runtar left2sendbackup: time 86.301:
started index creator: "/usr/freeware/bin/tar -tf - 2>/dev/null | sed -e
's/^\.//'"
gtar --create --file - --directory /data/nih/nih1 --one-file-system
--listed-incremental
/opt/amanda-av24-2/var/amanda/left2/gnutar-lists/yorick_data_nih_nih1_0.new
--sparse --ignore-failed-read --totals .
sendbackup-gnutar: time 86.305: /opt/amanda/av24-2/libexec/runtar: pid 4203711
sendbackup: time 86.306: started backup
sendbackup: time 5397.634: index tee cannot write [Broken pipe]
sendbackup: time 5397.641: pid 4198583 finish time Wed Jan 9 11:27:15 2008
