On Jul 22, 2011, at 11:14 AM, Jean-Louis Martineau wrote:
Which amanda release are you using?
Which program/application are you using to do the backup.
Post all the related client debug files.
Jean-Louis
Sorry, I just found the log files for amanda.
root@errol:/var/log/amanda/client# cat selfcheck.20110721155535.debug
1311278135.943302: selfcheck: pid 4612 ruid 34 euid 34 version
2.6.1p1: start at Thu Jul 21 15:55:35 2011
1311278135.943349: selfcheck: version 2.6.1p1
1311278135.943612: selfcheck: checking disk /dev/md0
1311278135.944521: selfcheck: device /dev/md0
1311278135.944538: selfcheck: disk /dev/md0 OK
1311278135.944545: selfcheck: amdevice /dev/md0 OK
1311278135.944551: selfcheck: device /dev/md0 OK
1311278135.944673: selfcheck: pid 4612 finish time Thu Jul 21 15:55:35
2011
root@errol:/var/log/amanda/client# cat sendsize.20110722001502.debug
1311308102.228955: sendsize: pid 4931 ruid 34 euid 34 version 2.6.1p1:
start at Fri Jul 22 00:15:02 2011
1311308102.229003: sendsize: version 2.6.1p1
1311308102.230359: sendsize: waiting for any estimate child: 1 running
1311308102.230412: sendsize: calculating for amname /dev/md0, dirname /
dev/md0, spindle -1 GNUTAR
1311308102.230475: sendsize: getting size via gnutar for /dev/md0
level 0
1311308102.231682: sendsize: pipespawnv: stdoutfd is 3
1311308102.231799: sendsize: Spawning "/usr/lib/amanda/runtar runtar
NOCONFIG /bin/tar --create --file /dev/null --numeric-owner --
directory /dev/md0 --one-file-system --listed-incremental /var/lib/
amanda/gnutar-lists/errol_dev_md0_0.new --sparse --ignore-failed-read
--totals ." in pipeline
1311308102.237388: sendsize: /bin/tar: /dev/md0: Cannot chdir: Not a
directory
1311308102.237769: sendsize: /bin/tar: Error is not recoverable:
exiting now
1311308102.238075: sendsize: .....
1311308102.238094: sendsize: estimate time for /dev/md0 level 0: 0.006
1311308102.238110: sendsize: no size line match in runtar output for /
dev/md0
1311308102.238116: sendsize: .....
1311308102.238123: sendsize: estimate size for /dev/md0 level 0: -1 KB
1311308102.238137: sendsize: waiting for runtar "/dev/md0" child
1311308102.238161: sendsize: after runtar /dev/md0 wait
1311308102.238246: sendsize: done with amname /dev/md0 dirname /dev/
md0 spindle -1
1311308102.238661: sendsize: pid 4931 finish time Fri Jul 22 00:15:02
2011
root@errol:/var/log/amanda/amandad# cat amandad.20110722001501.debug
1311308101.214611: amandad: pid 4927 ruid 34 euid 34 version 2.6.1p1:
start at Fri Jul 22 00:15:01 2011
1311308101.214760: amandad: security_getdriver(name=bsd) returns
0x7f8d9d317900
1311308101.214785: amandad: version 2.6.1p1
1311308101.214792: amandad: build: VERSION="Amanda-2.6.1p1"
1311308101.214798: amandad: BUILT_DATE="Wed Nov 4 03:04:52
UTC 2009"
1311308101.214804: amandad: BUILT_MACH="x86_64-unknown-
linux-gnu" BUILT_REV="1857"
1311308101.214811: amandad: BUILT_BRANCH="amanda-261"
CC="gcc"
1311308101.214817: amandad: paths: bindir="/usr/sbin" sbindir="/
usr/sbin"
1311308101.214823: amandad: libexecdir="/usr/lib/amanda"
1311308101.214829: amandad: amlibexecdir="/usr/lib/amanda"
mandir="/usr/share/man"
1311308101.214835: amandad: AMANDA_TMPDIR="/tmp/amanda"
1311308101.214841: amandad: AMANDA_DBGDIR="/var/log/amanda"
CONFIG_DIR="/etc/amanda"
1311308101.214847: amandad: DEV_PREFIX="/dev/"
RDEV_PREFIX="/dev/r"
1311308101.214853: amandad: DUMP="/sbin/dump" RESTORE="/
sbin/restore" VDUMP=UNDEF
1311308101.214858: amandad: VRESTORE=UNDEF XFSDUMP="/sbin/
xfsdump"
1311308101.214865: amandad: XFSRESTORE="/sbin/xfsrestore"
VXDUMP=UNDEF VXRESTORE=UNDEF
1311308101.214870: amandad: SAMBA_CLIENT="/usr/bin/
smbclient" GNUTAR="/bin/tar"
1311308101.214876: amandad: COMPRESS_PATH="/bin/gzip"
UNCOMPRESS_PATH="/bin/gzip"
1311308101.214882: amandad: LPRCMD="/usr/bin/lpr"
MAILER=UNDEF
1311308101.214888: amandad: listed_incr_dir="/var/lib/
amanda/gnutar-lists"
1311308101.214894: amandad: defs: DEFAULT_SERVER="localhost"
DEFAULT_CONFIG="DailySet1"
1311308101.214900: amandad: DEFAULT_TAPE_SERVER="localhost"
DEFAULT_TAPE_DEVICE=""
1311308101.214906: amandad: HAVE_MMAP NEED_STRSTR
HAVE_SYSVSHM AMFLOCK_POSIX AMFLOCK_FLOCK
1311308101.214911: amandad: AMFLOCK_LOCKF AMFLOCK_LNLOCK
SETPGRP_VOID AMANDA_DEBUG_DAYS=4
1311308101.214917: amandad: BSD_SECURITY USE_AMANDAHOSTS
CLIENT_LOGIN="backup"
1311308101.214923: amandad: CHECK_USERID HAVE_GZIP
COMPRESS_SUFFIX=".gz"
1311308101.214929: amandad: COMPRESS_FAST_OPT="--fast"
COMPRESS_BEST_OPT="--best"
1311308101.214935: amandad: UNCOMPRESS_OPT="-dc"
1311308101.215011: amandad: dgram_recv(dgram=0x7f8d9d322188,
timeout=0, fromaddr=0x7f8d9d332180)
1311308101.215032: amandad: (sockaddr_in *)0x7f8d9d332180 = { 2, 1015,
204.186.196.15 }
1311308101.215054: amandad: security_handleinit(handle=0x98cd00,
driver=0x7f8d9d317900 (BSD))
1311308101.219255: amandad: accept recv REQ pkt:
<<<<<
SERVICE noop
OPTIONS features=fffffeff9f00;
>>>>>
1311308101.219280: amandad: creating new service: noop
OPTIONS features=fffffeff9f00;
1311308101.219715: amandad: sending ACK pkt:
<<<<<
>>>>>
1311308101.219762: amandad: dgram_send_addr(addr=0x98cd40,
dgram=0x7f8d9d322188)
1311308101.219771: amandad: (sockaddr_in *)0x98cd40 = { 2, 1015,
204.186.196.15 }
1311308101.219777: amandad: dgram_send_addr: 0x7f8d9d322188->socket = 0
1311308102.221730: amandad: sending REP pkt:
<<<<<
OPTIONS features=ffffffff9ffeffffffff7f;
>>>>>
1311308102.221763: amandad: dgram_send_addr(addr=0x98cd40,
dgram=0x7f8d9d322188)
1311308102.221771: amandad: (sockaddr_in *)0x98cd40 = { 2, 1015,
204.186.196.15 }
1311308102.221779: amandad: dgram_send_addr: 0x7f8d9d322188->socket = 0
1311308102.222848: amandad: dgram_recv(dgram=0x7f8d9d322188,
timeout=0, fromaddr=0x7f8d9d332180)
1311308102.222879: amandad: (sockaddr_in *)0x7f8d9d332180 = { 2, 1015,
204.186.196.15 }
1311308102.222900: amandad: received ACK pkt:
<<<<<
>>>>>
1311308102.222927: amandad: security_close(handle=0x98cd00,
driver=0x7f8d9d317900 (BSD))
1311308102.223641: amandad: dgram_recv(dgram=0x7f8d9d322188,
timeout=0, fromaddr=0x7f8d9d332180)
1311308102.223652: amandad: (sockaddr_in *)0x7f8d9d332180 = { 2, 1015,
204.186.196.15 }
1311308102.223663: amandad: security_handleinit(handle=0x98cd00,
driver=0x7f8d9d317900 (BSD))
1311308102.226317: amandad: accept recv REQ pkt:
<<<<<
SERVICE sendsize
OPTIONS features=fffffeff9f00;maxdumps=1;hostname=errol;
GNUTAR /dev/md0 0 1970:1:1:0:0:0 -1 OPTIONS |;auth=bsd;index;
>>>>>
1311308102.226346: amandad: creating new service: sendsize
OPTIONS features=fffffeff9f00;maxdumps=1;hostname=errol;
GNUTAR /dev/md0 0 1970:1:1:0:0:0 -1 OPTIONS |;auth=bsd;index;
1311308102.226821: amandad: sending ACK pkt:
<<<<<
>>>>>
1311308102.226864: amandad: dgram_send_addr(addr=0x98cd40,
dgram=0x7f8d9d322188)
1311308102.226873: amandad: (sockaddr_in *)0x98cd40 = { 2, 1015,
204.186.196.15 }
1311308102.226880: amandad: dgram_send_addr: 0x7f8d9d322188->socket = 0
1311308102.239066: amandad: sending REP pkt:
<<<<<
OPTIONS features=ffffffff9ffeffffffff7f;
/dev/md0 0 SIZE -1
>>>>>
1311308102.239084: amandad: dgram_send_addr(addr=0x98cd40,
dgram=0x7f8d9d322188)
1311308102.239093: amandad: (sockaddr_in *)0x98cd40 = { 2, 1015,
204.186.196.15 }
1311308102.239101: amandad: dgram_send_addr: 0x7f8d9d322188->socket = 0
1311308102.240228: amandad: dgram_recv(dgram=0x7f8d9d322188,
timeout=0, fromaddr=0x7f8d9d332180)
1311308102.240251: amandad: (sockaddr_in *)0x7f8d9d332180 = { 2, 1015,
204.186.196.15 }
1311308102.240268: amandad: received ACK pkt:
<<<<<
>>>>>
1311308102.240293: amandad: security_close(handle=0x98cd00,
driver=0x7f8d9d317900 (BSD))
1311308131.244341: amandad: pid 4927 finish time Fri Jul 22 00:15:31
2011
On 07/22/2011 09:35 AM, myron wrote:
I put raid and lvm on the disk running ubuntu 10.04.
Amcheck didn't report any error, but it didn't back up.
I have other linux boxes w/o raid or lvm that back up fine.
I assume that it's the way I specified the partition. /dev/md0
instead
of /dev/sda[1-5], or should it be how lvm specifies the partition
/dev/mapper/system-var.
/var/amanda/DAILY/log/amdump.1
planner: time 0.155: setting up estimates for errol:/dev/md0
errol:/dev/md0 overdue 15177 days for level 0
setup_estimate: errol:/dev/md0: command 0, options:
last_level -1 next_level0 -15177 level_days 0
getting estimates 0 (0) -1 (-1) -1 (-1)
planner: time 0.156: setting up estimates took 0.082 secs
planner: time 1.394: got result for host errol disk /dev/md0: 0 ->
-1K, -1 -> -1K, -1 -> -1K
FAILED QUEUE:
0: errol /dev/md0
planner: FAILED errol /dev/md0 20110722 0 [disk /dev/md0 offline on
errol?]
/var/amanda/DAILY/log/log.20110722.0
DISK planner errol /dev/md0
INFO planner Adding new disk errol:/dev/md0.
FAIL planner errol /dev/md0 20110722 0 [disk /dev/md0 offline on
errol?]
--myron
=================================
Myron Kowalski
MoCoSIN Network/Systems Administrator
Moravian College
[email protected] <mailto:[email protected]>
