Hello Philipp,
First of all thanks for your time helping me.

I am runing the bareos-14.2.2-46.1.fc20.i686 and my test machine is a Fedora18 
(Let me know if you believe that this fc20 package is not compatible with 
Fedora 18). bareos-debuginfo, bareos-devel and bareos-tools are not installed 
yet.

I just moved the scsicrypto-sd.so and run the test again.
I had set both tape streamers to "Label Block Size = 64512" and "Maximum Block 
Size = 64512" and re run the tests.
Both units failed but the messages were a bit different from what I first 
reported:

# mt -f /dev/st0 eject
# mt -f /dev/st0 load
# btape -v /dev/st0
Tape block granularity is 1024 bytes.
btape: butil.c:301-0 Using device: "/dev/st0" for writing.
btape: btape.c:484-0 open device "LTO-4 INTERNO" (/dev/st0): OK
*readlabel
btape: btape.c:536-0 Volume label read correctly.

Volume Label:
Id                : Bacula 1.0 immortal
VerNo             : 11
VolName           : TestVolume1
PrevVolName       : 
VolFile           : 0
LabelType         : VOL_LABEL
LabelSize         : 170
PoolName          : Default
MediaType         : LTO-4
PoolType          : Backup
HostName          : fedora18.soliton
Date label written: 17-Jan-2015 21:01
*fill
...
...
Wrote block=6495000, file,blk=78,3840 VolBytes=419,005,440,000 rate=74.12 MB/s
Wrote block=6500000, file,blk=78,8840 VolBytes=419,328,000,000 rate=74.12 MB/s
19-Jan 14:26 btape JobId 0: End of Volume "TestVolume1" at 78:10498 on device 
"LTO-4 INTERNO" (/dev/st0). Write of 64512 bytes got -1.
19-Jan 14:26 btape JobId 0: Re-read of last block succeeded.
btape: btape.c:2736-0 Last block at: 78:10497 this_dev_block_num=10498
btape: btape.c:2750-0 Block not written: FileIndex=12788317 blk_block=6501658 
Size=206
btape: block.c:96-0 Dump block Last block written 23b51f0: size=64512 
BlkNum=6501657
               Hdrcksum=622aa7ef cksum=622aa7ef
btape: block.c:109-0    Rec: VId=1 VT=1421679082 FI=12788313 Strm=contDATA 
len=29172 p=23ce678
btape: block.c:109-0    Rec: VId=1 VT=1421679082 FI=12788314 Strm=DATA 
len=32768 p=23d5878
btape: block.c:109-0    Rec: VId=1 VT=1421679082 FI=12788315 Strm=DATA 
len=32768 p=23dd884

btape: block.c:96-0 Dump block Block not written 23a5300: size=64512 
BlkNum=6501658
               Hdrcksum=280d55fd cksum=280d55fd
btape: block.c:109-0    Rec: VId=1 VT=1421679082 FI=12788315 Strm=contDATA 
len=30256 p=23a53b8
btape: block.c:109-0    Rec: VId=1 VT=1421679082 FI=12788316 Strm=DATA 
len=32768 p=23ac9f4
btape: block.c:109-0    Rec: VId=1 VT=1421679082 FI=12788317 Strm=DATA 
len=32768 p=23b4a00
btape: btape.c:2771-0 End of tape 78:0. Volume Bytes=419,434,960,896. Write 
rate = 74.06 MB/s
btape: btape.c:2336-0 Wrote 1000 blocks on second tape. Done.
Done writing 0 records ...
btape: btape.c:2405-0 Wrote state file last_block_num1=10497 last_block_num2=0
btape: btape.c:2420-0 

14:26:23 Done filling tape at 78:0. Now beginning re-read of tape ...
btape: btape.c:2501-0 Enter do_unfill
19-Jan 14:26 btape JobId 0: Warning: acquire.c:267 Read acquire: Could not 
unserialize Volume label: ERR=label.c:871 Expecting Volume Label, got 
FI=SOS_LABEL Stream=0 len=144

Mount Volume "TestVolume1" on device "LTO-4 INTERNO" (/dev/st0) and press 
return when ready: 
19-Jan 14:27 btape JobId 0: Warning: acquire.c:267 Read acquire: Could not 
unserialize Volume label: ERR=label.c:871 Expecting Volume Label, got 
FI=SOS_LABEL Stream=0 len=144

Mount Volume "TestVolume1" on device "LTO-4 INTERNO" (/dev/st0) and press 
return when ready: 
19-Jan 14:30 btape JobId 0: Warning: acquire.c:267 Read acquire: Could not 
unserialize Volume label: ERR=label.c:871 Expecting Volume Label, got 
FI=SOS_LABEL Stream=0 len=144




On Monday, January 19, 2015 at 6:15:58 AM UTC-2, philipp.storz wrote:
> Hello John,
> 
> What bareos version are you using?
> 
> I think that your problem might be a problem related to
> 
> http://bugs.bareos.org/view.php?id=338
> 
> Just move/delete the scsicrypto-sd.so plugin so that it doesnt get loaded,
> 
> Btape should work then.
> 
> best regards,
> 
> Philipp
> 
> 
> Am 17.01.2015 um 23:36 schrieb John Bolt:
> > Bareos is failing to complete the btape fill test.
> > I tried it with the "m" (2 tapes) and "s" (single tape). The log lines 
> > below are for the "s" single tape run.
> > 
> > I tried multiple times with both LTO units I have, an INTERNAL and AN 
> > EXTERNAL one.
> > I had tweaked the "Maximum File Size" and "Maximum Block Size" for best 
> > performance.
> > btape test worked successfully. Only fill is failing.
> > 
> > I will really appreciate any help provided as these tests are very long (2 
> > hours each run) and I do not feel comfortable using a backup system that 
> > fails its basic tests.
> > 
> > By the way, it may be bug related because I selected "s" (single tape) and 
> > Bareos btape informed that it wrote on the second tape (see log bellow).
> >  
> > For this run the bareos-sd.conf contains the following lines:
> > 
> > Device {
> >   Name = "LTO-4 EXTERNAL"
> >   Media Type = LTO-4 
> >   Archive Device = /dev/st1
> >   Device Type = Tape
> >   AutomaticMount = yes;                     # when device opened, read it 
> >   AlwaysOpen = yes; 
> >   RemovableMedia = yes; 
> >   RandomAccess = no; 
> >   Maximum File Size = 5G
> >   Label Block Size = 64512
> >   Maximum Block Size = 262144
> >   LabelMedia = yes;
> >   Changer Device = /dev/st0
> >   Alert Command = "sh -c 'tapeinfo -f %c |grep TapeAlert|cat'"
> >   Alert Command = "sh -c 'smartctl -H -l error %c'"
> > } 
> > 
> > 
> > btape -v /dev/st1
> > Tape block granularity is 1024 bytes.
> > btape: butil.c:301-0 Using device: "/dev/st1" for writing.
> > btape: btape.c:484-0 open device "LTO-4 EXTERNAL" (/dev/st1): OK
> > 
> > *label
> > Enter Volume Name: TestVolume1
> > Wrote Volume label for volume "TestVolume1".
> > *fill
> > ....
> > or the complete multiple tape (m) test: (s/m) s
> > Simple test (single tape) selected.
> > Wrote Start of Session label.
> > 18:19:02 Begin writing Bareos records to tape ...
> > Wrote block=5000, file,blk=1,5000 VolBytes=1,310,720,000 rate=77.10 MB/s
> > Wrote block=10000, file,blk=1,10000 VolBytes=2,621,440,000 rate=79.43 MB/s
> > ...
> > ...
> > Wrote block=1605000, file,blk=79,7638 VolBytes=420,741,120,000 rate=75.83 
> > MB/s
> > Wrote block=1610000, file,blk=79,12638 VolBytes=422,051,840,000 rate=75.85 
> > MB/s
> > 17-Jan 19:51 btape JobId 0: End of Volume "TestVolume1" at 79:13746 on 
> > device "LTO-4 EXTERNAL" (/dev/st1). Write of 262144 bytes got -1.
> > 17-Jan 19:51 btape JobId 0: Re-read of last block succeeded.
> > btape: btape.c:2736-0 Last block at: 79:13745 this_dev_block_num=13746
> > btape: btape.c:2750-0 Block not written: FileIndex=12882385 
> > blk_block=1611108 Size=262144
> > btape: block.c:96-0 Dump block Last block written 1c08260: size=262144 
> > BlkNum=1611107
> >                Hdrcksum=57dd6344 cksum=57dd6344
> > btape: block.c:109-0    Rec: VId=1 VT=1421525883 FI=12882369 Strm=contDATA 
> > len=22408 p=1c7d668
> > btape: block.c:109-0    Rec: VId=1 VT=1421525883 FI=12882370 Strm=DATA 
> > len=32768 p=1c82dfc
> > ...
> > ...
> > btape: block.c:109-0    Rec: VId=1 VT=1421525883 FI=12882376 Strm=DATA 
> > len=32768 p=1cb2e44
> > btape: block.c:109-0    Rec: VId=1 VT=1421525883 FI=12882377 Strm=DATA 
> > len=32768 p=1cbae50
> > 
> > btape: block.c:96-0 Dump block Block not written 1c08180: size=262144 
> > BlkNum=1611108
> >                Hdrcksum=528c3a10 cksum=528c3a10
> > btape: block.c:109-0    Rec: VId=1 VT=1421525883 FI=12882377 Strm=contDATA 
> > len=22540 p=1c24f28
> > btape: block.c:109-0    Rec: VId=1 VT=1421525883 FI=12882378 Strm=DATA 
> > len=32768 p=1c2a740
> > ...
> > ...
> > btape: block.c:109-0    Rec: VId=1 VT=1421525883 FI=12882385 Strm=DATA 
> > len=32768 p=1c62794
> > btape: btape.c:2771-0 End of tape 79:0. Volume Bytes=422,342,295,552. Write 
> > rate = 75.78 MB/s
> > btape: btape.c:2336-0 Wrote 1000 blocks on second tape. Done.
> > Done writing 0 records ...
> > btape: btape.c:2405-0 Wrote state file last_block_num1=13745 
> > last_block_num2=0
> > btape: btape.c:2420-0 
> > 
> > 19:51:55 Done filling tape at 79:0. Now beginning re-read of tape ...
> > btape: btape.c:2501-0 Enter do_unfill
> > 17-Jan 19:52 btape JobId 0: Warning: acquire.c:267 Read acquire: 
> > label.c:260 Could not reserve volume TestVolume1 on "LTO-4 EXTERNAL" 
> > (/dev/st1)
> > Mount Volume "TestVolume1" on device "LTO-4 EXTERNAL" (/dev/st1) and press 
> > return when ready: 
> > Mount Volume "TestVolume1" on device "LTO-4 EXTERNAL" (/dev/st1) and press 
> > return when ready: 
> > 
> > The "TestVolume1" IS ALREADY mounted on device "LTO-4 EXTERNAL" (/dev/st1) 
> > but bareos btape does not accept it anymore.
> > 
> 
> 
> -- 
> Mit freundlichen Grüßen
> 
>  Philipp Storz                             
>  Bareos GmbH & Co. KG                       Phone: Phone: +49221630693-92
>  http://www.bareos.com                      Fax: +49221630693-10
> 
>  Sitz der Gesellschaft: Köln | Amtsgericht Köln: HRA 29646
>  Geschäftsführer: Stephan Dühr, M. Außendorf,
>  J. Steffens, P. Storz, M. v. Wieringen

-- 
You received this message because you are subscribed to the Google Groups 
"bareos-users" group.
To unsubscribe from this group and stop receiving emails from it, send an email 
to [email protected].
To post to this group, send email to [email protected].
For more options, visit https://groups.google.com/d/optout.

Reply via email to