Jeremy,
Be careful with the 'JLM' abbreviation, or you'll get confused with Jean-Louis
Martineau. ;-)
The server logs you've provided say that the Amanda server is in communication
with the client, but that for some reason the client could not perform
estimates. There should be a logfile on the client that specifies what the
problem is. Can you check in /tmp/amanda?
If it's not there, you'll can look at the contents of the libamanda.so shared
library using the strings command. That file will name a directory called
AMANDA_TMPDIR; the client should create a subdirectory 'amanda' of that. That
is, if libamanda.so contains the string 'AMANDA_TMPDIR="/foo/bar"', then the
Amanda client will create debugging logs in /foo/bar/amanda.
Hope that helps.
Cheers,
--Ian
On Thursday 10 July 2008 14:18:56 Jeremy Mordkoff wrote:
> Thanks for the help. I had no idea that there were logs anywhere except
> /var/log/amanda. Did this change?
>
> Anyways, here is my amdump file...is 'missing estimates' the culprit?
>
> JLM
>
>
>
> amdump: start at Thu Jul 10 11:18:03 EDT 2008
> amdump: datestamp 20080710
> amdump: starttime 20080710111803
> planner: pid 21973 executable /usr/lib/amanda/planner version 2.5.1p3
> planner: build: VERSION="Amanda-2.5.1p3"
> planner: BUILT_DATE="Fri Aug 17 10:55:44 EDT 2007"
> planner: BUILT_MACH="Linux xenbuilder2.fedora.redhat.com
> 2.6.20-1.2962.fc6xen #1 SMP Tue Jun 19 19:10:51 EDT 2007 i686 i686 i386
> GNU/Linux"
> planner: CC="gcc" CONFIGURE_COMMAND="'./configure' 'linux' 'gnu'"
> planner: paths: bindir="/usr/bin" sbindir="/usr/sbin"
> planner: libexecdir="/usr/lib/amanda" mandir="/usr/share/man"
> planner: AMANDA_TMPDIR="/var/log/amanda"
> planner: AMANDA_DBGDIR="/var/log/amanda" CONFIG_DIR="/etc/amanda"
> planner: DEV_PREFIX="/dev/" RDEV_PREFIX="/dev/r"
> planner: DUMP="/sbin/dump" RESTORE="/sbin/restore" VDUMP=UNDEF
> planner: VRESTORE=UNDEF XFSDUMP=UNDEF XFSRESTORE=UNDEF
> VXDUMP=UNDEF
> planner: VXRESTORE=UNDEF SAMBA_CLIENT="/usr/bin/smbclient"
> planner: GNUTAR="/bin/tar" COMPRESS_PATH="/bin/gzip"
> planner: UNCOMPRESS_PATH="/bin/gzip" LPRCMD="/usr/bin/lpr"
> planner: MAILER="/usr/bin/Mail"
> planner: listed_incr_dir="/var/lib/amanda/gnutar-lists"
> planner: defs: DEFAULT_SERVER="amandahost" DEFAULT_CONFIG="DailySet1"
> planner: DEFAULT_TAPE_SERVER="amandahost" HAVE_MMAP HAVE_SYSVSHM
> planner: LOCKING=POSIX_FCNTL SETPGRP_VOID DEBUG_CODE
> planner: AMANDA_DEBUG_DAYS=4 BSD_SECURITY RSH_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"
> READING CONF FILES...
> planner: timestamp 20080710111803
> planner: time 0.006: startup took 0.006 secs
>
> SENDING FLUSHES...
> ENDFLUSH
>
> SETTING UP FOR ESTIMATES...
> planner: time 0.006: setting up estimates for cuttingroom:/dev/sda1
> cuttingroom:/dev/sda1 overdue 14071 days for level 0
> setup_estimate: cuttingroom:/dev/sda1: command 0, options: none
> last_level -1 next_level0 -14071 level_days 0 getting estimates 0
> (-2) -1 (-2) -1 (-2)
> planner: time 0.007: setting up estimates took 0.000 secs
>
> GETTING ESTIMATES...
> driver: pid 21974 executable /usr/lib/amanda/driver version 2.5.1p3
> driver: tape size 102400000
> driver: adding holding disk 0 dir /dumps/amanda size 9536304 chunksize
> 1048576
> reserving 9536304 out of 9536304 for degraded-mode dumps
> driver: send-cmd time 0.030 to taper: START-TAPER 20080710111803
> driver: started dumper0 pid 21976
> driver: send-cmd time 0.032 to dumper0: START 20080710111803
> driver: started dumper1 pid 21977
> driver: send-cmd time 0.033 to dumper1: START 20080710111803
> taper: pid 21975 executable taper version 2.5.1p3
> driver: started dumper2 pid 21978
> driver: send-cmd time 0.061 to dumper2: START 20080710111803
> driver: started dumper3 pid 21979
> driver: send-cmd time 0.072 to dumper3: START 20080710111803
> driver: start time 0.072 inparallel 4 bandwidth 51400 diskspace 9536304
> dir OBSOLETE datestamp 20080710111803 driver: drain-ends tapeq FIRST
> big-dumpers TTTT
> taper: page size = 4096
> taper: buffer size is 32768
> changer: opening pipe to: /usr/lib/amanda/chg-multi -info
> planner: time 0.122: got result for host cuttingroom disk /dev/sda1: 0
> -> -2K, -1 -> -2K, -1 -> -2K
> error result for host cuttingroom disk /dev/sda1: missing estimate
> planner: time 0.122: getting estimates took 0.115 secs
> FAILED QUEUE:
> 0: cuttingroom /dev/sda1
> DONE QUEUE: empty
>
> ANALYZING ESTIMATES...
> planner: FAILED cuttingroom /dev/sda1 20080710111803 0 [missing result
> for /dev/sda1 in cuttingroom response]
> INITIAL SCHEDULE (size 66):
>
> DELAYING DUMPS IF NEEDED, total_size 66, tape length 102400000 mark 1
> delay: Total size now 66.
>
> PROMOTING DUMPS IF NEEDED, total_lev0 0, balanced_size 0...
> planner: time 0.122: analysis took 0.000 secs
>
> GENERATING SCHEDULE:
> --------
> --------
> dumper: pid 21976 executable dumper0 version 2.5.1p3
> dumper: pid 21979 executable dumper3 version 2.5.1p3
> dumper: pid 21977 executable dumper1 version 2.5.1p3
> changer: opening pipe to: /usr/lib/amanda/chg-multi -slot current
> dumper: pid 21978 executable dumper2 version 2.5.1p3
> changer: opening pipe to: /usr/lib/amanda/chg-multi -slot next
> taper: slot: 70 wrote label `DailySet1-00070' date `20080710111803'
> driver: result time 7.680 from taper: TAPER-OK
> driver: state time 7.680 free kps: 51400 space: 9536304 taper: idle
> idle-dumpers: 4 qlen tapeq: 0 runq: 0 roomq: 0 wakeup: 0 driver-idle:
> not-idle
> driver: interface-state time 7.680 if default: free 50000 if local: free
> 1000 if le0: free 400
> driver: hdisk-state time 7.680 hdisk 0: free 9536304 dumpers 0
> driver: flush size 0
> driver: state time 7.680 free kps: 51400 space: 9536304 taper: idle
> idle-dumpers: 4 qlen tapeq: 0 runq: 0 roomq: 0 wakeup: 0 driver-idle:
> no-dumpers
> driver: interface-state time 7.680 if default: free 50000 if local: free
> 1000 if le0: free 400
> driver: hdisk-state time 7.680 hdisk 0: free 9536304 dumpers 0
> driver: QUITTING time 7.680 telling children to quit
> driver: send-cmd time 7.680 to dumper0: QUIT
> driver: send-cmd time 7.680 to dumper1: QUIT
> driver: send-cmd time 7.680 to dumper2: QUIT
> driver: send-cmd time 7.680 to dumper3: QUIT
> driver: send-cmd time 7.680 to taper: QUIT
> taper: DONE [idle wait: 0.000 secs]
> taper: writing end marker. [DailySet1-00070 OK kb 0 fm 0]
> driver: FINISHED time 8.681
> amdump: end at Thu Jul 10 11:18:12 EDT 2008
> Scanning /dumps/amanda...
> 0
> 0
> 0
> 0
> 0
> 0
> 0
> 0
> 0
> 0
> 0
> 0
> 0
> 0
> 0
> 0
> 0
> 0
> 0
> 0
> 0
> 0
> 0
> 0
> 0
> 0
>
>
>
> -----Original Message-----
> From: Ian Turner [mailto:ian AT zmanda DOT com]
> Sent: Thursday, July 10, 2008 2:13 PM
> To: Jeremy Mordkoff
> Cc: amanda-users AT amanda DOT org
> Subject: Re: debian client
>
> Do I understand that there is nothing in /var/log/amanda/client on
> cuttingroom? What is the contents of /etc/amanda/<config>/amdump.1 on
> the
> server?
>
> On Thursday 10 July 2008 13:40:34 Jeremy Mordkoff wrote:
> > Amdump returns almost instantly
> >
> > The report email starts with
> >
> > These dumps were to tape DailySet1-00070.
> > The next tape Amanda expects to use is: DailySet1-00001.
> > The next new tape already labelled is: DailySet1-00017.
> >
> > FAILURE AND STRANGE DUMP SUMMARY:
> > cuttingroom /dev/sda1 lev 0 FAILED [missing result for /dev/sda1
>
> in
>
> > cuttingroom response]
> >
> >
> > as Amanda on the client---
> >
> > $
> > $ whoami
> > amanda
> > $ df
> > Filesystem 1K-blocks Used Available Use% Mounted on
> > /dev/sda1 236318584 3312404 221096396 2% /
> > varrun 1024048 116 1023932 1% /var/run
> > varlock 1024048 0 1024048 0% /var/lock
> > udev 1024048 44 1024004 1% /dev
> > devshm 1024048 0 1024048 0% /dev/shm
> > lrm 1024048 38684 985364 4%
> > /lib/modules/2.6.24-19-generic/volatile
> >
> >
> >
> >
> >
> >
> > -----Original Message-----
> > From: Ian Turner [mailto:ian AT zmanda DOT com]
> > Sent: Thursday, July 10, 2008 11:06 AM
> > To: Jeremy Mordkoff
> > Cc: amanda-users AT amanda DOT org
> > Subject: Re: debian client
> >
> > Jeremy,
> >
> > What do you mean when you say that "amdump always fails". Do you get
>
> an
>
> > error
> > message?
> >
> > --Ian
> >
> > On Thursday 10 July 2008 09:28:39 Jeremy Mordkoff wrote:
> > > Hi --
> > >
> > > I have a working setup running on fedora core 7/8/9. On my server, I
> >
> > am
> >
> > > running
> > > amanda-2.5.1p3-3.fc7
> > >
> > > amanda-client-2.5.1p3-3.fc7
> > >
> > > amanda-server-2.5.1p3-3.fc7
> > >
> > > Someone built a debian server and I am trying to add it to my
>
> backups.
>
> > > amcheck is happy, but amdump always fails. It is running
> > >
> > >
> > >
> > > $ dpkg -l | grep amanda
> > >
> > > ii amanda-client 1:2.5.2p1-1
> > > Advanced Maryland Automatic Network Disk Arc
> > >
> > > ii amanda-common 1:2.5.2p1-1
> > > Advanced Maryland Automatic Network Disk Arc
> > >
> > >
> > >
> > > an amandad log file is created, but nothing under
> >
> > /var/log/amanda/client
> >
> > > here is the /var/log/amanda/amandad log file
> > >
> > > amandad: debug 1 pid 10077 ruid 34 euid 34: start at Wed Jul 9
> >
> > 10:04:22
> >
> > > 2008
> > > Reading conf file "/etc/amanda/amanda-client.conf".
> > > amandad: time 0.000: security_getdriver(name=bsd) returns 0xb7eab2e0
> > > amandad: version 2.5.2p1
> > > amandad: time 0.000: build: VERSION="Amanda-2.5.2p1"
> > > amandad: time 0.000: BUILT_DATE="Fri Nov 9 01:06:28 GMT 2007"
> > > amandad: time 0.000: BUILT_MACH="Linux palmer 2.6.15.7 #1 SMP Thu
>
> Sep
>
> > 7
> >
> > > 19:42:20 UTC 2006 i686 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' '--sysconfdir=/etc'
> > > '--localstatedir=/var/lib'
> > > '--with-gnutar-listdir=/var/lib/amanda/gnutar-lists'
> > > '--with-index-server=localhost' '--with-user=backup'
> > > '--with-group=backup' '--with-bsd-security' '--with-amandahosts'
> > > '--with-smbclient=/usr/bin/smbclient'
> >
> > '--with-debugging=/var/log/amanda'
> >
> > > '--with-dumperdir=/usr/lib/amanda/dumper.d'
> > > '--with-tcpportrange=50000,50100' '--with-udpportrange=840,860'
> > > '--with-maxtapeblocksize=256' '--with-ssh-security'"
> > > 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/"
> > > DUMP="/sbin/dump"
> > > amandad: time 0.000: RESTORE="/sbin/restore" VDUMP=UNDEF
> >
> > VRESTORE=UNDEF
> >
> > > amandad: time 0.000: XFSDUMP="/sbin/xfsdump"
> > > XFSRESTORE="/sbin/xfsrestore"
> > > amandad: time 0.000: VXDUMP=UNDEF VXRESTORE=UNDEF
> > > amandad: time 0.000: SAMBA_CLIENT="/usr/bin/smbclient"
> >
> > GNUTAR="/bin/tar"
> >
> > > amandad: time 0.000: COMPRESS_PATH="/bin/gzip"
> > > UNCOMPRESS_PATH="/bin/gzip"
> > > amandad: time 0.000: LPRCMD="/usr/bin/lpr" MAILER="/usr/bin/mail"
> > > amandad: time 0.000: listed_incr_dir="/var/lib/amanda/gnutar-lists"
> > > amandad: time 0.000: defs: DEFAULT_SERVER="localhost"
> > > DEFAULT_CONFIG="DailySet1"
> > > amandad: time 0.000: DEFAULT_TAPE_SERVER="localhost" HAVE_MMAP
> > > NEED_STRSTR
> > > amandad: time 0.000: HAVE_SYSVSHM LOCKING=POSIX_FCNTL SETPGRP_VOID
> > > DEBUG_CODE
> > > amandad: time 0.000: AMANDA_DEBUG_DAYS=4 BSD_SECURITY RSH_SECURITY
> > > USE_AMANDAHOSTS
> > > amandad: time 0.000: 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: dgram_recv(dgram=0xb7ead284, timeout=0,
> > > fromaddr=0xb7ebd270)
> > > amandad: time 0.000: (sockaddr_in *)0xb7ebd270 = { 2, 897,
>
> 172.16.2.71
>
> > }
> >
> > > amandad: time 0.000: security_handleinit(handle=0x80529e8,
> > > driver=0xb7eab2e0 (BSD))
> > > amandad: time 0.001: accept recv REQ pkt:
> > > <<<<<
> > > SERVICE noop
> > > OPTIONS features=fffffeff9ffeffffff7f;
> > >
> > > amandad: time 0.001: creating new service: noop
> > > OPTIONS features=fffffeff9ffeffffff7f;
> > >
> > > amandad: time 0.002: sending ACK pkt:
> > > <<<<<
> > >
> > > amandad: time 0.002: dgram_send_addr(addr=0x8052a08,
>
> dgram=0xb7ead284)
>
> > > amandad: time 0.002: (sockaddr_in *)0x8052a08 = { 2, 897,
>
> 172.16.2.71
>
> > }
> >
> > > amandad: time 0.002: dgram_send_addr: 0xb7ead284->socket = 0
> > > amandad: time 0.003: sending REP pkt:
> > > <<<<<
> > > OPTIONS features=ffffffff9ffeffffffff00;
> > >
> > > amandad: time 0.003: dgram_send_addr(addr=0x8052a08,
>
> dgram=0xb7ead284)
>
> > > amandad: time 0.003: (sockaddr_in *)0x8052a08 = { 2, 897,
>
> 172.16.2.71
>
> > }
> >
> > > amandad: time 0.003: dgram_send_addr: 0xb7ead284->socket = 0
> > > amandad: time 0.012: dgram_recv(dgram=0xb7ead284, timeout=0,
> > > fromaddr=0xb7ebd270)
> > > amandad: time 0.012: (sockaddr_in *)0xb7ebd270 = { 2, 897,
>
> 172.16.2.71
>
> > }
> >
> > > amandad: time 0.012: received ACK pkt:
> > > <<<<<
> > >
> > > amandad: time 0.012: security_close(handle=0x80529e8,
> >
> > driver=0xb7eab2e0
> >
> > > (BSD))
> > > amandad: time 0.031: dgram_recv(dgram=0xb7ead284, timeout=0,
> > > fromaddr=0xb7ebd270)
> > > amandad: time 0.031: (sockaddr_in *)0xb7ebd270 = { 2, 897,
>
> 172.16.2.71
>
> > }
> >
> > > amandad: time 0.031: security_handleinit(handle=0x80529c0,
> > > driver=0xb7eab2e0 (BSD))
> > > amandad: time 0.032: accept recv REQ pkt:
> > > <<<<<
> > > SERVICE sendsize
> > > OPTIONS features=fffffeff9ffeffffff7f;maxdumps=1;hostname=
> > > cuttingroom;config=DailySet1;
> > > DUMP /dev/sda1 0 1970:1:1:0:0:0 -1 OPTIONS
> > >
> > > |;auth=BSD;compress-best;index;
> > >
> > > amandad: time 0.032: creating new service: sendsize
> > > OPTIONS features=fffffeff9ffeffffff7f;maxdumps=1;hostname=
> > > cuttingroom;config=DailySet1;
> > > DUMP /dev/sda1 0 1970:1:1:0:0:0 -1 OPTIONS
> > >
> > > |;auth=BSD;compress-best;index;
> > >
> > > amandad: time 0.032: sending ACK pkt:
> > > <<<<<
> > >
> > > amandad: time 0.032: dgram_send_addr(addr=0x80529e0,
>
> dgram=0xb7ead284)
>
> > > amandad: time 0.032: (sockaddr_in *)0x80529e0 = { 2, 897,
>
> 172.16.2.71
>
> > }
> >
> > > amandad: time 0.032: dgram_send_addr: 0xb7ead284->socket = 0
> > > amandad: time 0.033: sending REP pkt:
> > > <<<<<
> > >
> > > amandad: time 0.033: dgram_send_addr(addr=0x80529e0,
>
> dgram=0xb7ead284)
>
> > > amandad: time 0.033: (sockaddr_in *)0x80529e0 = { 2, 897,
>
> 172.16.2.71
>
> > }
> >
> > > amandad: time 0.033: dgram_send_addr: 0xb7ead284->socket = 0
> > > amandad: time 0.034: dgram_recv(dgram=0xb7ead284, timeout=0,
> > > fromaddr=0xb7ebd270)
> > > amandad: time 0.034: (sockaddr_in *)0xb7ebd270 = { 2, 897,
>
> 172.16.2.71
>
> > }
> >
> > > amandad: time 0.034: received ACK pkt:
> > > <<<<<
> > >
> > > amandad: time 0.034: security_close(handle=0x80529c0,
> >
> > driver=0xb7eab2e0
> >
> > > (BSD))
> > > amandad: time 30.034: pid 10077 finish time Wed Jul 9 10:04:52 2008
> > >
> > >
> > >
> > > just for grins I ran
> > >
> > > $ /sbin/dump 0SS /dev/sda1
> > > 3290419200
> > >
> > > as amanda on the debian system and it seems to work.
> > >
> > > I did have to make use amanda an alias for user backup since the
> >
> > debian
> >
> > > install seems to default to user backup but my server uses user
>
> amanda
>
> > > ADVthanksANCE
> > >
> > >
> > >
> > >
> > >
> > >
> > >
> > >
> > >
> > > ____________________
> > >
> > > Jeremy Mordkoff
> > >
> > > ZeeVee, Inc. (formerly Zazzle Technologies, Inc.)
> > >
> > > 1 Monarch Drive, suite 200
> > >
> > > Littleton, MA 01460
> > >
> > > 978-467-1395 x233
--
Forums for Amanda discussion: http://forums.zmanda.com/
|
