PDA

View Full Version : Adding new client to an existing solution - amchek ok, dump fails



khantastic
June 23rd, 2010, 07:44 AM
Hello

I've got an already up and running Amanda backup server. The server is running Amanda 2.6.1p1 and clients are running version 2.5-2p1. Dumptype is ssh. The backup is running every night and all is fine for all clients.

Now I wanted to add 1 more client to the system. I compiled from 2.5-2p1 sources with flags as shown further below. After install I added the client into the servers disklist. Amcheck reports everything as ok. From this I assume ssh keys are correct and communication is correctly configured.

However the amdumper doesn't backup the new client. The mail report says

FAILURE DUMP SUMMARY:
<pc.name> / lev 0 FAILED [too many dumper retry: "[couldn't open MESG or INDEX streams]"]

I have been googling and searching this forum but all I found was something with firewall settings. This is not the case for me, all PC's are connected to the same network. SELinux on the new client is disabled.

Any help is highly appreciated. If more logs or configuration is needed, please let me know.


Best Regards

SA

Client log:



amandad: debug 1 pid 20729 ruid 4350 euid 4350: start at Wed Jun 23 15:12:05 2010
Reading conf file "/etc/amanda/amanda-client.conf".
amandad: time 0.000: security_getdriver(name=ssh) returns 0x2b7b00bf8480
amandad: version 2.5.2p1
amandad: time 0.000: build: VERSION="Amanda-2.5.2p1"
amandad: time 0.000: BUILT_DATE="Wed Jun 23 14:35:23 UTC 2010"
amandad: time 0.000: BUILT_MACH="Linux <hostname> 2.6.18-128.4.1.el5 #1 SMP Thu Jul 23 19:59:19 EDT 2009 x86_64 x86_64 x86_64 GNU/Linux"
amandad: time 0.000: CC="gcc"
amandad: time 0.000: CONFIGURE_COMMAND="'./configure' '--prefix=/usr' '--bindir=/usr/sbin' '--mandir=/usr/share/man' '--libexecdir=/usr/lib/amanda' '--enable-shared' '--syscon
fdir=/etc' '--localstatedir=/var/lib' '--with-gnutar-listdir=/var/lib/amanda/gnutar-lists' '--with-user=backup' '--with-group=disk' '--with-amandahosts' '--with-debugging=/var/log/am
anda' '--with-dumperdir=/usr/lib/amanda/dumper.d' '--with-ssh-security' '--libdir=/lib64'"
amandad: time 0.000: paths: bindir="/usr/sbin" sbindir="/usr/sbin"
amandad: time 0.000: libexecdir="/usr/lib/amanda" mandir="/usr/share/man"
amandad: time 0.000: AMANDA_TMPDIR="/tmp/amanda"
amandad: time 0.000: AMANDA_DBGDIR="/var/log/amanda" CONFIG_DIR="/etc/amanda"
amandad: time 0.000: DEV_PREFIX="/dev/" RDEV_PREFIX="/dev/r"
amandad: time 0.000: DUMP="/sbin/dump" RESTORE="/sbin/restore" VDUMP=UNDEF
amandad: time 0.000: VRESTORE=UNDEF XFSDUMP=UNDEF XFSRESTORE=UNDEF VXDUMP=UNDEF
amandad: time 0.000: VXRESTORE=UNDEF SAMBA_CLIENT="/usr/bin/smbclient"
amandad: time 0.000: GNUTAR="/bin/gtar" COMPRESS_PATH="/bin/gzip"
amandad: time 0.000: UNCOMPRESS_PATH="/bin/gzip" LPRCMD="/usr/bin/lpr"
amandad: time 0.000: MAILER="/usr/bin/Mail"
amandad: time 0.000: listed_incr_dir="/var/lib/amanda/gnutar-lists"
amandad: time 0.000: defs: DEFAULT_SERVER="<hostname>"
amandad: time 0.000: DEFAULT_CONFIG="DailySet1"
amandad: time 0.000: DEFAULT_TAPE_SERVER="<hostname>" HAVE_MMAP
amandad: time 0.000: NEED_STRSTR HAVE_SYSVSHM LOCKING=POSIX_FCNTL SETPGRP_VOID
amandad: time 0.000: DEBUG_CODE AMANDA_DEBUG_DAYS=4 BSD_SECURITY RSH_SECURITY
amandad: time 0.000: USE_AMANDAHOSTS CLIENT_LOGIN="backup" FORCE_USERID HAVE_GZIP
amandad: time 0.000: COMPRESS_SUFFIX=".gz" COMPRESS_FAST_OPT="--fast"
amandad: time 0.000: COMPRESS_BEST_OPT="--best" UNCOMPRESS_OPT="-dc"
amandad: time 0.000: security_handleinit(handle=0x15b4a210, driver=0x2b7b00bf8480 (SSH))
amandad: time 0.000: security_streaminit(stream=0x15b4a320, driver=0x2b7b00bf8480 (SSH))
amandad: time 0.000: accept recv REQ pkt:
<<<<<
SERVICE sendbackup
OPTIONS features=ffffffff9ffeffffffff7f;hostname=<pc.dnsname>;config=<my_config>;
GNUTAR / 0 1970:1:1:0:0:0 OPTIONS |;auth=ssh;srvcomp-fast;index;exclude-list=/etc/amanda/excludelist;
>>>>>
amandad: time 0.000: creating new service: sendbackup
OPTIONS features=ffffffff9ffeffffffff7f;hostname=<pc.dnsname>;config=<my_config>;
GNUTAR / 0 1970:1:1:0:0:0 OPTIONS |;auth=ssh;srvcomp-fast;index;exclude-list=/etc/amanda/excludelist;

amandad: time 0.004: sending ACK pkt:
<<<<<
>>>>>
amandad: time 0.004: sending REP pkt:
<<<<<
>>>>>
amandad: time 0.042: received ACK pkt:
<<<<<
>>>>>
amandad: time 0.042: security_close(handle=0x15b4a210, driver=0x2b7b00bf8480 (SSH))
amandad: time 0.042: security_stream_close(0x15b4a320)
amandad: time 0.042: pid 20729 finish time Wed Jun 23 15:12:05 2010



Server log:


1277302395.176257: dumper: pid 13966 ruid 34 euid 34 version 2.6.1p1: start at Wed Jun 23 14:13:15 2010
1277302395.184864: dumper: pid 13966 ruid 34 euid 34 version 2.6.1p1: rename at Wed Jun 23 14:13:15 2010
1277302395.184943: dumper: getcmd: START 20100623141315
1277302395.664095: dumper: getcmd: PORT-DUMP 00-00001 50013 <pc.dnsname> ffffffff9ffeffffffff00 / NODEVICE 0 1970:1:1:0:0:0 GNUTAR /usr/lib/amanda/amandad backup /var/backups/.ssh/id_rsa ssh |;auth=ssh;srvcomp-fast;index;exclude-list=/etc/amanda/excludelist;
1277302395.664745: dumper: make_socket opening socket with family 2
1277302395.664761: dumper: connect_port: Try port 50000: available - Success
1277302395.664808: dumper: connected to 127.0.0.1.50013
1277302395.664816: dumper: our side is 0.0.0.0.50000
1277302395.664823: dumper: try_socksize: send buffer size is 65536
1277302395.664844: dumper: send request:
----
SERVICE sendbackup
OPTIONS features=ffffffff9ffeffffffff7f;hostname=<pc.dnsname>;config=<my_config>;
GNUTAR / 0 1970:1:1:0:0:0 OPTIONS |;auth=ssh;srvcomp-fast;index;exclude-list=/etc/amanda/excludelist;

----

1277302395.664853: dumper: security_getdriver(name=ssh) returns 0x6c6be0
1277302395.664863: dumper: security_handleinit(handle=0x8e57a20, driver=0x6c6be0 (SSH))
1277302395.665568: dumper: security_streaminit(stream=0x8e5e9f8, driver=0x6c6be0 (SSH))
1277302395.836840: dumper: got response:
----

----

1277302395.836880: dumper: security_close(handle=0x8e57a20, driver=0x6c6be0 (SSH))
1277302395.836891: dumper: security_stream_close(0x8e5e9f8)
1277302395.836952: dumper: putresult: 11 TRY-AGAIN
1277302410.859144: dumper: getcmd: PORT-DUMP 00-00002 50031 <pc.dnsname> ffffffff9ffeffffffff00 / NODEVICE 0 1970:1:1:0:0:0 GNUTAR /usr/lib/amanda/amandad backup /var/backups/.ssh/id_rsa ssh |;auth=ssh;srvcomp-fast;index;exclude-list=/etc/amanda/excludelist;
1277302410.859545: dumper: make_socket opening socket with family 2
1277302410.859564: dumper: connect_port: Try port 50000: available - Success
1277302410.859618: dumper: connected to 127.0.0.1.50031
1277302410.859630: dumper: our side is 0.0.0.0.50000
1277302410.859640: dumper: try_socksize: send buffer size is 65536
1277302410.859660: dumper: send request:
----
SERVICE sendbackup
OPTIONS features=ffffffff9ffeffffffff7f;hostname=<pc.dnsname>;config=<my_config>;
GNUTAR / 0 1970:1:1:0:0:0 OPTIONS |;auth=ssh;srvcomp-fast;index;exclude-list=/etc/amanda/excludelist;

----

1277302410.859670: dumper: security_getdriver(name=ssh) returns 0x6c6be0
1277302410.859682: dumper: security_handleinit(handle=0x8e57dc0, driver=0x6c6be0 (SSH))
1277302410.860242: dumper: security_streaminit(stream=0x8e5e9f8, driver=0x6c6be0 (SSH))
1277302411.036780: dumper: got response:
----

----

1277302411.036814: dumper: security_close(handle=0x8e57dc0, driver=0x6c6be0 (SSH))
1277302411.036824: dumper: security_stream_close(0x8e5e9f8)
1277302411.036874: dumper: putresult: 11 TRY-AGAIN
1277302411.038523: dumper: getcmd: QUIT ""
1277302411.038577: dumper: pid 13966 finish time Wed Jun 23 14:13:31 2010


Configure command with parameters:



./configure --prefix=/usr --bindir=/usr/sbin --mandir=/usr/share/man --libexecdir=/usr/lib/amanda --enable-shared --sysconfdir=/etc --localstatedir=/var/lib --with-gnutar-listdir=/var/lib/amanda/gnutar-lists --with-user=backup --with-group=disk --with-amandahosts --with-debugging=/var/log/amanda --with-dumperdir=/usr/lib/amanda/dumper.d --with-ssh-security --libdir=/lib64