Amanda-Users

"Failed Queue"

2005-01-22 23:56:26
Subject: "Failed Queue"
From: Nick Danger <nick AT hackermonkey DOT com>
To: amanda users <amanda-users AT amanda DOT org>
Date: Sat, 22 Jan 2005 23:48:48 -0500
I have a SuSE 9.2 box with amanda installed and an Exabyte 17-D autoloader. I believe the drive/chg-zd-mtx are configure properly as I can lable the tapes, check the lables, and have done all the 'testing' steps at the top of chg-zd-mtx. The command output is below. The current disklist consists of only the server, and only the /etc directory (just for testing before I add others) There are no iptables running, and xinetd is started with the amanda processes not disabled.

The log is below, the error that confuses me is "Failed Queue". I get no failures on an amcheck. Where should I start to debug this?

Thanks,

-Nick


amanda@tesla:/etc/amanda/hackermonkey> cat disklist
tesla.hackermonkey.com          /etc            comp-root
amanda@tesla:/etc/amanda/hackermonkey> /usr/lib/amanda/chg-zd-mtx -info
2 7 1
amanda@tesla:/etc/amanda/hackermonkey> /usr/lib/amanda/chg-zd-mtx -slot current
2 /dev/nst0


------------------------------- /usr/lib/amanda/hackermonkey/amdump.1 file --------------------------

amdump: start at Sat Jan 22 23:05:51 EST 2005
amdump: datestamp 20050122
taper: pid 20481 executable taper version 2.4.4p3
taper: page size is 4096
taper: buffer size is 32768
taper: buffer[00] at 0x401fa000
taper: buffer[01] at 0x40202000
taper: buffer[02] at 0x4020a000
taper: buffer[03] at 0x40212000
taper: buffer[04] at 0x4021a000
taper: buffer[05] at 0x40222000
taper: buffer[06] at 0x4022a000
taper: buffer[07] at 0x40232000
taper: buffer[08] at 0x4023a000
taper: buffer[09] at 0x40242000
taper: buffer[10] at 0x4024a000
taper: buffer[11] at 0x40252000
taper: buffer[12] at 0x4025a000
taper: buffer[13] at 0x40262000
taper: buffer[14] at 0x4026a000
taper: buffer[15] at 0x40272000
taper: buffer[16] at 0x4027a000
taper: buffer[17] at 0x40282000
taper: buffer[18] at 0x4028a000
taper: buffer[19] at 0x40292000
taper: buffer structures at 0x4029a000 for 240 bytes
driver: pid 20480 executable /usr/lib/amanda/driver version 2.4.4p3
driver: tape size 56320000
driver: send-cmd time 0.005 to taper: START-TAPER 20050122
dumper: dgram_bind: socket bound to 0.0.0.0.674
dumper: pid 20483 executable dumper0 version 2.4.4p3, using port 674
driver: started dumper0 pid 20483
driver: started dumper1 pid 20484
planner: pid 20479 executable /usr/lib/amanda/planner version 2.4.4p3
planner: build: VERSION="Amanda-2.4.4p3"
planner:        BUILT_DATE="Mon Oct 4 21:44:17 UTC 2004"
planner: BUILT_MACH="Linux appolonius 2.6.8.1 #1 SMP Sat Oct 2 22:23:56 U
TC 2004 i686 athlon i386 GNU/Linux"
planner:        CC="gcc"
planner: CONFIGURE_COMMAND="'./configure' '--mandir=/usr/share/man' '--pr efix=/usr' '--infodir=/usr/share/info' '--sysconfdir=/etc' '--libdir=/usr/lib' ' --libexecdir=/usr/lib/amanda' '--localstatedir=/var/lib' '--with-index-server=lo calhost' '--with-gnutar-listdir=/var/lib/amanda/gnutar-lists' '--with-smbclient= /usr/bin/smbclient' '--with-amandahosts' '--with-user=amanda' '--with-group=disk ' '--with-gnutar=/bin/tar' '--disable-libtool' '--disable-shared' '--disable-sta
tic'"
planner: paths: bindir="/usr/bin" sbindir="/usr/sbin"
planner:        libexecdir="/usr/lib/amanda" mandir="/usr/share/man"
planner:        AMANDA_TMPDIR="/tmp/amanda" AMANDA_DBGDIR="/tmp/amanda"
planner:        CONFIG_DIR="/etc/amanda" DEV_PREFIX="/dev/"
planner:        RDEV_PREFIX="/dev/r" DUMP="/sbin/dump"
planner:        RESTORE="/sbin/restore" VDUMP=UNDEF VRESTORE=UNDEF
planner:        XFSDUMP=UNDEF XFSRESTORE=UNDEF VXDUMP=UNDEF VXRESTORE=UNDEF
planner:        SAMBA_CLIENT="/usr/bin/smbclient" GNUTAR="/bin/tar"
planner:        COMPRESS_PATH="/usr/bin/gzip"
planner:        UNCOMPRESS_PATH="/usr/bin/gzip" LPRCMD="/usr/bin/lpr"
planner:        MAILER="/usr/bin/Mail"
planner:        listed_incr_dir="/var/lib/amanda/gnutar-lists"
planner: defs:  DEFAULT_SERVER="localhost" DEFAULT_CONFIG="DailySet1"
planner:        DEFAULT_TAPE_SERVER="localhost"
planner:        DEFAULT_TAPE_DEVICE="/dev/null" HAVE_MMAP HAVE_SYSVSHM
planner:        LOCKING=POSIX_FCNTL SETPGRP_VOID DEBUG_CODE
planner:        AMANDA_DEBUG_DAYS=4 BSD_SECURITY USE_AMANDAHOSTS
planner:        CLIENT_LOGIN="amanda" FORCE_USERID HAVE_GZIP
planner:        COMPRESS_SUFFIX=".gz" COMPRESS_FAST_OPT="--fast"
planner:        COMPRESS_BEST_OPT="--best" UNCOMPRESS_OPT="-dc"
planner: time 0.015: dgram_bind: socket bound to 0.0.0.0.670
READING CONF FILES...
planner: time 0.016: startup took 0.016 secs

SETTING UP FOR ESTIMATES...
planner: time 0.016: setting up estimates for tesla.hackermonkey.com:/etc
tesla.hackermonkey.com:/etc overdue 12806 days for level 0
setup_estimate: tesla.hackermonkey.com:/etc: command 0, options:
   last_level -1 next_level0 -12806 level_days 0
   getting estimates 0 (0) -1 (-1) -1 (-1)
planner: time 0.017: setting up estimates took 0.000 secs

GETTING ESTIMATES...
changer: opening pipe to: /usr/lib/amanda/chg-zd-mtx -info
dumper: dgram_bind: socket bound to 0.0.0.0.675
dumper: pid 20484 executable dumper1 version 2.4.4p3, using port 675
changer: got exit: 0 str: 1 7 1
changer_query: changer return was 7 1
changer_query: searchable = 0
changer_find: looking for HKRMNKY01 changer is searchable = 0
changer: opening pipe to: /usr/lib/amanda/chg-zd-mtx -slot current
planner: time 1.091: got result for host tesla.hackermonkey.com disk /etc: 0 ->
-1K, -1 -> -1K, -1 -> -1K
planner: time 1.091: getting estimates took 1.074 secs
FAILED QUEUE:
 0: tesla.hackermonkey.com /etc
DONE QUEUE: empty

ANALYZING ESTIMATES...
planner: FAILED tesla.hackermonkey.com /etc 20050122 0 [disk /etc, all estimate
failed]
INITIAL SCHEDULE (size 80):

DELAYING DUMPS IF NEEDED, total_size 80, tape length 56320000 mark 8
 delay: Total size now 80.

PROMOTING DUMPS IF NEEDED, total_lev0 0, balanced_size 0...
planner: time 1.092: analysis took 0.000 secs

GENERATING SCHEDULE:
--------
ENDFLUSH
--------
driver: adding holding disk 0 dir /mnt/misc/amanda size 1048576
reserving 1048576 out of 1048576 for degraded-mode dumps
driver: flush size 0
driver: start time 1.091 inparallel 2 bandwidth 2600 diskspace 1048576 dir OBSOL
ETE datestamp 20050122 driver: drain-ends tapeq FIRST big-dumpers ttt
changer: got exit: 0 str: 1 /dev/nst0
taper: slot 1: date 20050122 label HKRMNKY01 (exact label match)
taper: read label `HKRMNKY01' date `20050122'
taper: wrote label `HKRMNKY01' date `20050122'
driver: result time 16.171 from taper: TAPER-OK
driver: state time 16.171 free kps: 2600 space: 1048576 taper: idle idle-dumpers
: 2 qlen tapeq: 0 runq: 0 roomq: 0 wakeup: 86400 driver-idle: not-idle
driver: interface-state time 16.171 if : free 800 if ETH0: free 800 if LOCAL: fr
ee 1000
driver: hdisk-state time 16.171 hdisk 0: free 1048576 dumpers 0
driver: QUITTING time 16.171 telling children to quit
driver: send-cmd time 16.171 to dumper0: QUIT
driver: send-cmd time 16.171 to dumper1: QUIT
driver: send-cmd time 16.171 to taper: QUIT
taper: DONE [idle wait: 0.033 secs]
taper: writing end marker. [HKRMNKY01 OK kb 0 fm 0]
driver: FINISHED time 23.329
amdump: end at Sat Jan 22 23:06:15 EST 2005




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