Amanda-Users

planner failes: all estimate failed

2004-09-01 09:07:20
Subject: planner failes: all estimate failed
From: Sylvia Gelman <sgelman AT rtr.tu-darmstadt DOT de>
To: amanda-users AT amanda DOT org
Date: Wed, 01 Sep 2004 14:59:35 +0200
Hi,

hope someone can help ...

amandasrv is a SPARC Sun Solaris 5.8, the other clients are different versions 
of Suse Linux.
amcheck says everything is ok, but I can´t backup some filesystems on the server. They are failing in the planner time.

the mail report:
FAILURE AND STRANGE DUMP SUMMARY:
  amandasrv       /export/opt lev 0 FAILED [disk /export/opt, all estimate 
failed]

on the server I want to backup all together 7 disks, two are ok and five have the above behavior.

log-file:
START planner date 20040831
INFO planner Adding new disk amandasrv:/.common.
INFO planner Adding new disk amandasrv:/.test.
START driver date 20040831
INFO planner Adding new disk amandasrv:/.sun.
INFO planner Adding new disk amandasrv:/.maus.
START taper datestamp 20040831 label bac-006 tape 0
*************************************************************************
WARNING planner disk amandasrv:/.doc, estimate of level 1 failed: -1.
FAIL planner amandasrv /export/opt 20040831 0 [disk /export/opt, all estimate 
failed]
*************************************************************************************
FAIL planner amandasrv /.maus 20040831 0 [disk /.maus, all estimate failed]
FAIL planner amandasrv /.sun 20040831 0 [disk /.sun, all estimate failed]
FAIL planner amandasrv /.test 20040831 0 [disk /.test, all estimate failed]
FAIL planner amandasrv /.common 20040831 0 [disk /.common, all estimate failed]
INFO planner Full dump of moon:/var promoted from 2 days ahead.
FINISH planner date 20040831

Here I´m wondering about the warning, because this filesystem at last is 
backing up ok.

amdump.1:
...
SETTING UP FOR ESTIMATES...
planner: time 0.105: setting up estimates for amandasrv:/.maus
amandasrv:/.maus overdue 12662 days for level 0
setup_estimate: amandasrv:/.maus: command 0, options:
    last_level -1 next_level0 -12662 level_days 0
    getting estimates 0 (0) -1 (-1) -1 (-1)
planner: time 0.136: setting up estimates for amandasrv:/export/opt
setup_estimate: amandasrv:/export/opt: command 0, options:
    last_level 0 next_level0 1 level_days 0
    getting estimates 0 (1252972) 1 (0) -1 (-1)
planner: time 0.170: setting up estimates for amandasrv:/
setup_estimate: amandasrv:/: command 0, options:
    last_level 1 next_level0 2 level_days 2
    getting estimates 0 (1221160) 1 (25940) 2 (0)
...
GETTING ESTIMATES...
planner: time 185.527: got result for host moon disk /var: 0 -> 147640K, 1 -> 21750K, 2 -> 19220K planner: time 18617.533: got result for host amandasrv disk /: 0 -> 1231630K, 1 -> 27970K, 2 -> 8870K planner: time 18617.534: got result for host amandasrv disk /export/opt: 0 -> -1K, 1 -> -1K, -1 -> -1K planner: time 18617.534: got result for host amandasrv disk /.maus: 0 -> -1K, -1 -> -1K, -1 -> -1K planner: time 18617.535: got result for host amandasrv disk /.sun: 0 -> -1K, -1 -> -1K, -1 -> -1K planner: time 18617.557: got result for host amandasrv disk /.doc: 0 -> 251362K, 1 -> -1K, -1 -> -1K
...
planner: time 18617.606: getting estimates took 18617.205 secs


It takes about 5 hours to get the estimates, is this normal?


Here are the debugfiles:
sendsize[26589]: time 1905.754: calculating for amname '/.test', dirname '/export/home/test', spindle 1
sendsize[26589]: time 1905.755: getting size via gnutar for /.test level 0
sendsize[25660]: time 1905.756: waiting for any estimate child: 1 running
sendsize[26589]: time 1906.022: spawning /usr/local/amanda/libexec/runtar in 
pipeline
sendsize[26589]: argument list: /opt/gnu/bin/tar --create --file /dev/null --directory /export/home/test --o ne-file-system --listed-incremental /usr/local/amanda/var/amanda/gnutar-lists/amandasrv_.test_0.new --sparse --ig
nore-failed-read --totals .
*************************************************************************
sendsize[26589]: time 3365.417: Total bytes written: -1830019072
sendsize[26589]: time 3365.426: .....
sendsize[26589]: estimate time for /.test level 0: 1459.404
sendsize[26589]: no size line match in /opt/gnu/bin/tar output for "/.test"
sendsize[26589]: .....
sendsize[26589]: estimate size for /.test level 0: -1 KB
*******************************************************************************
sendsize[26589]: time 3365.426: waiting for /opt/gnu/bin/tar "/.test" child
sendsize[26589]: time 3365.427: after /opt/gnu/bin/tar "/.test" wait
sendsize[26589]: time 3365.428: done with amname '/.test', dirname '/export/home/test', spindle 1
sendsize[25660]: time 3365.430: child 26589 terminated normally
sendsize[27363]: time 3365.431: calculating for amname '/.doc', dirname '/export/home/doc', spindle 1
sendsize[27363]: time 3365.432: getting size via gnutar for /.doc level 0
sendsize[25660]: time 3365.433: waiting for any estimate child: 1 running
sendsize[27363]: time 3365.674: spawning /usr/local/amanda/libexec/runtar in 
pipeline
sendsize[27363]: argument list: /opt/gnu/bin/tar --create --file /dev/null --directory /export/home/doc - -one-file-system --listed-incremental /usr/local/amanda/var/amanda/gnutar-lists/amandasrv_.doc_0.new --sparse
--ignore-failed-read --totals .
*******************************************************************
sendsize[27363]: time 5073.749: Total bytes written: 257394688
sendsize[27363]: time 5073.760: .....
sendsize[27363]: estimate time for /.doc level 0: 1708.086
sendsize[27363]: estimate size for /.doc level 0: 251362 KB
*********************************************************************
sendsize[27363]: time 5073.761: waiting for /opt/gnu/bin/tar "/.doc" child
sendsize[27363]: time 5073.761: after /opt/gnu/bin/tar "/.doc" wait
sendsize[27363]: time 5073.762: getting size via gnutar for /.doc level 1
sendsize[27363]: time 5074.303: spawning /usr/local/amanda/libexec/runtar in 
pipeline
sendsize[27363]: argument list: /opt/gnu/bin/tar --create --file /dev/null --directory /export/home/doc - -one-file-system --listed-incremental /usr/local/amanda/var/amanda/gnutar-lists/amandasrv_.doc_1.new --sparse
--ignore-failed-read --totals .
sendsize[27363]: time 5074.843: .....
sendsize[27363]: estimate time for /.doc level 1: 0.539
sendsize[27363]: no size line match in /opt/gnu/bin/tar output for "/.doc"
sendsize[27363]: .....
sendsize[27363]: estimate size for /.doc level 1: -1 KB
sendsize[27363]: time 5074.843: waiting for /opt/gnu/bin/tar "/.doc" child
sendsize[27363]: time 5074.843: after /opt/gnu/bin/tar "/.doc" wait
sendsize[27363]: time 5074.845: done with amname '/.doc', dirname '/export/home/doc', spindle 1
sendsize[25660]: time 5074.848: child 27363 terminated normally

I really don´t understand why .doc is going ok, and .test not. What means no size line match ...

Tell me if you need any more informations.

Thanks for help

Sylvia






<Prev in Thread] Current Thread [Next in Thread>