Dear Bacula Community Users,
We have run into a problem when setting up our tape library and were hoping one
of you might be able to advise us.
We were following the 11.0.x community documentation “Testing Your Tape Drive
With Bacula” and ran into issues during step 6, the btape fill command.
Indeed, during our three attempts (on two different tapes) when btape had
written about 1.8-2 Tb of data to a tape it encountered a write error and
failed.
The cleaning light on our autoloader lit up after each of these errors and the
system required cleaning before further use.
As the btape test command passed we believe our bacula_sd.conf is set up
properly.
Have any of you encountered a similar problem before?
Did we receive a faulty drive or were unlucky and received two faulty tapes?
Or are we wrong and our configuration might the source of this issue?
Thanks in advance and best regards to all.
Jean-Baptiste
Here are the setup details and error messages we got.
Bacula: v11.0.5-1
Autoloader: HPE MSL 1/8 G2 0-drive Tape Autoloader (firmware version 5.5/2.6n)
Drive: HPE StoreEver MSL LTO-8 Ultrium 30750 SA (Ultrium 8-SCSi, firmware
revision M571)
tapes: HPE LTO-8 ULTRIUM 30TB RW
Error on first attempt (tape 1):
…
Wrote block=28845000, file,blk=94,13232 VolBytes=1,860,848,575,488 rate=147.4
MB/s
btape: block.c:294-0 [SE0201] Write error at 94:17224 on device "LTO-8"
(/dev/nst/tape0) Vol=TestVolume1. ERR=Input/output error.
22-Oct 15:20 btape JobId 0: Error: block.c:294 [SE0201] Write error at 94:17224
on device "LTO-8" (/dev/nst/tape0) Vol=TestVolume1. ERR=Input/output error.
22-Oct 15:20 btape JobId 0: Error: Error writing final EOF to tape. Volume
TestVolume1 may not be readable.
tape_dev.c:971 ioctl MTWEOF error on "LTO-8" (/dev/nst/tape0). ERR=Input/output
error.
btape: btape.c:2724-0 Last block at: 94:17223 this_dev_block_num=17224
btape: btape.c:2759-0 End of tape 94:17224. Volume Bytes=1,861,106,107,392.
Write rate = 143.1 MB/s
22-Oct 15:20 btape JobId 0: End of medium on Volume "TestVolume1"
Bytes=1,861,106,107,392 Blocks=28,848,991 at 22-Oct-2021 15:20.
22-Oct 15:20 btape JobId 0: 3307 Issuing autochanger "unload Volume
TestVolume1, Slot 1, Drive 0" command.
22-Oct 15:21 btape JobId 0: 3304 Issuing autochanger "load Volume TestVolume2,
Slot 2, Drive 0" command.
22-Oct 15:22 btape JobId 0: 3305 Autochanger "load Volume TestVolume2, Slot 2,
Drive 0", status is OK.
Wrote Volume label for volume "TestVolume2".
22-Oct 15:22 btape JobId 0: Wrote label to prelabeled Volume "TestVolume2" on
Tape device "LTO-8" (/dev/nst/tape0)
22-Oct 15:22 btape JobId 0: New volume "TestVolume2" mounted on device "LTO-8"
(/dev/nst/tape0) at 22-Oct-2021 15:22.
btape: btape.c:2323-0 Wrote 1000 blocks on second tape. Done.
Done writing 0 records ...
Wrote End of Session label.
btape: btape.c:2372-0 === free_block 1c94ad0
btape: btape.c:2391-0 Wrote state file last_block_num1=17223
last_block_num2=1001
btape: btape.c:2409-0
15:22:12 Done filling tapes at 0:1003. Now beginning re-read of first tape ...
btape: btape.c:2488-0 Enter do_unfill
22-Oct 15:22 btape JobId 0: 3307 Issuing autochanger "unload Volume
TestVolume2, Slot 2, Drive 0" command.
22-Oct 15:23 btape JobId 0: 3304 Issuing autochanger "load Volume TestVolume1,
Slot 1, Drive 0" command.
22-Oct 15:23 btape JobId 0: 3305 Autochanger "load Volume TestVolume1, Slot 1,
Drive 0", status is OK.
22-Oct 15:23 btape JobId 0: Ready to read from volume "TestVolume1" on Tape
device "LTO-8" (/dev/nst/tape0).
Rewinding.
Reading the first 10000 records from 0:0.
10000 records read now at 1:5084
Reposition from 1:5084 to 94:17223
Reposition error. ERR=tape_dev.c:791 ioctl MTFSR 17223 error on "LTO-8"
(/dev/nst/tape0). ERR=Input/output error.
btape: btape.c:2414-0 do_unfill failed.
Second attempt (tape 2)
…
Wrote block=32085000, file,blk=104,153042 VolBytes=2,069,867,455,488 rate=139.4
MB/s
btape: block.c:294-0 [SE0201] Write error at 104:154707 on device "LTO-8"
(/dev/nst/tape0) Vol=TestVolume1. ERR=Input/output error.
22-Oct 21:05 btape JobId 0: Error: block.c:294 [SE0201] Write error at
104:154707 on device "LTO-8" (/dev/nst/tape0) Vol=TestVolume1. ERR=Input/output
error.
22-Oct 21:05 btape JobId 0: Error: Error writing final EOF to tape. Volume
TestVolume1 may not be readable.
tape_dev.c:971 ioctl MTWEOF error on "LTO-8" (/dev/nst/tape0). ERR=Input/output
error.
btape: btape.c:2724-0 Last block at: 104:154706 this_dev_block_num=154707
btape: btape.c:2759-0 End of tape 104:154707. Volume Bytes=2,069,974,867,968.
Write rate = 136.1 MB/s
22-Oct 21:05 btape JobId 0: End of medium on Volume "TestVolume1"
Bytes=2,069,974,867,968 Blocks=32,086,664 at 22-Oct-2021 21:05.
22-Oct 21:05 btape JobId 0: 3307 Issuing autochanger "unload Volume
TestVolume1, Slot 1, Drive 0" command.
22-Oct 21:08 btape JobId 0: 3304 Issuing autochanger "load Volume TestVolume2,
Slot 2, Drive 0" command.
22-Oct 21:08 btape JobId 0: 3305 Autochanger "load Volume TestVolume2, Slot 2,
Drive 0", status is OK.
Wrote Volume label for volume "TestVolume2".
22-Oct 21:08 btape JobId 0: Wrote label to prelabeled Volume "TestVolume2" on
Tape device "LTO-8" (/dev/nst/tape0)
22-Oct 21:08 btape JobId 0: New volume "TestVolume2" mounted on device "LTO-8"
(/dev/nst/tape0) at 22-Oct-2021 21:08.
btape: btape.c:2323-0 Wrote 1000 blocks on second tape. Done.
Done writing 0 records ...
Wrote End of Session label.
btape: btape.c:2372-0 === free_block 1eaead0
btape: btape.c:2391-0 Wrote state file last_block_num1=154706
last_block_num2=1001
btape: btape.c:2409-0
21:08:48 Done filling tapes at 0:1003. Now beginning re-read of first tape ...
btape: btape.c:2488-0 Enter do_unfill
22-Oct 21:08 btape JobId 0: 3307 Issuing autochanger "unload Volume
TestVolume2, Slot 2, Drive 0" command.
22-Oct 21:09 btape JobId 0: 3304 Issuing autochanger "load Volume TestVolume1,
Slot 1, Drive 0" command.
22-Oct 21:10 btape JobId 0: 3305 Autochanger "load Volume TestVolume1, Slot 1,
Drive 0", status is OK.
22-Oct 21:10 btape JobId 0: Ready to read from volume "TestVolume1" on Tape
device "LTO-8" (/dev/nst/tape0).
Rewinding.
Reading the first 10000 records from 0:0.
10000 records read now at 1:5084
Reposition from 1:5084 to 94:17223
Reposition error. ERR=tape_dev.c:791 ioctl MTFSR 17223 error on "LTO-8"
(/dev/nst/tape0). ERR=Input/output error.
btape: btape.c:2414-0 do_unfill failed.
Read attempt (with scanblocks)
…
1 block of 64504 bytes in file 104
25-Oct 11:30 btape JobId 0: Error: block.c:558 [SE0204] Read error on fd=3 at
addr=104:145353 on device "LTO-8" (/dev/nst/tape0). ERR=Input/output error.
Error reading block. ERR=block.c:558 [SE0204] Read error on fd=3 at
addr=104:145353 on device "LTO-8" (/dev/nst/tape0). ERR=Input/output error.
Total files=104, blocks=32077311, bytes = 2,069,371,083,556
*btape: btape.c:2949-0 "" is an invalid command
Bacula_sd.conf (extract)
…
Autochanger {
Name = Tape_Autochanger
Device = LTO-8
Changer Command = "/opt/bacula/scripts/mtx-changer %c %o %S %a %d"
Changer Device = /dev/tape/by-id/scsi-350014380272e5574
}
Device {
Name = LTO-8
Media Type = LTO-8
Archive Device = /dev/nst/tape0
AutomaticMount = yes; # when device opened, read it
AlwaysOpen = yes;
RemovableMedia = yes;
RandomAccess = no;
Maximum File Size = 20GB
Changer Command = "/opt/bacula/scripts/mtx-changer %c %o %S %a %d"
Changer Device = /dev/tape/by-id/scsi-350014380272e5574
AutoChanger = yes
…
Dr. Jean-Baptiste Gualtierotti
Senior Scientist
_______________________________________________
Bacula-users mailing list
Bacula-users@lists.sourceforge.net
https://lists.sourceforge.net/lists/listinfo/bacula-users
