Amanda-Users

SSH auth/EOF on read: planner failure?

2009-04-13 11:42:20
Subject: SSH auth/EOF on read: planner failure?
From: Sam Hooker <sth AT noiseplant DOT com>
To: amanda-users AT amanda DOT org
Date: Mon, 13 Apr 2009 11:36:47 -0400 (EDT)
-----BEGIN PGP SIGNED MESSAGE-----
Hash: SHA1


Hi folks,

(WARNING: long message, in an attempt to be complete. Sorry for the verbosity, 
if it turns out to be unnecessary.)

It's been a while since I've deployed AMANDA, and I need a little help with a 
personal backup rig, since thinking about this problem is distracting me from 
my _real_ work...

For those possessed of godlike depth-of-knowledge, here's the executive 
summary: SSH auth works, amcheck seems happy, amdump produces "planner: ERROR 
Request to zoe.x.noiseplant.com failed: EOF on read from zoe.x.noiseplant.com", 
planner plans nothing. What's going wrong?


Here are the details...

All hosts are running CentOS (RHEL) 5.3, authenticating with SSH; AMANDA 
2.5.0p4:

[root@inara ~]# rpm -qa | grep amanda
amanda-server-2.5.0p2-4
amanda-client-2.5.0p2-4
amanda-2.5.0p2-4

[root@zoe ~]# rpm -qa | grep amanda
amanda-2.5.0p2-4          # One of these is the i386 version...
amanda-2.5.0p2-4          # ...and one is the x86_64 version.
amanda-client-2.5.0p2-4   # I've confirmed this to be the x86_64 version.


"inara" (32-bit CentOS) is the AMANDA server, "zoe" (64-bit CentOS) is the only 
client so far, and the only disklist entry (for simplicity) is /etc:

[root@inara ~]# cat /etc/amanda/NOISEPLANT/disklist 
zoe.x.noiseplant.com /etc comp-user-tar

All the "SSHness" works fine, (i.e., amanda@inara can log as amanda@zoe), and 
the key is restricted thus:

[root@zoe ~]# cat ~amanda/.ssh/authorized_keys2 
no-port-forwarding,no-X11-forwarding,no-agent-forwarding,command="/usr/lib64/amanda/amandad
 -auth=ssh amdump",from="10.168.88.10" ssh-dss ... amanda@inara


.amandahosts files are configured per Red Hat's docs[1][2]:

[root@inara ~]# cat ~amanda/.amandahosts
localhost amanda
localhost.localdomain amanda
zoe.x.noiseplant.com root

[root@zoe ~]# cat ~amanda/.amandahosts
inara.x.noiseplant.com amanda


Each can resolve the other forwards and backwards, in DNS:

[root@inara ~]# dig +short zoe.x.noiseplant.com
10.168.77.3
[root@inara ~]# dig +short -x 10.168.77.3
zoe.x.noiseplant.com.

[root@zoe ~]# dig +short inara.x.noiseplant.com
10.168.88.10
[root@zoe ~]# dig +short -x 10.168.88.10
inara.x.noiseplant.com.


Services are enabled and xinetd has been reloaded:

[root@inara ~]# for s in amanda amandaidx amidxtape xinetd; do chkconfig --list 
$s; done
amanda          on
amandaidx       on
amidxtape       on
xinetd          0:off   1:off   2:off   3:on    4:on    5:on    6:off

[root@zoe ~]# for s in amanda xinetd; do chkconfig --list $s; done
amanda          on
xinetd          0:off   1:off   2:off   3:on    4:on    5:on    6:off


The profile name is "NOISEPLANT", and I'm using virtual tapes on inara's local 
disk. Here's the output of 'amcheck':

[root@inara ~]# su -c 'amcheck NOISEPLANT' amanda
Amanda Tape Server Host Check
- -----------------------------
Holding disk /dumps/amanda: 33501072 KB disk space available, using 33398672 KB
slot 5: read label `NOISEPLANT-5', date `20090413'
slot 6: read label `NOISEPLANT-6', date `X'

NOTE: skipping tape-writable test
Tape NOISEPLANT-6 label ok
NOTE: info dir /etc/amanda/NOISEPLANT/curinfo: does not exist
NOTE: it will be created on the next run.
NOTE: index dir /etc/amanda/NOISEPLANT/index: does not exist
NOTE: it will be created on the next run.
Server check took 0.179 seconds

Amanda Backup Client Hosts Check
- --------------------------------
Client check: 1 host checked in 1.918 seconds, 0 problems found

(brought to you by Amanda 2.5.0p2)


And here's what I get when running "su -c 'amdump NOISEPLANT' amanda":

[excerpt]
- ----- Forwarded Message -----
From: "Amanda user" <[email protected]>
To: root AT noiseplant DOT com
Sent: Monday, April 13, 2009 10:40:18 AM GMT -05:00 US/Canada Eastern
Subject: NOISEPLANT AMANDA MAIL REPORT FOR April 13, 2009

These dumps were to tape NOISEPLANT-5.
The next tape Amanda expects to use is: a new tape.
The next new tape already labelled is: NOISEPLANT-6.

FAILURE AND STRANGE DUMP SUMMARY:
  zoe.x.noiseplant.com  /etc  RESULTS MISSING
  planner: ERROR Request to zoe.x.noiseplant.com failed: EOF on read from 
zoe.x.noiseplant.com


STATISTICS:
                          Total       Full      Incr.
                        --------   --------   --------
Estimate Time (hrs:min)    0:00
[snip]

NOTES:
  planner: Adding new disk zoe.x.noiseplant.com:/etc.
  driver: WARNING: got empty schedule from planner
  taper: tape NOISEPLANT-5 kb 0 fm 0 [OK]


DUMP SUMMARY:
                                       DUMPER STATS               TAPER STATS 
HOSTNAME     DISK        L ORIG-KB  OUT-KB  COMP%  MMM:SS   KB/s MMM:SS   KB/s
- -------------------------- ------------------------------------- -------------
zoe.x.noisep /etc          MISSING -------------------------------------------
[end excerpt]


If I run 'planner' manually, here's what I see:

[root@inara ~]# su -c '/usr/lib/amanda/planner NOISEPLANT' amanda
planner: pid 14178 executable /usr/lib/amanda/planner version 2.5.0p2
planner: build: VERSION="Amanda-2.5.0p2"
[snip]
READING CONF FILES...
planner: time 0.007: startup took 0.007 secs

SENDING FLUSHES...
ENDFLUSH
ENDFLUSH

SETTING UP FOR ESTIMATES...
planner: time 0.008: setting up estimates for zoe.x.noiseplant.com:/etc
zoe.x.noiseplant.com:/etc overdue 14348 days for level 0
setup_estimate: zoe.x.noiseplant.com:/etc: command 0, options: none    
last_level -1 next_level0 -14348 level_days 0    getting estimates 0 (-2) -1 
(-2) -1 (-2)
planner: time 0.009: setting up estimates took 0.000 secs

GETTING ESTIMATES...
planner: time 1.273: getting estimates took 1.263 secs
FAILED QUEUE: empty
DONE QUEUE: empty

ANALYZING ESTIMATES...
INITIAL SCHEDULE (size 2064):

DELAYING DUMPS IF NEEDED, total_size 2064, tape length 102400000 mark 1000
  delay: Total size now 2064.

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

GENERATING SCHEDULE:
- --------
- --------


What newb mistake am I making? Is this a "32-bit vs. 64-bit" issue? Thanks in 
advance for any suggestions, and for letting me get this off my chest, so I can 
pay better attention to...well...my paying gig. ;-)


Cheers,

- -sth

[1] http://kbase.redhat.com/faq/docs/DOC-2524
[2] http://kbase.redhat.com/faq/docs/DOC-2457

sam hooker|sth AT noiseplant DOT com|http://www.noiseplant.com

        "The hurrier, the speed."
                        -Anon.
-----BEGIN PGP SIGNATURE-----
Version: GnuPG v1.4.8 (Darwin)
Comment: Use GnuPG with Firefox : http://getfiregpg.org (Version: 0.7.5)

iEYEARECAAYFAknjVX8ACgkQX8KByLv3aQ0VMgCghhuw39DvG+OnDlFuQMkeSrNX
kcsAmgKIeAmXSc1jz7a6kvhp0EC4Pk9e
=XfOt
-----END PGP SIGNATURE-----

<Prev in Thread] Current Thread [Next in Thread>
  • SSH auth/EOF on read: planner failure?, Sam Hooker <=