amcheck reports no problems but taper fails on the dump. I'm running BSDI
4.1 and amanda Amanda-2.4.3b1. The log file shows "FATAL taper syncpipe_get:
r: unexpected EOF" and the amdump.x reports "writing taper command: Broken
pipe". Any ideas anyone on what's wrong here?
Thanks,
Brian
here is the output from my log files:
relay# more log.20020125.9
DISK planner relay.irs.sat wd0a
DISK planner relay.irs.sat wd0h
DISK planner relay.irs.sat wd3a
DISK planner crypto-gw.irs.sat /
DISK planner crypto-gw.irs.sat /usr
START planner date 20020125
INFO planner Adding new disk relay.irs.sat:wd0a.
INFO planner Adding new disk relay.irs.sat:wd0h.
INFO planner Adding new disk relay.irs.sat:wd3a.
INFO planner Adding new disk crypto-gw.irs.sat:/.
INFO planner Adding new disk crypto-gw.irs.sat:/usr.
START driver date 20020125
FATAL taper syncpipe_get: r: unexpected EOF
FINISH planner date 20020125
STATS driver startup time 143.806
FAIL driver relay.irs.sat wd3a 20020125 0 [can't switch to incremental dump]
FAIL driver crypto-gw.irs.sat / 20020125 0 [can't switch to incremental
dump]
FAIL driver relay.irs.sat wd0a 20020125 0 [can't switch to incremental dump]
FAIL driver crypto-gw.irs.sat /usr 20020125 0 [can't switch to incremental
dump]
FAIL driver relay.irs.sat wd0h 20020125 0 [can't switch to incremental dump]
FINISH driver date 20020125 time 143.834
relay#
relay# more amdump.1
amdump: start at Fri Jan 25 10:44:45 EST 2002
amdump: datestamp 20020125
planner: pid 263 executable /usr/local/libexec/planner version 2.4.3b1
planner: build: VERSION="Amanda-2.4.3b1"
planner: BUILT_DATE="Thu Jan 24 09:17:51 EST 2002"
planner: BUILT_MACH="BSD/OS relay.irs.sat 4.1 BSDI BSD/OS 4.1 Kernel
#0: Thu Nov 18 15:10:44 MST 1999 [EMAIL PROTECTED]
M:/hrel/proto/4.1-i386/usr/src/sys/compile/GENERIC i386"
planner: CC="gcc"
planner: paths: bindir="/usr/local/bin" sbindir="/usr/local/sbin"
planner: libexecdir="/usr/local/libexec" mandir="/usr/local/man"
planner: AMANDA_TMPDIR="/tmp/amanda" AMANDA_DBGDIR="/tmp/amanda"
planner: CONFIG_DIR="/usr/local/etc/amanda" DEV_PREFIX="/dev/"
planner: RDEV_PREFIX="/dev/r" DUMP="/sbin/dump"
planner: RESTORE="/sbin/restore"
planner: SAMBA_CLIENT="/usr/contrib/bin/smbclient"
planner: COMPRESS_PATH="/usr/contrib/bin/gzip"
planner: UNCOMPRESS_PATH="/usr/contrib/bin/gzip"
planner: MAILER="/usr/bin/Mail"
planner: listed_incr_dir="/usr/local/var/amanda/gnutar-lists"
planner: defs: DEFAULT_SERVER="relay.irs.sat" DEFAULT_CONFIG="DailySet1"
planner: DEFAULT_TAPE_SERVER="relay.irs.sat"
planner: DEFAULT_TAPE_DEVICE="/dev/nrst0" HAVE_MMAP HAVE_SYSVSHM
planner: LOCKING=POSIX_FCNTL DEBUG_CODE AMANDA_DEBUG_DAYS=4
planner: BSD_SECURITY USE_AMANDAHOSTS CLIENT_LOGIN="amanda"
planner: FORCE_USERID HAVE_GZIP COMPRESS_SUFFIX=".gz"
planner: COMPRESS_FAST_OPT="--fast" COMPRESS_BEST_OPT="--best"
planner: UNCOMPRESS_OPT="-dc"
planner: dgram_bind: socket bound to 0.0.0.0.628
READING CONF FILES...
startup took 0.069 secs
SETTING UP FOR ESTIMATES...
setting up estimates for relay.irs.sat:wd0a
relay.irs.sat:wd0a overdue 11713 days for level 0
setup_estimate: relay.irs.sat:wd0a: command 0, options:
last_level -1 next_level0 -11713 level_days 0
getting estimates 0 (0) -1 (-1) -1 (-1)
setting up estimates for relay.irs.sat:wd0h
relay.irs.sat:wd0h overdue 11713 days for level 0
setup_estimate: relay.irs.sat:wd0h: command 0, options:
last_level -1 next_level0 -11713 level_days 0
getting estimates 0 (0) -1 (-1) -1 (-1)
setting up estimates for relay.irs.sat:wd3a
relay.irs.sat:wd3a overdue 11713 days for level 0
setup_estimate: relay.irs.sat:wd3a: command 0, options:
last_level -1 next_level0 -11713 level_days 0
getting estimates 0 (0) -1 (-1) -1 (-1)
setting up estimates for crypto-gw.irs.sat:/
crypto-gw.irs.sat:/ overdue 11713 days for level 0
setup_estimate: crypto-gw.irs.sat:/: command 0, options:
last_level -1 next_level0 -11713 level_days 0
getting estimates 0 (0) -1 (-1) -1 (-1)
setting up estimates for crypto-gw.irs.sat:/usr
crypto-gw.irs.sat:/usr overdue 11713 days for level 0
setup_estimate: crypto-gw.irs.sat:/usr: command 0, options:
last_level -1 next_level0 -11713 level_days 0
getting estimates 0 (0) -1 (-1) -1 (-1)
setting up estimates took 0.034 secs
GETTING ESTIMATES...
driver: pid 264 executable /usr/local/libexec/driver version 2.4.3b1
driver: send-cmd time 0.115 to taper: START-TAPER 20020125
driver: started dumper0 pid 267
driver: started dumper1 pid 268
driver: started dumper2 pid 269
driver: started dumper3 pid 270
taper: pid 266 executable taper version 2.4.3b1
dumper: dgram_bind: socket bound to 0.0.0.0.634
dumper: pid 268 executable dumper1 version 2.4.3b1, using port 634
taper: page size is 4096
taper: buffer size is 32768
taper: buffer[00] at 0x48190000
taper: buffer[01] at 0x48198000
taper: buffer[02] at 0x481a0000
taper: buffer[03] at 0x481a8000
taper: buffer[04] at 0x481b0000
taper: buffer[05] at 0x481b8000
taper: buffer[06] at 0x481c0000
taper: buffer[07] at 0x481c8000
taper: buffer[08] at 0x481d0000
taper: buffer[09] at 0x481d8000
taper: buffer[10] at 0x481e0000
taper: buffer[11] at 0x481e8000
taper: buffer structures at 0x481f0000 for 144 bytes
dumper: dgram_bind: socket bound to 0.0.0.0.635
dumper: pid 269 executable dumper2 version 2.4.3b1, using port 635
dumper: dgram_bind: socket bound to 0.0.0.0.636
dumper: pid 270 executable dumper3 version 2.4.3b1, using port 636
changer: opening pipe to: /usr/local/libexec/chg-manual -info
dumper: dgram_bind: socket bound to 0.0.0.0.633
dumper: pid 267 executable dumper0 version 2.4.3b1, using port 633
changer: got exit: 0 str: 1 99 1
changer: opening pipe to: /usr/local/libexec/chg-manual -slot current
changer: got exit: 0 str: 1 /dev/nrst0
got result for host crypto-gw.irs.sat disk /usr: 0 -> 523580K, -1 -> -1K, -1
-> -1K
got result for host crypto-gw.irs.sat disk /: 0 -> 10060K, -1 -> -1K, -1 ->
-1K
got result for host relay.irs.sat disk wd3a: 0 -> 1781K, -1 -> -1K, -1 ->
-1K
got result for host relay.irs.sat disk wd0h: 0 -> 547681K, -1 -> -1K, -1 ->
-1K
got result for host relay.irs.sat disk wd0a: 0 -> 13627K, -1 -> -1K, -1 ->
-1K
getting estimates took 143.703 secs
FAILED QUEUE: empty
DONE QUEUE:
0: crypto-gw.irs.sat /usr
1: crypto-gw.irs.sat /
2: relay.irs.sat wd3a
3: relay.irs.sat wd0h
4: relay.irs.sat wd0a
ANALYZING ESTIMATES...
pondering crypto-gw.irs.sat:/usr... next_level0 -11713 last_level -1 (due
for level 0) (new disk, can't switch to degraded mode)
curr level 0 size 261790 total size 262219 total_lev0 261790
balanced-lev0size 13089
pondering crypto-gw.irs.sat:/... next_level0 -11713 last_level -1 (due for
level 0) (new disk, can't switch to degraded mode)
curr level 0 size 5030 total size 267392 total_lev0 266820
balanced-lev0size 13340
pondering relay.irs.sat:wd3a... next_level0 -11713 last_level -1 (due for
level 0) (new disk, can't switch to degraded mode)
curr level 0 size 890 total size 268425 total_lev0 267710
balanced-lev0size 13384
pondering relay.irs.sat:wd0h... next_level0 -11713 last_level -1 (due for
level 0) (new disk, can't switch to degraded mode)
curr level 0 size 547681 total size 816249 total_lev0 815391
balanced-lev0size 40768
pondering relay.irs.sat:wd0a... next_level0 -11713 last_level -1 (due for
level 0) (new disk, can't switch to degraded mode)
curr level 0 size 13627 total size 830019 total_lev0 829018
balanced-lev0size 41449
INITIAL SCHEDULE (size 830019):
relay.irs.sat wd0h pri 11714 lev 0 size 547681
crypto-gw.irs.sat /usr pri 11714 lev 0 size 261790
relay.irs.sat wd3a pri 11714 lev 0 size 890
relay.irs.sat wd0a pri 11713 lev 0 size 13627
crypto-gw.irs.sat / pri 11713 lev 0 size 5030
DELAYING DUMPS IF NEEDED, total_size 830019, tape length 1976320 mark 111
delay: Total size now 830019.
PROMOTING DUMPS IF NEEDED, total_lev0 829018, balanced_size 41449...
analysis took 0.002 secs
ENDFLUSH
GENERATING SCHEDULE:
--------
DUMP relay.irs.sat wd0h 20020125 11714 0 1970:1:1:0:0:0 547681 18256
DUMP crypto-gw.irs.sat /usr 20020125 11714 0 1970:1:1:0:0:0 261790 8726
DUMP relay.irs.sat wd3a 20020125 11714 0 1970:1:1:0:0:0 890 29
DUMP relay.irs.sat wd0a 20020125 11713 0 1970:1:1:0:0:0 13627 454
DUMP crypto-gw.irs.sat / 20020125 11713 0 1970:1:1:0:0:0 5030 167
--------
driver: adding holding disk 0 dir /amanda/hold size 17948910
reserving 17948910 out of 17948910 for degraded-mode dumps
driver: start time 143.806 inparallel 4 bandwidth 2200 diskspace 17948910
dir OBSOLETE datestamp 20020125 driver: drain-ends tapeq L
FFO big-dumpers sssS
driver: result time 143.807 from taper:
dump of driver schedule before start degraded mode:
--------
relay.irs. wd3a lv 0 t 29 s 922 p 11714
crypto-gw. / lv 0 t 167 s 5062 p 11713
relay.irs. wd0a lv 0 t 454 s 13659 p 11713
crypto-gw. /usr lv 0 t 8726 s 261822 p 11714
relay.irs. wd0h lv 0 t 18256 s 547713 p 11714
--------
dump of driver schedule after start degraded mode:
--------
--------
driver: state time 143.809 free kps: 2200 space: 17948910 taper: DOWN
idle-dumpers: 4 qlen tapeq: 0 runq: 0 roomq: 0 wakeup: 86400 d
river-idle: not-idle
driver: interface-state time 143.809 if : free 800 if LE0: free 400 if
LOCAL: free 1000
driver: hdisk-state time 143.809 hdisk 0: free 17948910 dumpers 0
driver: QUITTING time 143.809 telling children to quit
driver: send-cmd time 143.809 to dumper0: QUIT
driver: send-cmd time 143.809 to dumper1: QUIT
driver: send-cmd time 143.809 to dumper2: QUIT
driver: send-cmd time 143.810 to dumper3: QUIT
driver: send-cmd time 143.810 to taper: QUIT
writing taper command: Broken pipe
driver: FINISHED time 143.834
amdump: end at Fri Jan 25 10:47:09 EST 2002
