Joe Konecny wrote: > Amanda was working fine and now is always asking for the same tape. > I cannot figure out what is wrong. Any tips?
Looks like it had a problem with whatever tape it is trying to use: driver: result time 37.821 from taper: TAPE-ERROR <nohandle> "[writing label: short write]" and then falling back to degraded mode, but the dump is larger than your holding disk (trying to do a 22GB backup onto a 16GB disk, and failing). You might try relabeling the tape it's trying to use and see if there are any write errors due to device permissions, write-protected tape, or perhaps hardware issues with the tape drive. Also, did you do any system upgrades recently? Perhaps your tape device got renumbered or a symlink to it was changed or removed. Frank > > > ** tapelist > 20090528 DailySet1005 reuse > 20090522 DailySet1008 reuse > 20090521 DailySet1004 reuse > 20090520 DailySet1002 reuse > 20090519 DailySet1006 reuse > 20090518 DailySet1007 reuse > > ** amdump.1 > amdump: start at Mon Jun 1 23:00:00 EDT 2009 > amdump: datestamp 20090601 > amdump: starttime 20090601230000 > driver: pid 28068 executable /usr/local/libexec/driver version 2.5.1p3 > planner: pid 28067 executable /usr/local/libexec/planner version 2.5.1p3 > planner: build: VERSION="Amanda-2.5.1p3" > planner: BUILT_DATE="Wed Mar 21 15:05:45 EDT 2007" > planner: BUILT_MACH="FreeBSD r4p17.rmtohio.com 5.2.1-RELEASE FreeBSD > 5.2.1-RELEASE #0: Mon Feb 23 20:45:55 GMT > 2004 r...@wv1u.btc.adaptec.com:/usr/obj/usr/src/sys/GENERIC i386" > planner: CC="gcc" > planner: CONFIGURE_COMMAND="'./configure' '--with-user=bin' > '--with-group=operator' '--with-config=DailySet1'" > 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/" DUMP="/sbin/dump" > planner: RESTORE="/sbin/restore" VDUMP=UNDEF VRESTORE=UNDEF > planner: XFSDUMP=UNDEF XFSRESTORE=UNDEF VXDUMP=UNDEF VXRESTORE=UNDEF > planner: SAMBA_CLIENT="/usr/bin/smbclient" GNUTAR="/usr/bin/tar" > planner: COMPRESS_PATH="/usr/bin/gzip" > planner: UNCOMPRESS_PATH="/usr/bin/gzip" LPRCMD="/usr/bin/lpr" > planner: MAILER="/usr/bin/Mail" > planner: listed_incr_dir="/usr/local/var/amanda/gnutar-lists" > planner: defs: DEFAULT_SERVER="r4p17.rmtohio.com" > planner: DEFAULT_CONFIG="DailySet1" > planner: DEFAULT_TAPE_SERVER="r4p17.rmtohio.com" HAVE_MMAP > planner: HAVE_SYSVSHM LOCKING=POSIX_FCNTL DEBUG_CODE > planner: AMANDA_DEBUG_DAYS=4 BSD_SECURITY RSH_SECURITY USE_AMANDAHOSTS > planner: CLIENT_LOGIN="bin" 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 20090601 > planner: time 0.089: startup took 0.089 secs > > SENDING FLUSHES... > ENDFLUSH > > SETTING UP FOR ESTIMATES... > planner: time 0.089: setting up estimates for r4p17.rmtohio.com:/usr > driver: tape size 36802560 > driver: adding holding disk 0 dir /usr/dumps/amanda size 16080392 chunksize > 1048576 > reserving 16080392 out of 16080392 for degraded-mode dumps > driver: send-cmd time 0.132 to taper: START-TAPER 20090601 > driver: started dumper0 pid 28070 > driver: send-cmd time 0.133 to dumper0: START 20090601 > driver: started dumper1 pid 28071 > driver: send-cmd time 0.133 to dumper1: START 20090601 > driver: started dumper2 pid 28072 > driver: send-cmd time 0.134 to dumper2: START 20090601 > driver: started dumper3 pid 28073 > driver: send-cmd time 0.134 to dumper3: START 20090601 > driver: start time 0.135 inparallel 4 bandwidth 2000 diskspace 16080392 dir > OBSOLETE datestamp 20090601 driver: > drain-ends tapeq FIRST big-dumpers sssS > r4p17.rmtohio.com:/usr overdue 4 days for level 0 > setup_estimate: r4p17.rmtohio.com:/usr: command 0, options: none > last_level 0 next_level0 -4 level_days 0 getting > estimates 0 (-2) 1 (-2) -1 (-2) > planner: time 0.134: setting up estimates took 0.045 secs > > GETTING ESTIMATES... > taper: pid 28069 executable taper version 2.5.1p3 > taper: page size = 4096 > taper: buffer size is 32768 > dumper: pid 28073 executable dumper3 version 2.5.1p3 > dumper: pid 28072 executable dumper2 version 2.5.1p3 > dumper: pid 28070 executable dumper0 version 2.5.1p3 > dumper: pid 28071 executable dumper1 version 2.5.1p3 > planner: time 0.282: got partial result for host r4p17.rmtohio.com disk /usr: > 0 -> -2K, 1 -> -2K, -1 -> -2K > planner: time 13.371: got partial result for host r4p17.rmtohio.com disk > /usr: 0 -> 41959467K, 1 -> -2K, -1 -> -2K > driver: result time 37.821 from taper: TAPE-ERROR <nohandle> "[writing label: > short write]" > driver: state time 37.821 free kps: 2000 space: 16080392 taper: idle > idle-dumpers: 4 qlen tapeq: 0 runq: 0 roomq: 0 > wakeup: 0 driver-idle: not-idle > driver: interface-state time 37.821 if default: free 600 if local: free 1000 > if le0: free 400 > driver: hdisk-state time 37.821 hdisk 0: free 16080392 dumpers 0 > planner: time 167.729: got partial result for host r4p17.rmtohio.com disk > /usr: 0 -> 41959467K, 1 -> 9341565K, -1 -> -2K > planner: time 167.731: got result for host r4p17.rmtohio.com disk /usr: 0 -> > 41959467K, 1 -> 9341565K, -1 -> -2K > planner: time 167.731: getting estimates took 167.596 secs > FAILED QUEUE: empty > DONE QUEUE: > 0: r4p17.rmtohio.com /usr > > ANALYZING ESTIMATES... > pondering r4p17.rmtohio.com:/usr... next_level0 -4 last_level 0 (due for > level 0) (picking inclevel for degraded mode) > picklev: last night 0, so tonight level 1 > > curr level 0 nsize 41959467 csize 22418551 total size 22418647 total_lev0 > 22418551 balanced-lev0size 22418551 > INITIAL SCHEDULE (size 22418647): > r4p17.rmtohio.com /usr pri 6 lev 0 nsize 41959467 csize 22418551 > > DELAYING DUMPS IF NEEDED, total_size 22418647, tape length 36802560 mark 0 > delay: Total size now 22418647. > > PROMOTING DUMPS IF NEEDED, total_lev0 22418551, balanced_size 22418551... > planner: time 167.732: analysis took 0.000 secs > > GENERATING SCHEDULE: > -------- > DUMP r4p17.rmtohio.com fffffeff9ffeffffff7f /usr 20090601 6 0 1970:1:1:0:0:0 > 41959467 22418551 10292 2178 1 > 2009:5:29:3:2:40 9341565 4670782 4561 1024 > -------- > driver: flush size 0 > dump of driver schedule before start degraded mode: > -------- > r4p17.rmtohio.com /usr lv 0 t 10292 s 22418592 p 6 > -------- > dump of driver schedule after start degraded mode: > -------- > r4p17.rmtohio.com /usr lv 1 t 4561 s 22418592 p 6 > -------- > driver: find_diskspace: time 167.734: want 22418592 K > driver: find_diskspace: time 167.734: find diskspace: size 22418592 hf > 16080392 df 16079880 da 16079880 ha 16080392 > find diskspace: not enough diskspace. Left with 6338712 K > driver: find_diskspace: time 167.734: want 22418592 K > driver: find_diskspace: time 167.734: find diskspace: size 22418592 hf > 16080392 df 16079880 da 16079880 ha 16080392 > find diskspace: not enough diskspace. Left with 6338712 K > driver: find_diskspace: time 167.734: want 22418592 K > driver: find_diskspace: time 167.734: find diskspace: size 22418592 hf > 16080392 df 16079880 da 16079880 ha 16080392 > find diskspace: not enough diskspace. Left with 6338712 K > driver: find_diskspace: time 167.734: want 22418592 K > driver: find_diskspace: time 167.734: find diskspace: size 22418592 hf > 16080392 df 16079880 da 16079880 ha 16080392 > find diskspace: not enough diskspace. Left with 6338712 K > driver: state time 167.734 free kps: 2000 space: 16080392 taper: DOWN > idle-dumpers: 4 qlen tapeq: 0 runq: 0 roomq: 0 > wakeup: 0 driver-idle: no-diskspace > driver: interface-state time 167.734 if default: free 600 if local: free 1000 > if le0: free 400 > driver: hdisk-state time 167.734 hdisk 0: free 16080392 dumpers 0 > driver: QUITTING time 167.735 telling children to quit > driver: send-cmd time 167.735 to dumper0: QUIT > driver: send-cmd time 167.735 to dumper1: QUIT > driver: send-cmd time 167.736 to dumper2: QUIT > driver: send-cmd time 167.737 to dumper3: QUIT > driver: send-cmd time 167.737 to taper: QUIT > taper: DONE [idle wait: 129.916 secs] > driver: FINISHED time 168.740 > amdump: end at Mon Jun 1 23:02:49 EDT 2009 > Scanning /usr/dumps/amanda... > 0 > 0 > 0 > 0 > 0 > 0 > 0 > -- Frank Smith fsm...@hoovers.com Sr. Systems Administrator Voice: 512-374-4673 Hoover's Online Fax: 512-374-4501