Thank you.

On 4/27/2010 1:17 PM, John Jorgensen wrote:
>>>>>> "bdebelius" == Brian Debelius<[email protected]>  writes:
>>>>>>              
>      bdebelius>  Hi,
>      bdebelius>  I am testing 5.0.1 on a new server with a SAS LTO-3 drive, 
> and Ubuntu
>      bdebelius>  Lucid.  Btape says the test succeeded and then says it 
> failed.  Did it fail?
>
>  From observation, rather than from actually reading the btape code, I
> believe that frequently when btape reports a line like
>
>      bdebelius>  btape: btape.c:2403 do_unfill failed.
>
> the "do_unfill failed" part comes from the most recent operation
> to have returned some kind of error indication rather than from
> the most recently executed operation. So I'd say that your test
> did, in fact, succeed though some "do_unfill" request
> incorporated in the test failed when it was expected to fail.
>
>
> I'll illustrate my hypothesis with some extracts from the output
> when I ran "bls fill" to test a replacement tape drive (I used -d
> to boost the debugging level, which increased the volume of
> messages).
>
> Trying to read one block past the end of tape led to a
>
>    ERR=block.c:1023 Read zero bytes at 616:0 on device "ML6000-LTO3-0" 
> (/dev/nst0)
>
> and that error kept getting repeated in the status reports from
> subsequent commands which succeeded.  Here's an illustrative
> excerpt:
>
>    btape: btape.c:485 Rewound "ML6000-LTO3-0" (/dev/nst0)
>    *status
>     Bacula status: file=0 block=0
>     Device status: BOT ONLINE IM_REP_EN file=0 block=0
>    btape: btape.c:1815 Device status: 645. ERR=
>    *fill
>    .
>    .
>    .
>    21-Apr 22:08 btape JobId 0: Ready to read from volume "TestVolume1" on 
> device "ML6000-LTO3-0" (/dev/nst0).
>    Rewinding.
>    Reading the first 10000 records from 0:0.
>    10000 records read now at 1:5084
>    Reposition from 1:5084 to 616:15500
>    Reading block 15500.
>    Error reading block: ERR=block.c:1023 Read zero bytes at 616:0 on device 
> "ML6000-LTO3-0" (/dev/nst0).
>
>    *rewind
>    btape: btape.c:485 Rewound "ML6000-LTO3-0" (/dev/nst0)
>    *status
>     Bacula status: file=0 block=0
>     Device status: BOT ONLINE IM_REP_EN file=0 block=0
>    btape: btape.c:1815 Device status: 645. ERR=block.c:1023 Read zero bytes 
> at 616:0 on device "ML6000-LTO3-0" (/dev/nst0).
>
>    *eom
>    btape: btape.c:536 Moved to end of medium.
>    *status
>     EOF Bacula status: file=618 block=0
>     Device status: EOD ONLINE IM_REP_EN file=618 block=-1
>    btape: btape.c:1815 Device status: 675. ERR=block.c:1023 Read zero bytes 
> at 616:0 on device "ML6000-LTO3-0" (/dev/nst0).
>
>    *bsf 2
>    btape: btape.c:565 Backspaced 2 files.
>    *status
>     Bacula status: file=616 block=0
>     Device status: ONLINE IM_REP_EN file=616 block=-1
>    btape: btape.c:1815 Device status: 641. ERR=block.c:1023 Read zero bytes 
> at 616:0 on device "ML6000-LTO3-0" (/dev/nst0).
>
>
> Clearly the "rewind" command shouldn't have been reading
> anything, certainly not at tape file 616, that has to be a
> leftover.
>    


------------------------------------------------------------------------------
_______________________________________________
Bacula-devel mailing list
[email protected]
https://lists.sourceforge.net/lists/listinfo/bacula-devel

Reply via email to