Amanda-Users

Re: more restore problems with tape spanning...

2007-07-05 20:48:22
Subject: Re: more restore problems with tape spanning...
From: Jean-Francois Malouin <Jean-Francois.Malouin AT bic.mni.mcgill DOT ca>
To: Jean-Louis Martineau <martineau AT zmanda DOT com>
Date: Thu, 5 Jul 2007 20:40:54 -0400
* Jean-Francois Malouin <Jean-Francois.Malouin AT bic.mni.mcgill DOT ca> 
[20070705 16:05]:
> Hold on to answer this one Jean-Louis.
> I think I've found the problem and I'm 
> doing a amfetchdump run and it went 
> through the first tape and resumed the
> restore with the second tape.
> I'll post later when it completes.

OK here it goes: I had somehow 2 config recompiled most probably
without doing a 'make distclean' between the configure. The hint 
was that the debug files for this one were not located in 
the right place and once I found them I realized that amfetchdump 
could not find the chg-zd-mtx script.

The amfetchdump debug file (in /tmp/amanda-spantest/server/stk_80-conf2
it should have been /tmp/amanda-conf2/server/stk_80-conf2):

...
search_tapes(prompt_out=2, prompt_in=0,  use_changer=1, tapelist=100873f8, 
match_list=10025758, flags=10016550, features=0)
<error> could not exec "/opt/amanda/spantest/libexec/chg-zd-mtx": No such file 
or directory
changer: got exit: 1 str: <error> could not read result from 
"/opt/amanda/spantest/libexec/chg-zd-mtx"
num_entries(tapelist=100873f8)=7
<error> could not exec "/opt/amanda/spantest/libexec/chg-zd-mtx": No such file 
o r directory
changer: got exit: 1 str: <error> could not read result from 
"/opt/amanda/spantest/libexec/chg-zd-mtx"


So I recompiled making sure to start with a clean slate and now I get:


# /opt/amanda/amanda2/sbin/amfetchdump -p -a stk_80-conf2 \
yorick /data/ipl/ipl10 20070630 | /usr/freeware/bin/tar -xpf -
7 tape(s) needed for restoration
cc
dd (null)
The following tapes are needed: stk_40-conf2-000017 stk_40-conf2-000018
stk_40-conf2-000019 stk_40-conf2-000020 stk_40-conf2-000014
stk_40-conf2-000015 stk_40-conf2-000001
ee (null)
ff /hw/tape/tps22d2nrnsv
gg /hw/tape/tps22d2nrnsv
Label mismatch, got stk_40-conf2-000018 and expected stk_40-conf2-000017
hh /hw/tape/tps22d2nrnsv
Looking for tape stk_40-conf2-000017...
amfetchdump: slot 26: date 20070630 label stk_40-conf2-000017 (exact label 
match)
ii /hw/tape/tps22d2nrnsv
Scanning stk_40-conf2-000017 (slot 26)
amfetchdump: 14: restoring split dumpfile: date 20070630 host yorick disk 
/data/ipl/ipl10 part 1/UNKNOWN lev 0 comp N program /usr/freeware/bin/tar
amfetchdump: 15: restoring split dumpfile: date 20070630 host yorick disk 
/data/ipl/ipl10 part 2/UNKNOWN lev 0 comp N program /usr/freeware/bin/tar
amfetchdump: Search of stk_40-conf2-000017 complete
gg /hw/tape/tps22d2nrnsv
Label mismatch, got stk_40-conf2-000017 and expected stk_40-conf2-000018
hh /hw/tape/tps22d2nrnsv
Looking for tape stk_40-conf2-000018...
amfetchdump: slot 28: date 20070630 label stk_40-conf2-000018 (exact label 
match)
ii /hw/tape/tps22d2nrnsv
Scanning stk_40-conf2-000018 (slot 28)
amfetchdump: 1: restoring split dumpfile: date 20070630 host yorick disk 
/data/ipl/ipl10 part 3/UNKNOWN lev 0 comp N program /usr/freeware/bin/tar
amfetchdump: 2: restoring split dumpfile: date 20070630 host yorick disk 
/data/ipl/ipl10 part 4/UNKNOWN lev 0 comp N program /usr/freeware/bin/tar
amfetchdump: 3: restoring split dumpfile: date 20070630 host yorick disk 
/data/ipl/ipl10 part 5/UNKNOWN lev 0 comp N program /usr/freeware/bin/tar
amfetchdump: 4: restoring split dumpfile: date 20070630 host yorick disk 
/data/ipl/ipl10 part 6/UNKNOWN lev 0 comp N program /usr/freeware/bin/tar
amfetchdump: 5: restoring split dumpfile: date 20070630 host yorick disk 
/data/ipl/ipl10 part 7/UNKNOWN lev 0 comp N program /usr/freeware/bin/tar
amfetchdump: 6: restoring split dumpfile: date 20070630 host yorick disk 
/data/ipl/ipl10 part 8/UNKNOWN lev 0 comp N program /usr/freeware/bin/tar
amfetchdump: 7: restoring split dumpfile: date 20070630 host yorick disk 
/data/ipl/ipl10 part 9/UNKNOWN lev 0 comp N program /usr/freeware/bin/tar
amfetchdump: 8: restoring split dumpfile: date 20070630 host yorick disk 
/data/ipl/ipl10 part 10/UNKNOWN lev 0 comp N program /usr/freeware/bin/tar
amfetchdump: 9: restoring split dumpfile: date 20070630 host yorick disk 
/data/ipl/ipl10 part 11/UNKNOWN lev 0 comp N program /usr/freeware/bin/tar
amfetchdump: 10: restoring split dumpfile: date 20070630 host yorick disk 
/data/ipl/ipl10 part 12/UNKNOWN lev 0 comp N program /usr/freeware/bin/tar
amfetchdump: 11: restoring split dumpfile: date 20070630 host yorick disk 
/data/ipl/ipl10 part 13/UNKNOWN lev 0 comp N program /usr/freeware/bin/tar
amfetchdump: error reading file header: No space left on device
amfetchdump: Search of stk_40-conf2-000018 complete

/usr/freeware/bin/tar: Unexpected EOF in archive
/usr/freeware/bin/tar: Unexpected EOF in archive

/usr/freeware/bin/tar: Error is not recoverable: exiting now

amfetchdump.*.debug attached.

jf

> jf
> 
> * Jean-Louis Martineau <martineau AT zmanda DOT com> [20070705 14:02]:
> > Try amfetchdump.
> > 
> > Jean-Louis
> > 
> > Jean-Francois Malouin wrote:
> > >* Jean-Louis Martineau <martineau AT zmanda DOT com> [20070705 09:08]:
> > >  
> > >>Try the attached patch for amrestore and amfetchdump.
> > >>    
> > >
> > >patch applied, hmm, still getting the 'no space left on device':
> > >
> > >/opt/amanda/amanda2/sbin/amrestore /hw/tape/tps22d2nrnsv nosuchhost
> > >amrestore: 1: skipping yorick._data_mril_mril5_bojana_images.20070630.0
> > >amrestore: 2: skipping yorick._.20070630.1
> > >amrestore: 3: skipping yorick._data_noel_noel1.20070630.0
> > >amrestore: 4: skipping yorick.noel1_neda_03.20070630.1
> > >amrestore: 5: skipping yorick._data_mril_mril5_tardif.20070630.2
> > >amrestore: 6: skipping yorick._data_mril_mril5_leili.20070630.0
> > >amrestore: 7: skipping yorick._data_mril_mril5_vivian.20070630.0
> > >amrestore: 8: skipping yorick._data_mril_mril5_mferre.20070630.0
> > >amrestore: 9: skipping yorick._data_mril_mril5_ives.20070630.0
> > >amrestore: 10: skipping yorick._data_mril_mril5_jcampbel.20070630.1
> > >amrestore: 11: skipping yorick._data_mril_mril5_vanela.20070630.0
> > >amrestore: 12: skipping 
> > >yorick._data_mril_mril5_mgriffin_Experimental_data.20070630.1
> > >amrestore: 13: skipping yorick._data_mril_mril5_bojana.20070630.1
> > >amrestore: 14: skipping yorick._data_ipl_ipl10.20070630.0.0000001
> > >amrestore: 15: skipping yorick._data_ipl_ipl10.20070630.0.0000002
> > >amrestore: 16: skipping yorick._data_ipl_ipl10.20070630.0.0000003
> > >amrestore: could not fsf /hw/tape/tps22d2nrnsv: No space left on device
> > >
> > >amrestore.*.debug:
> > >
> > >amrestore: debug 1 pid 53730507 ruid 0 euid 0: start at Thu Jul  5 
> > >10:48:53 2007
> > >amrestore: time 723.545: could not fsf /hw/tape/tps22d2nrnsv: No space 
> > >left on device
> > >amrestore: time 723.545: pid 53730507 finish time Thu Jul  5 11:00:56 2007
> > >
> > >jf
> > >
> > >  
> > >>Jean-Louis
> > >>
> > >>Jean-Francois Malouin wrote:
> > >>    
> > >>>* Jean-Louis Martineau <martineau AT zmanda DOT com> [20070704 08:04]:
> > >>> 
> > >>>      
> > >>>>Jean-Francois Malouin wrote:
> > >>>>   
> > >>>>        
> > >>>>>Following on my previous post: here's what I get
> > >>>>>
> > >>>>>/opt/amanda/amanda2/sbin/amfetchdump -p -l stk_80-conf2 yorick
> > >>>>>/data/ipl/ipl10
> > >>>>>20070630 -o stk_80-conf2 | /usr/freeware/bin/tar -xvGpf -
> > >>>>>"(null)", line 0: Must specify a value for stk_80-conf2.
> > >>>>>
> > >>>>>     
> > >>>>>          
> > >>>>You can remove the '-o stk_80-conf2' argument.
> > >>>>   
> > >>>>        
> > >>>>>amfetchdump: time 2425.149: could not fsf /hw/tape/tps22d2nrnsv: No 
> > >>>>>space left on device
> > >>>>>
> > >>>>>     
> > >>>>>          
> > >>>>I don't understand the 'No space left on device' error.
> > >>>>
> > >>>>Can you put the stk_40-conf2-000017 tape in the drive and run:
> > >>>>mt -f /hw/tape/tps22d2nrnsv rewind
> > >>>>amrestore /hw/tape/tps22d2nrnsv nohost
> > >>>>   
> > >>>>        
> > >>>here's what I got:
> > >>>
> > >>>amrestore: 1: skipping yorick._data_mril_mril5_bojana_images.20070630.0
> > >>>amrestore: 2: skipping yorick._.20070630.1
> > >>>amrestore: 3: skipping yorick._data_noel_noel1.20070630.0
> > >>>amrestore: 4: skipping yorick.noel1_neda_03.20070630.1
> > >>>amrestore: 5: skipping yorick._data_mril_mril5_tardif.20070630.2
> > >>>amrestore: 6: skipping yorick._data_mril_mril5_leili.20070630.0
> > >>>amrestore: 7: skipping yorick._data_mril_mril5_vivian.20070630.0
> > >>>amrestore: 8: skipping yorick._data_mril_mril5_mferre.20070630.0
> > >>>amrestore: 9: skipping yorick._data_mril_mril5_ives.20070630.0
> > >>>amrestore: 10: skipping yorick._data_mril_mril5_jcampbel.20070630.1
> > >>>amrestore: 11: skipping yorick._data_mril_mril5_vanela.20070630.0
> > >>>amrestore: 12: skipping 
> > >>>yorick._data_mril_mril5_mgriffin_Experimental_data.20070630.1
> > >>>amrestore: 13: skipping yorick._data_mril_mril5_bojana.20070630.1
> > >>>amrestore: 14: skipping yorick._data_ipl_ipl10.20070630.0.0000001
> > >>>amrestore: 15: skipping yorick._data_ipl_ipl10.20070630.0.0000002
> > >>>amrestore: 16: skipping yorick._data_ipl_ipl10.20070630.0.0000003
> > >>>amrestore: could not fsf /hw/tape/tps23d3nrnsv: No space left on device
> > >>>
> > >>>jf
> > >>> 
> > >>>      
> > >
> > >
> > >
> > >  
> 
> -- 
> <° ><

-- 
<° ><

Attachment: amfetchdump.20070705165309.debug
Description: Text document