Hello,
I have a problem with amrecover:
amrecover> add cpio.ry
Added file /cpio.ry
amrecover> list
TAPE Set1-2011-18:1;Set1K-2011-13:15,16;Set1K-2011-14:1,2,3,4,5,6,7,8,9,10
LEVEL
0 DATE 2012-01-01-03-08-50
/cpio.ry
amrecover> extract
Extracting files using tape drive changer on host uxrs74.
The following tapes are needed: Set1-2011-18 Set1K-2011-13 Set1K-2011-14
Extracting files using tape drive changer on host uxrs74.
Load tape Set1-2011-18 now
Continue [?/Y/n/s/d]? y
Specified file list matches multiple dumps; cannot continue recovery
Got no header and data from server, check in amidxtaped.*.debug and
amandad.*.debug files on server
amrecover>
Set1-2011-18 is the original tape, the DLE dump resides on this tape
only. Set1K-2011-13 and Set1K-2011-14 are the copies made with
amvault. I had to enable splitting in order to use amvault, so the
dump is split in several 40G-sized parts. And some of these parts are
on one tape and the other on the next tape.
I didn't split in fixed-size parts before, so this might be a cause of
the problem too.
The original tapes were written by Amanda 3.2.3, the vaulting happened
with Amanda 3.3.0. And amrecover is now from Amanda 3.3.1.
Log file amindexd.20120509160105.debug:
Wed May 9 16:01:05 2012: thd-0x8056e00: amindexd: pid 32483 ruid 34 euid 34
version 3.3.1: start at Wed May 9 16:01:05 2012
Wed May 9 16:01:05 2012: thd-0x8056e00: amindexd: version 3.3.1
Wed May 9 16:01:05 2012: thd-0x8056e00: amindexd: < 220 uxrs74 AMANDA index
server (3.3.1) ready.
Wed May 9 16:01:05 2012: thd-0x8056e00: amindexd: > FEATURES
ffffffff9efefbffffffffff1f
Wed May 9 16:01:05 2012: thd-0x8056e00: amindexd: < 200 FEATURES
ffffffff9efefbffffffffff1f
Wed May 9 16:01:05 2012: thd-0x8056e00: amindexd: > DATE 2012-05-09
Wed May 9 16:01:05 2012: thd-0x8056e00: amindexd: < 200 Working date set to
2012-05-09.
Wed May 9 16:01:05 2012: thd-0x8056e00: amindexd: > SCNF MonthlySet1
Wed May 9 16:01:05 2012: thd-0x8056e00: amindexd: pid 32483 ruid 34 euid 34
version 3.3.1: rename at Wed May 9 16:01:05 2012
Wed May 9 16:01:06 2012: thd-0x8056e00: amindexd: < 200 Config set to
MonthlySet1.
Wed May 9 16:01:06 2012: thd-0x8056e00: amindexd: > HOST uxrs74
Wed May 9 16:01:06 2012: thd-0x8056e00: amindexd: < 200 Dump host set to
uxrs74.
Wed May 9 16:01:12 2012: thd-0x8056e00: amindexd: > DATE 2012-01-07
Wed May 9 16:01:12 2012: thd-0x8056e00: amindexd: < 200 Working date set to
2012-01-07.
Wed May 9 16:01:15 2012: thd-0x8056e00: amindexd: > HOST fileserver
Wed May 9 16:01:15 2012: thd-0x8056e00: amindexd: < 200 Dump host set to
fileserver.
Wed May 9 16:01:17 2012: thd-0x8056e00: amindexd: > LISTDISK
Wed May 9 16:01:17 2012: thd-0x8056e00: amindexd: < 200- List of disk for
host fileserver
Wed May 9 16:01:17 2012: thd-0x8056e00: amindexd: < 200 List of disk for
host fileserver
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: > DISK /data
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: no recovery limit found;
allowing access
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd:
append_to_tapelist(tapelist=(nil), label='Set1-Apr-17', file=1, partnum=1,
isafile=0)
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: - 2012-05-06-03-09-16 0
Set1-Apr-17 1 1 1
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd:
append_to_tapelist(tapelist=(nil), label='Set1-Mar-15', file=4, partnum=1,
isafile=0)
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: - 2012-04-01-03-09-20 0
Set1-Mar-15 4 1 2
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd:
append_to_tapelist(tapelist=0x8055570, label='Set1-Mar-16', file=1, partnum=2,
isafile=0)
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: - 2012-04-01-03-09-20 0
Set1-Mar-16 1 2 2
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd:
append_to_tapelist(tapelist=(nil), label='Set1-Feb-16', file=2, partnum=1,
isafile=0)
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: - 2012-03-11-03-09-18 0
Set1-Feb-16 2 1 1
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd:
append_to_tapelist(tapelist=(nil), label='Set1-Jan-13', file=5, partnum=1,
isafile=0)
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: - 2012-02-05-03-09-17 0
Set1-Jan-13 5 1 2
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd:
append_to_tapelist(tapelist=0x82bfbc0, label='Set1-Jan-14', file=1, partnum=2,
isafile=0)
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: - 2012-02-05-03-09-17 0
Set1-Jan-14 1 2 2
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd:
append_to_tapelist(tapelist=(nil), label='Set1-2011-18', file=1, partnum=1,
isafile=0)
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: - 2012-01-01-03-08-50 0
Set1-2011-18 1 1 1
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd:
append_to_tapelist(tapelist=0x82d6e40, label='Set1K-2011-13', file=15,
partnum=2, isafile=0)
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: - 2012-01-01-03-08-50 0
Set1K-2011-13 15 2 13
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd:
append_to_tapelist(tapelist=0x82d6e40, label='Set1K-2011-13', file=16,
partnum=3, isafile=0)
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: - 2012-01-01-03-08-50 0
Set1K-2011-13 16 3 13
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd:
append_to_tapelist(tapelist=0x82d6e40, label='Set1K-2011-14', file=1,
partnum=4, isafile=0)
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: - 2012-01-01-03-08-50 0
Set1K-2011-14 1 4 13
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd:
append_to_tapelist(tapelist=0x82d6e40, label='Set1K-2011-14', file=2,
partnum=5, isafile=0)
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: - 2012-01-01-03-08-50 0
Set1K-2011-14 2 5 13
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd:
append_to_tapelist(tapelist=0x82d6e40, label='Set1K-2011-14', file=3,
partnum=6, isafile=0)
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: - 2012-01-01-03-08-50 0
Set1K-2011-14 3 6 13
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd:
append_to_tapelist(tapelist=0x82d6e40, label='Set1K-2011-14', file=4,
partnum=7, isafile=0)
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: - 2012-01-01-03-08-50 0
Set1K-2011-14 4 7 13
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd:
append_to_tapelist(tapelist=0x82d6e40, label='Set1K-2011-14', file=5,
partnum=8, isafile=0)
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: - 2012-01-01-03-08-50 0
Set1K-2011-14 5 8 13
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd:
append_to_tapelist(tapelist=0x82d6e40, label='Set1K-2011-14', file=6,
partnum=9, isafile=0)
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: - 2012-01-01-03-08-50 0
Set1K-2011-14 6 9 13
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd:
append_to_tapelist(tapelist=0x82d6e40, label='Set1K-2011-14', file=7,
partnum=10, isafile=0)
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: - 2012-01-01-03-08-50 0
Set1K-2011-14 7 10 13
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd:
append_to_tapelist(tapelist=0x82d6e40, label='Set1K-2011-14', file=8,
partnum=11, isafile=0)
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: - 2012-01-01-03-08-50 0
Set1K-2011-14 8 11 13
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd:
append_to_tapelist(tapelist=0x82d6e40, label='Set1K-2011-14', file=9,
partnum=12, isafile=0)
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: - 2012-01-01-03-08-50 0
Set1K-2011-14 9 12 13
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd:
append_to_tapelist(tapelist=0x82d6e40, label='Set1K-2011-14', file=10,
partnum=13, isafile=0)
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: - 2012-01-01-03-08-50 0
Set1K-2011-14 10 13 13
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd:
append_to_tapelist(tapelist=(nil), label='Set1-Nov-12', file=3, partnum=1,
isafile=0)
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: - 2011-12-04-03-09-17 0
Set1-Nov-12 3 1 2
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd:
append_to_tapelist(tapelist=0x82ca6e0, label='Set1-Nov-13', file=1, partnum=2,
isafile=0)
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: - 2011-12-04-03-09-17 0
Set1-Nov-13 1 2 2
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd:
append_to_tapelist(tapelist=(nil), label='Set1-Oct-09', file=2, partnum=1,
isafile=0)
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: - 2011-11-06-03-09-13 0
Set1-Oct-09 2 1 2
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd:
append_to_tapelist(tapelist=0x805bfa8, label='Set1-Oct-10', file=1, partnum=2,
isafile=0)
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: - 2011-11-06-03-09-13 0
Set1-Oct-10 1 2 2
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd:
append_to_tapelist(tapelist=(nil), label='Set1-Sep-09', file=1, partnum=1,
isafile=0)
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: - 2011-10-02-03-07-58 0
Set1-Sep-09 1 1 1
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd:
append_to_tapelist(tapelist=(nil), label='Set1-Aug-17', file=1, partnum=1,
isafile=0)
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: - 2011-09-07-15-13-30 0
Set1-Aug-17 1 1 1
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd:
append_to_tapelist(tapelist=(nil), label='Set1-Aug-07', file=2, partnum=1,
isafile=0)
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: - 2011-09-04-03-08-42 0
Set1-Aug-07 2 1 1
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd:
append_to_tapelist(tapelist=(nil), label='Set1-Jul-06', file=3, partnum=1,
isafile=0)
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: - 2011-08-07-03-08-41 0
Set1-Jul-06 3 1 2
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd:
append_to_tapelist(tapelist=0x82b95c8, label='Set1-Jul-07', file=1, partnum=2,
isafile=0)
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: - 2011-08-07-03-08-41 0
Set1-Jul-07 1 2 2
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd:
append_to_tapelist(tapelist=(nil), label='Set1-Jun-07', file=2, partnum=1,
isafile=0)
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: - 2011-07-03-03-09-16 0
Set1-Jun-07 2 1 1
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd:
append_to_tapelist(tapelist=(nil), label='Set1-May-07', file=2, partnum=1,
isafile=0)
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: - 2011-06-05-03-09-17 0
Set1-May-07 2 1 1
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd:
append_to_tapelist(tapelist=(nil), label='Set1-2010-09', file=1, partnum=1,
isafile=0)
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: - 2011-01-02-03-09-16 0
Set1-2010-09 1 1 1
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: < 200 Disk set to /data.
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: > OISD /
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: Spawning "/bin/gzip
/bin/gzip -dc
/var/lib/amanda/MonthlySet1/index/fileserver/_data/20120101030850_0.gz" in
pipeline
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: Spawning "/usr/bin/sort
/usr/bin/sort" in pipeline
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: f
/var/lib/amanda/MonthlySet1/index/fileserver/_data/20120101030850_0
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: < 200 "/" is a valid
directory
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: > OLSD /
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: < 200- Opaque list of /
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: < 200 Opaque list of /
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: > DLE
Wed May 9 16:01:22 2012: thd-0x8056e00: amindexd: < 200 "<dle>\n
<program>GNUTAR</program>\n <disk>/data</disk>\n <auth>bsd</auth>\n
<record>NO</record>\n <index>YES</index>\n
<datapath>AMANDA</datapath>\n</dle>\n"
amidxtaped.20120509160219.debug is quite boring:
Wed May 9 16:02:19 2012: thd-0x88bee00: amidxtaped: pid 32500 ruid 34 euid
34 version 3.3.1: start at Wed May 9 16:02:19 2012
Wed May 9 16:02:19 2012: thd-0x88bee00: amidxtaped: CTL <<
FEATURES=ffffffff9efefbffffffffff1f
Wed May 9 16:02:19 2012: thd-0x88bee00: amidxtaped: CTL << CONFIG=MonthlySet1
Wed May 9 16:02:20 2012: thd-0x88bee00: amidxtaped: CTL <<
LABEL=Set1-2011-18:1;Set1K-2011-13:15,16;Set1K-2011-14:1,2,3,4,5,6,7,8,9,10
Wed May 9 16:02:20 2012: thd-0x88bee00: amidxtaped: CTL << FSF=1
Wed May 9 16:02:20 2012: thd-0x88bee00: amidxtaped: CTL << HEADER
Wed May 9 16:02:20 2012: thd-0x88bee00: amidxtaped: CTL << DEVICE=changer
Wed May 9 16:02:20 2012: thd-0x88bee00: amidxtaped: CTL << HOST=^fileserver$
Wed May 9 16:02:20 2012: thd-0x88bee00: amidxtaped: CTL << DISK=^/data$
Wed May 9 16:02:20 2012: thd-0x88bee00: amidxtaped: CTL <<
DATESTAMP=20120101030850
Wed May 9 16:02:20 2012: thd-0x88bee00: amidxtaped: CTL << END
Wed May 9 16:02:20 2012: thd-0x88bee00: amidxtaped: pid 32500 ruid 34 euid
34 version 3.3.1: rename at Wed May 9 16:02:20 2012
Wed May 9 16:02:20 2012: thd-0x88bee00: amidxtaped: chg-robot: using
statefile '/var/lib/amanda/chg-robot-dev-i500-changer'
Warning: no log files found for tape ...
... more such warnings ...
Wed May 9 16:02:31 2012: thd-0x88bee00: amidxtaped: CTL >> MESSAGE Specified
file list matches multiple dumps; cannot continue recovery
Wed May 9 16:02:31 2012: thd-0x88bee00: amidxtaped: exiting with 0
Wed May 9 16:02:31 2012: thd-0x88bee00: amidxtaped: pid 32500 finish time
Wed May 9 16:02:31 2012
Internet search pointed me to this:
<http://archives.zmanda.com/amanda-archives/viewtopic.php?t=6270&sid=00e0bd4b4a37001ee0e475b5e5da4fd3>
But the patch shown there should already be in 3.3.x? (And the github
link to the last patch shown there doesn't work (anymore).)
Any ideas? Or should I provide more info?
Thanks,
Sven
