Hi listreaders,
perhaps can one of you explain me, why the taper of amanda produces excessive
write errors on my Tandberg SLR50 but neither the tapetype program nor a 24/7
running tar (to test the tapedrive) spit out this errors.
If this happens once more I think I will go mad... *g*
I think I append part of /var/log/messages and the amanda logfiles.
/var/log/messages
Jun 4 17:47:03: st: Version 20020205, bufsize 32768, wrt 30720, max init.
bufs 4, s/g segs 16
Jun 4 17:47:03: Attached scsi tape st0 at scsi0, channel 2, id 6, lun 0
Jun 5 00:45:02: st0: Block limits 1 - 262144 bytes.
Jun 8 01:32:58: st0: Error with sense data: Info fld=0x40, Current st09:00:
sense key Medium Error
Jun 8 01:32:58: Additional sense indicates Excessive write errors
Jun 8 01:32:58: st0: Error with sense data: Info fld=0x1, Current st09:00:
sense key Medium Error
Jun 8 01:32:58: Additional sense indicates Excessive write errors
Jun 8 01:32:58: st0: Error on write filemark.
And I use this tapetype in the amanda.conf
define tapetype SLR {
comment "SLR 50 Tapedefinition by Tapetype"
length 45000 mbytes
filemark 0 kbytes
speed 1784 kps
}
Yeah, I know that this tapedrive only has 25Gb uncompressed storage capacity,
but the error occures usually after about 2-10 Gb.
I hope that anyone has an Idea why this happens...
Cheers
Nicki Messerschmidt
To: backup
Subject: bb-backup AMANDA MAIL REPORT FOR June 8, 2002
From: Operator <operator>
Date: Sat, 08 Jun 2002 02:22:13 +0200
These dumps were to tape bb-backup_001.
*** A TAPE ERROR OCCURRED: [[writing file: Input/output error]].
Some dumps may have been left in the holding disk.
Run amflush to flush them to tape.
The next tape Amanda expects to use is: bb-backup_002.
FAILURE AND STRANGE DUMP SUMMARY:
merkur /var lev 0 STRANGE
nathan /var lev 0 STRANGE
dilbert /var lev 0 STRANGE
pluto /var lev 0 STRANGE
pluto /var lev 0 FAILED [out of tape]
ssh / lev 1 STRANGE
STATISTICS:
Total Full Daily
-------- -------- --------
Estimate Time (hrs:min) 0:16
Run Time (hrs:min) 1:37
Dump Time (hrs:min) 1:49 0:57 0:52
Output Size (meg) 2134.7 1670.1 464.5
Original Size (meg) 9557.9 3594.1 5963.8
Avg Compressed Size (%) 22.3 46.5 7.7 (level:#disks ...)
Filesystems Dumped 42 10 32 (1:32)
Avg Dump Rate (k/s) 333.9 499.2 152.5
Tape Time (hrs:min) 0:13 0:11 0:02
Tape Size (meg) 1216.8 1164.0 52.8
Tape Used (%) 2.7 2.6 0.1 (level:#disks ...)
Filesystems Taped 36 8 28 (1:28)
Avg Tp Write Rate (k/s) 1590.8 1741.1 548.0
FAILED AND STRANGE DUMP DETAILS:
/-- merkur /var lev 0 STRANGE
sendbackup: start [merkur:/var level 0]
sendbackup: info BACKUP=/bin/tar
sendbackup: info RECOVER_CMD=/bin/gzip -dc |/bin/tar -f... -
sendbackup: info COMPRESS_SUFFIX=.gz
sendbackup: info end
? gtar: ./lib/amanda/bb-backup/index/hawkeye/_usr/20020608_1.gz.tmp: Warning: Cannot
stat: No such file or directory
| gtar: ./run/mysqld/mysqld.sock: socket ignored
| Total bytes written: 472504320 (451MB, 1.2MB/s)
sendbackup: size 461430
sendbackup: end
\--------
/-- nathan /var lev 0 STRANGE
sendbackup: start [nathan:/var level 0]
sendbackup: info BACKUP=/bin/tar
sendbackup: info RECOVER_CMD=/bin/gzip -dc |/bin/tar -f... -
sendbackup: info COMPRESS_SUFFIX=.gz
sendbackup: info end
? gtar: ./log/mail.info: file changed as we read it
| Total bytes written: 428441600 (409MB, 1.3MB/s)
sendbackup: size 418400
sendbackup: end
\--------
/-- dilbert /var lev 0 STRANGE
sendbackup: start [dilbert:/var level 0]
sendbackup: info BACKUP=/bin/tar
sendbackup: info RECOVER_CMD=/usr/bin/gzip -dc |/bin/tar -f... -
sendbackup: info COMPRESS_SUFFIX=.gz
sendbackup: info end
? gtar: ./lib/mysql/mysql.sock: socket ignored
| Total bytes written: 828733440 (790MB, 3.9MB/s)
sendbackup: size 809310
sendbackup: end
\--------
/-- pluto /var lev 0 STRANGE
sendbackup: start [pluto:/var level 0]
sendbackup: info BACKUP=/bin/tar
sendbackup: info RECOVER_CMD=/usr/bin/gzip -dc |/bin/tar -f... -
sendbackup: info COMPRESS_SUFFIX=.gz
sendbackup: info end
? gtar: Cannot add file ./qmail/queue/info/15/173435: No such file or directory
? gtar: Cannot add file ./qmail/queue/mess/15/173435: No such file or directory
? gtar: Cannot add file ./qmail/queue/remote/15/173435: No such file or directory
| Total bytes written: 329656320
sendbackup: size 321930
sendbackup: end
\--------
/-- ssh / lev 1 STRANGE
sendbackup: start [ssh:/ level 1]
sendbackup: info BACKUP=/bin/tar
sendbackup: info RECOVER_CMD=/usr/bin/gzip -dc |/bin/tar -f... -
sendbackup: info COMPRESS_SUFFIX=.gz
sendbackup: info end
? gtar: ./var/lib/mysql/transphasic.log: file changed as we read it
| Total bytes written: 5289052160 (4.9GB, 3.7MB/s)
sendbackup: size 5165090
sendbackup: end
\--------
NOTES:
planner: Full dump of pluto:/home/pop3 promoted from 4 days ahead.
planner: Full dump of merkur:/var promoted from 4 days ahead.
planner: Full dump of uranus:/home promoted from 4 days ahead.
planner: Full dump of sol:/var/log/acct promoted from 4 days ahead.
planner: Full dump of ssh:/ promoted from 4 days ahead.
planner: Full dump of neptun:/var promoted from 4 days ahead.
planner: Full dump of merkur:/home promoted from 4 days ahead.
planner: Full dump of blasebalg:/var promoted from 4 days ahead.
planner: Full dump of dilbert.wochenanzeiger.de:/var promoted from 4 days ahead.
planner: Full dump of pluto:/var promoted from 4 days ahead.
planner: Full dump of sol:/var promoted from 4 days ahead.
planner: Full dump of uranus:/var promoted from 4 days ahead.
planner: Full dump of dilbert.wochenanzeiger.de:/usr/local/ftp promoted from 4 days
ahead.
planner: Full dump of nathan:/var promoted from 4 days ahead.
taper: tape bb-backup_001 kb 1293056 fm 37 writing file: Input/output error
driver: going into degraded mode because of tape error.
DUMP SUMMARY:
DUMPER STATS TAPER STATS
HOSTNAME DISK L ORIG-KB OUT-KB COMP% MMM:SS KB/s MMM:SS KB/s
-------------------------- --------------------------------- ------------
blasebalg / 1 740 96 13.0 0:01 67.1 0:03 43.0
blasebalg /home 1 1410 128 9.1 0:02 77.9 0:03 54.2
blasebalg /usr 1 16580 1632 9.8 1:51 14.7 0:011164.6
blasebalg /var 0 207200 121216 58.5 1:551057.8 1:111706.7
dilbert / 1 1320 128 9.7 0:03 37.6 0:03 53.5
dilbert /usr 1 2940 352 12.0 0:06 61.5 0:03 126.2
dilbert /apache 1 24070 3648 15.2 0:09 417.3 0:05 746.4
dilbert /local/ftp 1 8140 6912 84.9 0:16 423.3 N/A N/A
dilbert /var 0 809310 162944 20.1 3:21 811.9 1:301802.2
europa /data 1 520 64 12.3 0:01 124.5 0:03 32.7
hawkeye / 1 470 64 13.6 0:01 55.2 0:03 32.2
hawkeye /home 1 1380 160 11.6 0:02 70.0 0:03 62.7
hawkeye /usr 1 1020 160 15.7 0:01 122.6 0:03 64.6
hawkeye /usr/local 1 16240 3968 24.4 0:23 169.8 0:05 763.2
hawkeye /var 1 47990 5632 11.7 0:14 411.6 0:06 929.6
merkur / 1 2400 2400 -- 0:27 90.0 0:04 640.8
merkur /home 1 382350 77344 20.2 4:05 315.7 N/A N/A
merkur /usr 1 2890 288 10.0 0:16 18.4 0:01 486.8
merkur /var 0 461430 142752 30.9 6:31 365.4 1:201791.9
nathan / 1 350 64 18.3 0:14 4.7 0:03 31.8
nathan /home 1 227330 20576 9.1 6:57 49.3 0:141438.2
nathan /usr 1 5130 480 9.4 0:55 8.7 0:01 442.1
nathan /usr/local 1 560 64 11.4 0:04 15.5 0:03 32.6
nathan /var 0 418400 324544 77.6 5:041066.4 3:001804.4
neptun / 1 544 544 -- 0:04 152.1 0:03 191.2
neptun /usr 1 2990 320 10.7 0:23 13.9 0:02 185.5
neptun /var 0 375670 138304 36.8 2:44 845.9 1:301530.3
pingu / 1 19590 2944 15.0 5:23 9.1 0:05 593.6
pluto / 1 1120 1120 -- 0:03 445.5 0:011033.3
pluto /home/pop3 1 156080 99744 63.9 5:35 297.7 N/A N/A
pluto /usr 1 11020 6752 61.3 0:25 266.5 0:09 771.2
pluto /var 0 321930 202016 62.8 5:04 665.1 N/A N/A
sol / 1 416 416 -- 0:08 49.5 0:03 143.5
sol /usr 1 3950 640 16.2 1:03 10.2 0:01 537.7
sol /var 0 618850 274464 44.4 9:56 460.8 2:301827.1
sol /log/acct 0 10 32 320.0 0:03 11.3 0:03 21.8
ssh / 1 5165090 238496 4.6 22:28 177.0 N/A N/A
ssh /boot 1 10 32 320.0 0:00 342.9 0:03 22.7
uranus / 1 288 288 -- 0:03 96.9 0:03 105.4
uranus /home 0 378960 316512 83.5 20:40 255.3 N/A N/A
uranus /usr 1 2010 224 11.1 0:18 12.5 0:01 226.7
uranus /var 0 88620 27424 30.9 1:50 249.0 0:201374.5
(brought to you by Amanda version 2.4.2p2)
START driver date 20020608
START planner date 20020608
START taper datestamp 20020608 label bb-backup_001 tape 0
INFO planner Full dump of pluto.link-m.de:/home/pop3 promoted from 4 days ahead.
FINISH planner date 20020608
STATS driver startup time 964.532
STRANGE dumper pluto.link-m.de /var 0 [sec 303.744 kb 202016 kps 665.1 orig-kb 321930]
sendbackup: start [pluto.link-m.de:/var level 0]
sendbackup: info BACKUP=/bin/tar
sendbackup: info RECOVER_CMD=/usr/bin/gzip -dc |/bin/tar -f... -
sendbackup: info COMPRESS_SUFFIX=.gz
sendbackup: info end
? gtar: Cannot add file ./qmail/queue/info/15/173435: No such file or directory
? gtar: Cannot add file ./qmail/queue/mess/15/173435: No such file or directory
? gtar: Cannot add file ./qmail/queue/remote/15/173435: No such file or directory
| Total bytes written: 329656320
sendbackup: size 321930
sendbackup: end
INFO taper tape bb-backup_001 kb 1293056 fm 37 writing file: Input/output error
FAIL taper pluto.link-m.de /var 0 [out of tape]
ERROR taper no-tape [[writing file: Input/output error]]
WARNING driver going into degraded mode because of tape error.
FINISH driver date 20020608 time 5831.571
