Re: restore from vtapes written by amvault

Hello,

Am 11.10.20 um 00:50 schrieb Nathan Stratton Treadway:
> So, does the following command work any better?:
>   $ amfetchdump -ostorage=vtape -d vtape be-full svr '^/$' 20000119

great idea, many thanks!

$ amfetchdump -ostorage=vtape -d vtape be-full svr '^/$' 20000119
1 volume(s) needed for restoration
The following volumes are needed: vBE-full-001

Press enter when ready
^C

It even works without "-d vtape":

$ amfetchdump -ostorage=vtape be-full svr '^/$' 20000119
1 volume(s) needed for restoration
The following volumes are needed: vBE-full-001

Press enter when ready


Reading label 'vBE-full-001' filenum 2
FILE: date 20000119 host svr disk / lev 0 comp .gz program /sbin/dump
13312 kb
$ file svr._.20000119.0
svr._.20000119.0: gzip compressed data, from Unix, last modified: Wed
Jan 19 14:10:55 2000, max speed
$ zcat <svr._.20000119.0 | restore tf - | head
Dump   date: Wed Jan 19 14:10:55 2000
Dumped from: the epoch
Level 0 dump of / on james:/dev/hda6
Label: none
         2	.
        11	./lost+found
      2009	./usr
     20081	./usr/local
     22089	./usr/local/squid
      2010	./usr/local/squid/cache

This was using the modified logfile of the amvault run (timestamp
20000119000000 of "svr /" changed to 20000119):

$ diff -u log.20201004123343.0~ log.20201004123343.0
--- log.20201004123343.0~	2020-10-04 18:44:40.294379979 +0200
+++ log.20201004123343.0	2020-10-09 08:33:34.431667034 +0200
@@ -30,7 +30,7 @@
 PART taper "ST:vtape" vBE-full-001 1 svr /var/spool 20000119 1/-1 0
[sec 0.547588 bytes 262144 kps 467.504766]
 DONE taper "ST:vtape" svr /var/spool 20000119000000 1 0 [sec 0.100000
bytes 262144 kps 2560.000000 orig-kb 0]
 PART taper "ST:vtape" vBE-full-001 2 svr / 20000119 1/-1 0 [sec
43.408733 bytes 13631488 kps 306.666403]
-DONE taper "ST:vtape" svr / 20000119000000 1 0 [sec 44.000000 bytes
13631488 kps 302.545455 orig-kb 0]
+DONE taper "ST:vtape" svr / 20000119 1 0 [sec 44.000000 bytes 13631488
kps 302.545455 orig-kb 0]
 PART taper "ST:vtape" vBE-full-001 3 svr /home 20000119 1/-1 0 [sec
36.595257 bytes 23199744 kps 619.096622]
 DONE taper "ST:vtape" svr /home 20000119000000 1 0 [sec 36.000000 bytes
23199744 kps 629.333333 orig-kb 0]
 PART taper "ST:vtape" vBE-full-001 4 ente /var 20000119 1/-1 0 [sec
13.011361 bytes 5636096 kps 423.014933]

Without "patching" the logfile it still cannot locate a dump file:

$ amfetchdump -ostorage=vtape be-full svr '^/$' 20000119
No matching dumps found


Logfile /tmp/amanda/server/be-full/amfetchdump.20201011110913.debug:

So Okt 11 11:09:13.256285270 2020: pid 1453: thd-0x13ba550: amfetchdump:
pid 1453 ruid 33 euid 33 version 3.5.1: start at Sun Oct 11 11:09:13 2020
So Okt 11 11:09:13.256395490 2020: pid 1453: thd-0x13ba550: amfetchdump:
Arguments: -ostorage=vtape be-full svr ^/$ 20000119
So Okt 11 11:09:13.257427585 2020: pid 1453: thd-0x13ba550: amfetchdump:
config_overrides: storage vtape
So Okt 11 11:09:13.257590528 2020: pid 1453: thd-0x13ba550: amfetchdump:
reading config file /var/lib/amanda/be-full/amanda.conf
So Okt 11 11:09:13.257896416 2020: pid 1453: thd-0x13ba550: amfetchdump:
reading config file /var/lib/amanda/amanda.conf.main
So Okt 11 11:09:13.266738788 2020: pid 1453: thd-0x13ba550: amfetchdump:
pid 1453 ruid 33 euid 33 version 3.5.1: rename at Sun Oct 11 11:09:13 2020
So Okt 11 11:09:13.271080507 2020: pid 1453: thd-0x13ba550: amfetchdump:
beginning trace log: /var/lib/amanda/be-full/log/log.20201011110913.0
So Okt 11 11:09:13.288030002 2020: pid 1453: thd-0x13ba550: amfetchdump:
chg-disk: Dir /var/lib/vtape/be-full
So Okt 11 11:09:13.288070143 2020: pid 1453: thd-0x13ba550: amfetchdump:
chg-disk: Using statefile '/var/lib/vtape/be-full/state'
So Okt 11 11:09:13.502641255 2020: pid 1453: thd-0x13ba550: amfetchdump:
/opt/amanda/lib/amanda/perl/Amanda/Restore.pm:1303:success:4900002 1
volume(s) needed for restoration
The following volumes are needed: vBE-full-001

So Okt 11 11:09:18.200178280 2020: pid 1453: thd-0x13ba550: amfetchdump:
Amanda::Recovery::Clerk: loading volume 'vBE-full-001'
So Okt 11 11:09:18.200421179 2020: pid 1453: thd-0x13ba550: amfetchdump:
find_volume labeled 'vBE-full-001'
So Okt 11 11:09:18.305984332 2020: pid 1453: thd-0x13ba550: amfetchdump:
parse_inventory: load slot 1 with label 'vBE-full-001'
So Okt 11 11:09:18.306181903 2020: pid 1453: thd-0x13ba550: amfetchdump:
/opt/amanda/lib/amanda/perl/Amanda/Recovery/Scan.pm:307:info:1200000 slot 1
So Okt 11 11:09:18.310501307 2020: pid 1453: thd-0x13ba550: amfetchdump:
dir_name: /var/lib/vtape/be-full/slot1/
So Okt 11 11:09:18.841018739 2020: pid 1453: thd-0x13ba550: amfetchdump:
/opt/amanda/lib/amanda/perl/Amanda/Recovery/Scan.pm:459:info:1200001
vBE-full-001
So Okt 11 11:09:18.880881693 2020: pid 1453: thd-0x13ba550: amfetchdump:
Amanda::Recovery::Clerk: successfully located first part for recovery
So Okt 11 11:09:18.898383395 2020: pid 1453: thd-0x13ba550: amfetchdump:
Building type FILE header of 128-32768 bytes with name='svr' disk='/'
dumplevel=0 and blocksize=0
So Okt 11 11:09:18.898960106 2020: pid 1453: thd-0x13ba550: amfetchdump:
Starting <Xfer@0x2875670 (<XferSourceRecovery@0x2838000> ->
<XferDestFd@0x28bf820>)>
So Okt 11 11:09:18.898993261 2020: pid 1453: thd-0x13ba550: amfetchdump:
Final linkage: <XferSourceRecovery@0x2838000> -(PULL_BUFFER)->
<XferElementGlue@0x28c0030> -(WRITEFD)-> <XferDestFd@0x28bf820>
So Okt 11 11:09:18.899008369 2020: pid 1453: thd-0x13ba550: amfetchdump:
setup_impl: 3, 2
So Okt 11 11:09:18.899104583 2020: pid 1453: thd-0x13ba550: amfetchdump:
xfer_queue_message: MSG: <XMsg@0x280d080 type=XMSG_READY
elt=<XferSourceRecovery@0x2838000> version=0>
So Okt 11 11:09:18.899163214 2020: pid 1453: thd-0x13ba550: amfetchdump:
Amanda::Recovery::Clerk: starting recovery
So Okt 11 11:09:18.899179840 2020: pid 1453: thd-0x2886b70: amfetchdump:
pull_and_write
So Okt 11 11:09:18.900882824 2020: pid 1453: thd-0x13ba550: amfetchdump:
/opt/amanda/lib/amanda/perl/Amanda/FetchDump.pm:165:info:3300003 Reading
label 'vBE-full-001' filenum 2
FILE: date 20000119 host svr disk / lev 0 comp .gz program /sbin/dump
So Okt 11 11:09:18.901234409 2020: pid 1453: thd-0x13ba550: amfetchdump:
Amanda::Recovery::Clerk: reading file 2 on 'vBE-full-001'
So Okt 11 11:09:19.036676900 2020: pid 1453: thd-0x2886b70: amfetchdump:
Device file:/var/lib/vtape/be-full/slot1 error = 'EOF'
So Okt 11 11:09:19.036718143 2020: pid 1453: thd-0x2886b70: amfetchdump:
xfer_queue_message: MSG: <XMsg@0x7f6aa0000950 type=XMSG_CRC
elt=<XferSourceRecovery@0x2838000> version=0>
So Okt 11 11:09:19.036764427 2020: pid 1453: thd-0x2886b70: amfetchdump:
xfer_queue_message: MSG: <XMsg@0x7f6aa0001230 type=XMSG_PART_DONE
elt=<XferSourceRecovery@0x2838000> version=0>
So Okt 11 11:09:19.037318386 2020: pid 1453: thd-0x13ba550: amfetchdump:
source_crc: 54b643b1:13631488
So Okt 11 11:09:19.037422653 2020: pid 1453: thd-0x13ba550: amfetchdump:
Amanda::Recovery::Clerk: done reading file 2 on 'vBE-full-001'
So Okt 11 11:09:19.037842519 2020: pid 1453: thd-0x2886b70: amfetchdump:
sending XMSG_CRC message 0x28bf820
So Okt 11 11:09:19.037891165 2020: pid 1453: thd-0x2886b70: amfetchdump:
pull_and_write CRC: 54b643b1      size 13631488
So Okt 11 11:09:19.037905382 2020: pid 1453: thd-0x2886b70: amfetchdump:
xfer_queue_message: MSG: <XMsg@0x7f6aa0001230 type=XMSG_CRC
elt=<XferDestFd@0x28bf820> version=0>
So Okt 11 11:09:19.037948843 2020: pid 1453: thd-0x2886b70: amfetchdump:
xfer_queue_message: MSG: <XMsg@0x7f6aa0001350 type=XMSG_DONE
elt=<XferElementGlue@0x28c0030> version=0>
So Okt 11 11:09:19.038328991 2020: pid 1453: thd-0x13ba550: amfetchdump:
dest_crc: 54b643b1:13631488
So Okt 11 11:09:19.038662664 2020: pid 1453: thd-0x13ba550: amfetchdump:
/opt/amanda/lib/amanda/perl/Amanda/Restore.pm:1913:info:4900012 13312 kb
So Okt 11 11:09:19.045728617 2020: pid 1453: thd-0x13ba550: amfetchdump:
ru_utime   : 0
So Okt 11 11:09:19.045764790 2020: pid 1453: thd-0x13ba550: amfetchdump:
ru_stime   : 0
So Okt 11 11:09:19.045770951 2020: pid 1453: thd-0x13ba550: amfetchdump:
ru_maxrss  : 29596
So Okt 11 11:09:19.045776603 2020: pid 1453: thd-0x13ba550: amfetchdump:
ru_ixrss   : 0
So Okt 11 11:09:19.045782046 2020: pid 1453: thd-0x13ba550: amfetchdump:
ru_idrss   : 0
So Okt 11 11:09:19.045787304 2020: pid 1453: thd-0x13ba550: amfetchdump:
ru_isrss   : 0
So Okt 11 11:09:19.045792361 2020: pid 1453: thd-0x13ba550: amfetchdump:
ru_minflt  : 7906
So Okt 11 11:09:19.045797472 2020: pid 1453: thd-0x13ba550: amfetchdump:
ru_majflt  : 1
So Okt 11 11:09:19.045802565 2020: pid 1453: thd-0x13ba550: amfetchdump:
ru_nswap   : 0
So Okt 11 11:09:19.045807644 2020: pid 1453: thd-0x13ba550: amfetchdump:
ru_inblock : 26929
So Okt 11 11:09:19.045812727 2020: pid 1453: thd-0x13ba550: amfetchdump:
ru_oublock : 26696
So Okt 11 11:09:19.045817778 2020: pid 1453: thd-0x13ba550: amfetchdump:
ru_msgsnd  : 0
So Okt 11 11:09:19.045822739 2020: pid 1453: thd-0x13ba550: amfetchdump:
ru_msgrcv  : 0
So Okt 11 11:09:19.045827694 2020: pid 1453: thd-0x13ba550: amfetchdump:
ru_nsignals: 0
So Okt 11 11:09:19.045832775 2020: pid 1453: thd-0x13ba550: amfetchdump:
ru_nvcsw   : 646
So Okt 11 11:09:19.045837966 2020: pid 1453: thd-0x13ba550: amfetchdump:
ru_nivcsw  : 458
So Okt 11 11:09:19.052730514 2020: pid 1453: thd-0x13ba550: amfetchdump:
pid 1453 finish time Sun Oct 11 11:09:19 2020