Amanda-Users

Re: Estimate timeout error

2004-12-02 16:37:50
Subject: Re: Estimate timeout error
From: Nick Danger <nick AT hackermonkey DOT com>
To: amanda-users AT amanda DOT org
Date: Thu, 02 Dec 2004 16:22:13 -0500
Matt Hyclak wrote:

The sendsize.DATETIME.debug log file on dominion should tell you how long
the estimates are taking. A simple calculation should tell you how big
etimeout should be.
(NUM_PARTITIONS * ETIMEOUT) = total time amanda waits for estimates.

Matt

Nope - still a problem. The error is still as below:

FAILURE AND STRANGE DUMP SUMMARY:

 dominion.h /var lev 0 FAILED [Estimate timeout from dominion.xxx]
 dominion.h /usr/local lev 0 FAILED [Estimate timeout from dominion.xxx]
 dominion.h /usr lev 0 FAILED [Estimate timeout from dominion.xxx]
 dominion.h /u00 lev 0 FAILED [Estimate timeout from dominion.xxx]
 dominion.h / lev 0 FAILED [Estimate timeout from dominion.xxx]




I have the timeout in amanda.conf set to an ungodly high number of

etimeout -12000         # total number of seconds for estimates.


The lines from the sendsize in /var/log are listed below. All the file systems are short, except for /u00 which lists Is the 77 in MINUES? Or seconds? Either way, 12000 in amanda.conf should be plenty, shouldnt it? I could be just doing my math wrong. Which is always a possiblity. There are no units listed other then in the config file, so Im guessing at some parts here.

Thanks all

-Nick

-------------------
sendsize: debug 1 pid 26242 ruid 33 euid 33: start at Thu Dec 2 11:25:07 2004
sendsize: version 2.4.4p1
sendsize[26244]: time 0.007: calculating for amname '/', dirname '/', spindle -1
sendsize[26244]: time 0.007: getting size via dump for / level 0
sendsize[26242]: time 0.008: waiting for any estimate child
sendsize[26244]: time 0.008: calculating for device '/dev/sda1' with 'ext3'
sendsize[26244]: time 0.008: running "/sbin/dump 0Ssf 1048576 - /dev/sda1"
sendsize[26244]: time 0.011: running /usr/lib/amanda/killpgrp
sendsize[26244]: time 0.071: DUMP: Excluding inode 8 (journal inode) from dump sendsize[26244]: time 0.072: DUMP: Excluding inode 7 (resize inode) from dump
sendsize[26244]: time 0.410: 308423680
sendsize[26244]: time 0.411: .....
sendsize[26244]: estimate time for / level 0: 0.402
sendsize[26244]: estimate size for / level 0: 301195 KB
sendsize[26244]: time 0.411: asking killpgrp to terminate
sendsize[26244]: time 1.415: getting size via dump for / level 1
sendsize[26244]: time 1.416: calculating for device '/dev/sda1' with 'ext3'
sendsize[26244]: time 1.416: running "/sbin/dump 1Ssf 1048576 - /dev/sda1"
sendsize[26244]: time 1.419: running /usr/lib/amanda/killpgrp
sendsize[26244]: time 1.449: DUMP: Excluding inode 8 (journal inode) from dump sendsize[26244]: time 1.451: DUMP: Excluding inode 7 (resize inode) from dump
sendsize[26244]: time 1.887: 1104896
sendsize[26244]: time 1.889: .....
sendsize[26244]: estimate time for / level 1: 0.472
sendsize[26244]: estimate size for / level 1: 1079 KB
sendsize[26244]: time 1.889: asking killpgrp to terminate
sendsize[26244]: time 2.895: done with amname '/', dirname '/', spindle -1
sendsize[26242]: time 2.895: child 26244 terminated normally
sendsize[26249]: time 2.896: calculating for amname '/u00', dirname '/u00', spindle -1
sendsize[26249]: time 2.896: getting size via dump for /u00 level 0
sendsize[26249]: time 2.897: calculating for device '/dev/sda9' with 'ext3'
sendsize[26249]: time 2.897: running "/sbin/dump 0Ssf 1048576 - /dev/sda9"
sendsize[26249]: time 2.900: running /usr/lib/amanda/killpgrp
sendsize[26242]: time 2.905: waiting for any estimate child
sendsize[26249]: time 2.942: DUMP: Excluding inode 8 (journal inode) from dump sendsize[26249]: time 2.943: DUMP: Excluding inode 7 (resize inode) from dump
sendsize[26249]: time 80.109: 147388416
sendsize[26249]: time 80.111: .....
sendsize[26249]: estimate time for /u00 level 0: 77.213
sendsize[26249]: estimate size for /u00 level 0: 143934 KB
sendsize[26249]: time 80.111: asking killpgrp to terminate
sendsize[26249]: time 81.112: getting size via dump for /u00 level 1
sendsize[26249]: time 81.113: calculating for device '/dev/sda9' with 'ext3'
sendsize[26249]: time 81.113: running "/sbin/dump 1Ssf 1048576 - /dev/sda9"
sendsize[26249]: time 81.116: running /usr/lib/amanda/killpgrp
sendsize[26249]: time 81.401: DUMP: Excluding inode 8 (journal inode) from dump sendsize[26249]: time 81.403: DUMP: Excluding inode 7 (resize inode) from dump
sendsize[26249]: time 159.069: 42408960
sendsize[26249]: time 159.070: .....
sendsize[26249]: estimate time for /u00 level 1: 77.957
sendsize[26249]: estimate size for /u00 level 1: 41415 KB
sendsize[26249]: time 159.071: asking killpgrp to terminate
sendsize[26249]: time 160.080: done with amname '/u00', dirname '/u00', spindle -1
sendsize[26242]: time 160.080: child 26249 terminated normally
sendsize[26484]: time 160.081: calculating for amname '/usr', dirname '/usr', spindle -1
sendsize[26484]: time 160.081: getting size via dump for /usr level 0
sendsize[26484]: time 160.082: calculating for device '/dev/sda2' with 'ext3'
sendsize[26484]: time 160.082: running "/sbin/dump 0Ssf 1048576 - /dev/sda2"
sendsize[26484]: time 160.085: running /usr/lib/amanda/killpgrp
sendsize[26242]: time 160.087: waiting for any estimate child
sendsize[26484]: time 160.124: DUMP: Excluding inode 8 (journal inode) from dump sendsize[26484]: time 160.126: DUMP: Excluding inode 7 (resize inode) from dump
sendsize[26484]: time 163.458: 902100992
sendsize[26484]: time 163.460: .....
sendsize[26484]: estimate time for /usr level 0: 3.377
sendsize[26484]: estimate size for /usr level 0: 880958 KB
sendsize[26484]: time 163.460: asking killpgrp to terminate
sendsize[26484]: time 164.461: getting size via dump for /usr level 1
sendsize[26484]: time 164.462: calculating for device '/dev/sda2' with 'ext3'
sendsize[26484]: time 164.462: running "/sbin/dump 1Ssf 1048576 - /dev/sda2"
sendsize[26484]: time 164.465: running /usr/lib/amanda/killpgrp
sendsize[26484]: time 164.503: DUMP: Excluding inode 8 (journal inode) from dump sendsize[26484]: time 164.504: DUMP: Excluding inode 7 (resize inode) from dump
sendsize[26484]: time 165.187: 80896
sendsize[26484]: time 165.189: .....
sendsize[26484]: estimate time for /usr level 1: 0.726
sendsize[26484]: estimate size for /usr level 1: 79 KB
sendsize[26484]: time 165.189: asking killpgrp to terminate
sendsize[26484]: time 166.191: done with amname '/usr', dirname '/usr', spindle -1
sendsize[26242]: time 166.192: child 26484 terminated normally
sendsize[26489]: time 166.192: calculating for amname '/usr/local', dirname '/usr/local', spindle -1
sendsize[26242]: time 166.192: waiting for any estimate child
sendsize[26489]: time 166.192: getting size via dump for /usr/local level 0
sendsize[26489]: time 166.193: calculating for device '/dev/sda5' with 'ext3'
sendsize[26489]: time 166.194: running "/sbin/dump 0Ssf 1048576 - /dev/sda5"
sendsize[26489]: time 166.196: running /usr/lib/amanda/killpgrp
sendsize[26489]: time 166.230: DUMP: Excluding inode 8 (journal inode) from dump sendsize[26489]: time 166.232: DUMP: Excluding inode 7 (resize inode) from dump
sendsize[26489]: time 167.312: 178176
sendsize[26489]: time 167.313: .....
sendsize[26489]: estimate time for /usr/local level 0: 1.119
sendsize[26489]: estimate size for /usr/local level 0: 174 KB
sendsize[26489]: time 167.313: asking killpgrp to terminate
sendsize[26489]: time 168.321: getting size via dump for /usr/local level 1
sendsize[26489]: time 168.323: calculating for device '/dev/sda5' with 'ext3'
sendsize[26489]: time 168.323: running "/sbin/dump 1Ssf 1048576 - /dev/sda5"
sendsize[26489]: time 168.326: running /usr/lib/amanda/killpgrp
sendsize[26489]: time 168.373: DUMP: Excluding inode 8 (journal inode) from dump sendsize[26489]: time 168.374: DUMP: Excluding inode 7 (resize inode) from dump
sendsize[26489]: time 168.691: 48128
sendsize[26489]: time 168.692: .....
sendsize[26489]: estimate time for /usr/local level 1: 0.369
sendsize[26489]: estimate size for /usr/local level 1: 47 KB
sendsize[26489]: time 168.692: asking killpgrp to terminate
sendsize[26489]: time 169.702: done with amname '/usr/local', dirname '/usr/local', spindle -1
sendsize[26242]: time 169.702: child 26489 terminated normally
sendsize[26242]: time 169.703: waiting for any estimate child
sendsize[26494]: time 169.703: calculating for amname '/var', dirname '/var', spindle -1
sendsize[26494]: time 169.703: getting size via dump for /var level 0
sendsize[26494]: time 169.704: calculating for device '/dev/sda6' with 'ext3'
sendsize[26494]: time 169.705: running "/sbin/dump 0Ssf 1048576 - /dev/sda6"
sendsize[26494]: time 169.707: running /usr/lib/amanda/killpgrp
sendsize[26494]: time 169.741: DUMP: Excluding inode 8 (journal inode) from dump sendsize[26494]: time 169.742: DUMP: Excluding inode 7 (resize inode) from dump
sendsize[26494]: time 170.063: 306378752
sendsize[26494]: time 170.081: .....
sendsize[26494]: estimate time for /var level 0: 0.376
sendsize[26494]: estimate size for /var level 0: 299198 KB
sendsize[26494]: time 170.081: asking killpgrp to terminate
sendsize[26494]: time 171.082: getting size via dump for /var level 1
sendsize[26494]: time 171.083: calculating for device '/dev/sda6' with 'ext3'
sendsize[26494]: time 171.083: running "/sbin/dump 1Ssf 1048576 - /dev/sda6"
sendsize[26494]: time 171.086: running /usr/lib/amanda/killpgrp
sendsize[26494]: time 171.116: DUMP: Excluding inode 8 (journal inode) from dump sendsize[26494]: time 171.118: DUMP: Excluding inode 7 (resize inode) from dump
sendsize[26494]: time 171.450: 2814976
sendsize[26494]: time 171.468: .....
sendsize[26494]: estimate time for /var level 1: 0.384
sendsize[26494]: estimate size for /var level 1: 2749 KB
sendsize[26494]: time 171.468: asking killpgrp to terminate
sendsize[26494]: time 172.472: done with amname '/var', dirname '/var', spindle -1
sendsize[26242]: time 172.473: child 26494 terminated normally
sendsize: time 172.473: pid 26242 finish time Thu Dec  2 11:27:59 2004




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