Hi Jean-Louis,
> It's a bug that can only be seen with the bsd auth.
> Attached patch fix it, can you try it?
thanks for the patch. I applied it to the client and server (both 3.2.0) and
tried a restore a file without umlauts on the client:
...
Continue [?/Y/n]? y
amrecover: bad header
Extractor child exited with status 1
I attached all logfiles that were created for that try (2 from the server, 1
from the client)
Am 22.10.2010 18:06, schrieb Jean-Louis Martineau:
> I suspect a bug in the handling of the bsd auth in amrecover.
> Can you try the bsdtcp auth?
> You need to setup an inetd/xinetd entry on the server and run
> amrecover with '-oauth=bsdtcp'
bsdtcp allows recovering files with and without umlauts (without just when
using wildcards as workaround).
Regards,
Marc
Am 22.10.2010 21:47, schrieb Jean-Louis Martineau:
It's a bug that can only be seen with the bsd auth.
Attached patch fix it, can you try it?
Jean-Louis
Jean-Louis Martineau wrote:
Marc Muehlfeld wrote:
/bin/tar: This does not look like a tar archive
/bin/tar: Skipping to next header
/bin/tar: Archive contains obsolescent base-64 headers
/bin/tar: Read 7944 bytes from -
It has nothing to do with umlauts.
I suspect a bug in the handling of the bsd auth in amrecover.
Can you try the bsdtcp auth?
You need to setup an inetd/xinetd entry on the server and run amrecover with
'-oauth=bsdtcp'
Jean-Louis
--
Marc Muehlfeld (IT-Leiter)
Zentrum fuer Humangenetik und Laboratoriumsmedizin Dr. Klein und Dr. Rost
Lochhamer Str. 29 - D-82152 Martinsried
Telefon: +49(0)89/895578-0 - Fax: +49(0)89/895578-78
http://www.medizinische-genetik.de
Sat Oct 23 10:56:23 2010: amidxtaped: pid 1112 ruid 33 euid 33 version 3.2.0:
start at Sat Oct 23 10:56:23 2010
Sat Oct 23 10:56:23 2010: amidxtaped: CTL << FEATURES=ffffffff9efefbffffffffff01
Sat Oct 23 10:56:23 2010: amidxtaped: CTL << CONFIG=TestSet
Sat Oct 23 10:56:23 2010: amidxtaped: CTL << LABEL=TestSet001:1
Sat Oct 23 10:56:23 2010: amidxtaped: CTL << FSF=1
Sat Oct 23 10:56:23 2010: amidxtaped: CTL << HEADER
Sat Oct 23 10:56:23 2010: amidxtaped: CTL << DEVICE=HDD_Test_Changer
Sat Oct 23 10:56:23 2010: amidxtaped: CTL << HOST=^genome.mr.lfmg.de$
Sat Oct 23 10:56:23 2010: amidxtaped: CTL << DISK=^/BACKUP$
Sat Oct 23 10:56:23 2010: amidxtaped: CTL << DATESTAMP=20101022165751
Sat Oct 23 10:56:23 2010: amidxtaped: CTL << END
Sat Oct 23 10:56:23 2010: amidxtaped: pid 1112 ruid 33 euid 33 version 3.2.0:
rename at Sat Oct 23 10:56:23 2010
Sat Oct 23 10:56:23 2010: amidxtaped: find_volume labeled 'TestSet001'
Sat Oct 23 10:56:23 2010: amidxtaped: parse_inventory: load slot 1 with label
'TestSet001'
Sat Oct 23 10:56:23 2010: amidxtaped: ignoring spurious Amanda::Recovery::Scan
abort call
Sat Oct 23 10:56:23 2010: amidxtaped: recovering from split dumpfile: date
20101022165751 host genome.mr.lfmg.de disk /BACKUP part 1/UNKNOWN lev 1 comp
.gz program APPLICATION
Sat Oct 23 10:56:23 2010: amidxtaped: ..with decompression applied
Sat Oct 23 10:56:23 2010: amidxtaped: Building type FILE header of 32768-32768
bytes with name='genome.mr.lfmg.de' disk='/BACKUP' dumplevel=1 and blocksize=0
Sat Oct 23 10:56:25 2010: amidxtaped: CTL << AVAIL-DATAPATH AMANDA
Sat Oct 23 10:56:25 2010: amidxtaped: CTL >> USE-DATAPATH AMANDA
Sat Oct 23 10:56:25 2010: amidxtaped: CTL << DATAPATH-OK
Sat Oct 23 10:56:25 2010: amidxtaped: Starting <x...@0x1fac9d30
(<xfersourcerecov...@0x1faee830> -> <xferfilterproc...@0x1faef050> ->
<xferdes...@0x1faec800>)>
Sat Oct 23 10:56:25 2010: amidxtaped: Final linkage:
<xfersourcerecov...@0x1faee830> -(PULL_BUFFER)-> <xferelementg...@0x1fae98f0>
-(READFD)-> <xferfilterproc...@0x1faef050> -(WRITEFD)-> <xferdes...@0x1faec800>
Sat Oct 23 10:56:25 2010: amidxtaped: <xferfilterproc...@0x1faef050> spawning:
'/bin/gzip' '-dc'
Sat Oct 23 10:56:25 2010: amidxtaped: started xfer; datapath=amanda
Sat Oct 23 10:56:25 2010: amidxtaped: Device
file:/amandadisks/TestSet/slots/drive0 error = 'EOF'
Sat Oct 23 10:56:25 2010: amidxtaped: <xferfilterproc...@0x1faef050>: process
exited with status 0
Sat Oct 23 10:56:25 2010: amidxtaped: recovery complete
Sat Oct 23 10:56:25 2010: amidxtaped: exiting with 0
Sat Oct 23 10:56:25 2010: amidxtaped: pid 1112 finish time Sat Oct 23 10:56:25
2010
Sat Oct 23 10:56:08 2010: amindexd: pid 1105 ruid 33 euid 33 version 3.2.0:
start at Sat Oct 23 10:56:08 2010
Sat Oct 23 10:56:08 2010: amindexd: version 3.2.0
Sat Oct 23 10:56:08 2010: amindexd: < 220 nucleus AMANDA index server (3.2.0)
ready.
Sat Oct 23 10:56:08 2010: amindexd: > FEATURES ffffffff9efefbffffffffff01
Sat Oct 23 10:56:08 2010: amindexd: < 200 FEATURES ffffffff9efefbffffffffff01
Sat Oct 23 10:56:08 2010: amindexd: > DATE 2010-10-23
Sat Oct 23 10:56:08 2010: amindexd: < 200 Working date set to 2010-10-23.
Sat Oct 23 10:56:08 2010: amindexd: > SCNF TestSet
Sat Oct 23 10:56:08 2010: amindexd: pid 1105 ruid 33 euid 33 version 3.2.0:
rename at Sat Oct 23 10:56:08 2010
Sat Oct 23 10:56:08 2010: amindexd: < 200 Config set to TestSet.
Sat Oct 23 10:56:08 2010: amindexd: > HOST genome.mr.lfmg.de
Sat Oct 23 10:56:08 2010: amindexd: < 200 Dump host set to genome.mr.lfmg.de.
Sat Oct 23 10:56:18 2010: amindexd: > DISK /BACKUP
Sat Oct 23 10:56:18 2010: amindexd: no recovery limit found; allowing access
Sat Oct 23 10:56:18 2010: amindexd: append_to_tapelist(tapelist=(nil),
label='TestSet001', file=1, partnum=1, isafile=0)
Sat Oct 23 10:56:18 2010: amindexd: - 2010-10-22-16-57-51 1 TestSet001 1 1 1
Sat Oct 23 10:56:18 2010: amindexd: < 200 Disk set to /BACKUP.
Sat Oct 23 10:56:18 2010: amindexd: > OISD /
Sat Oct 23 10:56:18 2010: amindexd: Spawning "/bin/gzip /bin/gzip -dc
/etc/amanda/TestSet/index/genome.mr.lfmg.de/_BACKUP/20101022165751_1.gz" in
pipeline
Sat Oct 23 10:56:18 2010: amindexd: Spawning "/bin/sort /bin/sort" in pipeline
Sat Oct 23 10:56:18 2010: amindexd: f
/etc/amanda/TestSet/index/genome.mr.lfmg.de/_BACKUP/20101022165751_1
Sat Oct 23 10:56:18 2010: amindexd: < 200 "/" is a valid directory
Sat Oct 23 10:56:18 2010: amindexd: > OLSD /
Sat Oct 23 10:56:18 2010: amindexd: < 200- Opaque list of /
Sat Oct 23 10:56:18 2010: amindexd: < 200 Opaque list of /
Sat Oct 23 10:56:18 2010: amindexd: > DLE
Sat Oct 23 10:56:18 2010: amindexd: < 200 "<dle>\n
<program>APPLICATION</program>\n <backup-program>\n
<plugin>amgtar</plugin>\n <property>\n <name>ignore</name>\n
<value encoding=\"raw\"
raw=\"OiBzb2NrZXQgaWdub3JlZCQ=\">:_socket_ignored$</value>\n <value
encoding=\"raw\"
raw=\"OiBEaXJlY3RvcnkgaXMgbmV3JA==\">:_Directory_is_new$</value>\n <value
encoding=\"raw\"
raw=\"OiBEaXJlY3RvcnkgaGFzIGJlZW4gcmVuYW1lZA==\">:_Directory_has_been_renamed</value>\n
<value encoding=\"raw\"
raw=\"ZmlsZSBjaGFuZ2VkIGFzIHdlIHJlYWQgaXQk\">file_changed_as_we_read_it$</value>\n
</property>\n <property>\n <name>sparse</name>\n
<value>YES</value>\n </property>\n <property>\n
<name>check-device</name>\n <value>YES</value>\n </property>\n
<property>\n <name>exit-handling</name>\n <value encoding=\"raw\"
raw=\"MT1HT09EIDI9QkFE\">1=GOOD_2=BAD</value>\n </property>\n
<property>\n <name>atime-preserve</name>\n <value>NO</value>\n
</property>\n <property>\n <name>gnutar-listdir</name>\n
<value>/var/lib/amanda/gnutar-lists/</value>\n </property>\n <property>\n
<name>one-file-system</name>\n <value>YES</value>\n </property>\n
<property>\n <name>gnutar-path</name>\n <value>/bin/tar</value>\n
</property>\n </backup-program>\n <disk>/BACKUP</disk>\n <auth>bsd</auth>\n
<compress>FAST</compress>\n <record>YES</record>\n <index>YES</index>\n
<datapath>AMANDA</datapath>\n <exclude>\n
<list>/etc/amanda/exclude.gtar</list>\n </exclude>\n</dle>\n"
Sat Oct 23 10:56:19 2010: amindexd: > OISD /ldap
Sat Oct 23 10:56:19 2010: amindexd: f
/etc/amanda/TestSet/index/genome.mr.lfmg.de/_BACKUP/20101022165751_1
Sat Oct 23 10:56:19 2010: amindexd: < 200 "/ldap" is a valid directory
Sat Oct 23 10:56:19 2010: amindexd: > OLSD /ldap
Sat Oct 23 10:56:19 2010: amindexd: < 200- Opaque list of /ldap
Sat Oct 23 10:56:19 2010: amindexd: < 200 Opaque list of /ldap
Sat Oct 23 10:56:22 2010: amindexd: > TAPE
Sat Oct 23 10:56:22 2010: amindexd: tapedev_is tpchanger: HDD_Test_Changer
Sat Oct 23 10:56:22 2010: amindexd: < 200 HDD_Test_Changer
Sat Oct 23 10:56:26 2010: amindexd: > QUIT
Sat Oct 23 10:56:26 2010: amindexd: removing index file:
/etc/amanda/TestSet/index/genome.mr.lfmg.de/_BACKUP/20101022165751_1
Sat Oct 23 10:56:26 2010: amindexd: < 200 Good bye.
Sat Oct 23 10:56:26 2010: amindexd: pid 1105 finish time Sat Oct 23 10:56:26
2010
Sat Oct 23 10:56:08 2010: amrecover: pid 4887 ruid 0 euid 0 version 3.2.0:
start at Sat Oct 23 10:56:08 2010
Sat Oct 23 10:56:08 2010: amrecover: config_overrides: conf TestSet
Sat Oct 23 10:56:08 2010: amrecover: config_overrides: index_server nucleus
Sat Oct 23 10:56:08 2010: amrecover: config_overrides: tape_server nucleus
Sat Oct 23 10:56:08 2010: amrecover: pid 4887 ruid 0 euid 0 version 3.2.0:
rename at Sat Oct 23 10:56:08 2010
Sat Oct 23 10:56:08 2010: amrecover: security_getdriver(name=bsd) returns
0x2b4b7ea21380
Sat Oct 23 10:56:08 2010: amrecover: security_handleinit(handle=0x13caac50,
driver=0x2b4b7ea21380 (BSD))
Sat Oct 23 10:56:08 2010: amrecover: dgram_bind: setting up a socket with
family 2
Sat Oct 23 10:56:08 2010: amrecover: bind_portrange2: Skip port 575: Owned by
vemmi.
Sat Oct 23 10:56:08 2010: amrecover: bind_portrange2: Skip port 576: Owned by
ipcd.
Sat Oct 23 10:56:08 2010: amrecover: bind_portrange2: Skip port 577: Owned by
vnas.
Sat Oct 23 10:56:08 2010: amrecover: bind_portrange2: Skip port 578: Owned by
ipdd.
Sat Oct 23 10:56:08 2010: amrecover: bind_portrange2: Skip port 579: Owned by
decbsrv.
Sat Oct 23 10:56:08 2010: amrecover: bind_portrange2: Skip port 580: Owned by
sntp-heartbeat.
Sat Oct 23 10:56:08 2010: amrecover: bind_portrange2: Skip port 581: Owned by
bdp.
Sat Oct 23 10:56:08 2010: amrecover: bind_portrange2: Skip port 582: Owned by
scc-security.
Sat Oct 23 10:56:08 2010: amrecover: bind_portrange2: Skip port 583: Owned by
philips-vc.
Sat Oct 23 10:56:08 2010: amrecover: bind_portrange2: Skip port 584: Owned by
keyserver.
Sat Oct 23 10:56:08 2010: amrecover: bind_portrange2: Skip port 585: Owned by
imap4-ssl.
Sat Oct 23 10:56:08 2010: amrecover: bind_portrange2: Skip port 586: Owned by
password-chg.
Sat Oct 23 10:56:08 2010: amrecover: bind_portrange2: Skip port 587: Owned by
submission.
Sat Oct 23 10:56:08 2010: amrecover: bind_portrange2: Skip port 588: Owned by
cal.
Sat Oct 23 10:56:08 2010: amrecover: bind_portrange2: Skip port 589: Owned by
eyelink.
Sat Oct 23 10:56:08 2010: amrecover: bind_portrange2: Skip port 590: Owned by
tns-cml.
Sat Oct 23 10:56:08 2010: amrecover: bind_portrange2: Try port 591: Available
- Success
Sat Oct 23 10:56:08 2010: amrecover: dgram_bind: socket 3 bound to 0.0.0.0.591
Sat Oct 23 10:56:08 2010: amrecover: dgram_send_addr(addr=0x13caac90,
dgram=0x2b4b7ea2c968)
Sat Oct 23 10:56:08 2010: amrecover: (sockaddr_in *)0x13caac90 = { 2, 10080,
192.168.29.2 }
Sat Oct 23 10:56:08 2010: amrecover: dgram_send_addr: 0x2b4b7ea2c968->socket = 3
Sat Oct 23 10:56:08 2010: amrecover: dgram_recv(dgram=0x2b4b7ea2c968,
timeout=0, fromaddr=0x2b4b7ea3c960)
Sat Oct 23 10:56:08 2010: amrecover: (sockaddr_in *)0x2b4b7ea3c960 = { 2,
10080, 192.168.29.2 }
Sat Oct 23 10:56:08 2010: amrecover: dgram_recv(dgram=0x2b4b7ea2c968,
timeout=0, fromaddr=0x2b4b7ea3c960)
Sat Oct 23 10:56:08 2010: amrecover: (sockaddr_in *)0x2b4b7ea3c960 = { 2,
10080, 192.168.29.2 }
Sat Oct 23 10:56:08 2010: amrecover: dgram_send_addr(addr=0x13caac90,
dgram=0x2b4b7ea2c968)
Sat Oct 23 10:56:08 2010: amrecover: (sockaddr_in *)0x13caac90 = { 2, 10080,
192.168.29.2 }
Sat Oct 23 10:56:08 2010: amrecover: dgram_send_addr: 0x2b4b7ea2c968->socket = 3
Sat Oct 23 10:56:08 2010: amrecover: security_streaminit(stream=0x13cb2280,
driver=0x2b4b7ea21380 (BSD))
Sat Oct 23 10:56:08 2010: amrecover: make_socket opening socket with family 2
Sat Oct 23 10:56:08 2010: amrecover: connect_port: Try port 1024: available -
Success
Sat Oct 23 10:56:08 2010: amrecover: connected to 192.168.29.2.57690
Sat Oct 23 10:56:08 2010: amrecover: our side is 0.0.0.0.1024
Sat Oct 23 10:56:08 2010: amrecover: try_socksize: send buffer size is 65536
Sat Oct 23 10:56:08 2010: amrecover: try_socksize: receive buffer size is 65536
Sat Oct 23 10:56:08 2010: amrecover: security_close(handle=0x13caac50,
driver=0x2b4b7ea21380 (BSD))
Sat Oct 23 10:56:08 2010: amrecover: sending: FEATURES
ffffffff9efefbffffffffff01
Sat Oct 23 10:56:08 2010: amrecover: sending: DATE 2010-10-23
Sat Oct 23 10:56:08 2010: amrecover: sending: SCNF TestSet
Sat Oct 23 10:56:08 2010: amrecover: sending: HOST genome.mr.lfmg.de
Sat Oct 23 10:56:12 2010: amrecover: user command: 'cd ldap'
Sat Oct 23 10:56:18 2010: amrecover: user command: 'setdisk /BACKUP'
Sat Oct 23 10:56:18 2010: amrecover: sending: DISK /BACKUP
Sat Oct 23 10:56:18 2010: amrecover: sending: OISD /
Sat Oct 23 10:56:18 2010: amrecover: sending: OLSD /
Sat Oct 23 10:56:18 2010: amrecover: add_dir_list_item: Adding
"2010-10-22-16-57-51" "1" "TestSet001:1" "1" "/."
Sat Oct 23 10:56:18 2010: amrecover: add_dir_list_item: Adding
"2010-10-22-16-57-51" "1" "TestSet001:1" "1" "/M\303\266gliche Zusatzkosten
f\303\274r QM-Projekt.odt"
Sat Oct 23 10:56:18 2010: amrecover: add_dir_list_item: Adding
"2010-10-22-16-57-51" "1" "TestSet001:1" "1" "/SSL-VPN/"
Sat Oct 23 10:56:18 2010: amrecover: add_dir_list_item: Adding
"2010-10-22-16-57-51" "1" "TestSet001:1" "1" "/hdd-info/"
Sat Oct 23 10:56:18 2010: amrecover: add_dir_list_item: Adding
"2010-10-22-16-57-51" "1" "TestSet001:1" "1" "/ldap/"
Sat Oct 23 10:56:18 2010: amrecover: add_dir_list_item: Adding
"2010-10-22-16-57-51" "1" "TestSet001:1" "1" "/samba/"
Sat Oct 23 10:56:18 2010: amrecover: sending: DLE
Sat Oct 23 10:56:19 2010: amrecover: user command: 'cd ldap'
Sat Oct 23 10:56:19 2010: amrecover: cd_glob (ldap) -> ^ldap$
Sat Oct 23 10:56:19 2010: amrecover: sending: OISD /ldap
Sat Oct 23 10:56:19 2010: amrecover: sending: OLSD /ldap
Sat Oct 23 10:56:19 2010: amrecover: add_dir_list_item: Adding
"2010-10-22-16-57-51" "1" "TestSet001:1" "1" "/ldap/."
Sat Oct 23 10:56:19 2010: amrecover: add_dir_list_item: Adding
"2010-10-22-16-57-51" "1" "TestSet001:1" "1"
"/ldap/ldap-2010-10-22-16-55-01.tar.bz2"
Sat Oct 23 10:56:21 2010: amrecover: user command: 'add *'
Sat Oct 23 10:56:21 2010: amrecover: add_glob (*) -> ^[^/]*$
Sat Oct 23 10:56:21 2010: amrecover: add_file: Looking for "[^/]*[/]*$"
Sat Oct 23 10:56:21 2010: amrecover: add_file: Converted
path="([^/.]|\.[^/]+|[^/.][^/]*)[/]*$" to
path_on_disk="\/ldap/([^/.]|\.[^/]+|[^/.][^/]*)[/]*$"
Sat Oct 23 10:56:21 2010: amrecover: add_file: Pondering
ditem->path=/ldap/ldap-2010-10-22-16-55-01.tar.bz2
Sat Oct 23 10:56:21 2010: amrecover: add_file: (Successful) Added
/ldap/ldap-2010-10-22-16-55-01.tar.bz2
Sat Oct 23 10:56:21 2010: amrecover: add_file: Pondering ditem->path=/ldap/.
Sat Oct 23 10:56:22 2010: amrecover: user command: 'extract'
Sat Oct 23 10:56:22 2010: amrecover: sending: TAPE
Sat Oct 23 10:56:22 2010: amrecover: append_to_tapelist(tapelist=(nil),
label='TestSet001', file=-1, partnum=-1, isafile=0)
Sat Oct 23 10:56:22 2010: amrecover: append_to_tapelist(tapelist=0x13cad6e0,
label='TestSet001', file=1, partnum=-1, isafile=0)
Sat Oct 23 10:56:22 2010: amrecover: append_to_tapelist(tapelist=(nil),
label='TestSet001', file=-1, partnum=-1, isafile=0)
Sat Oct 23 10:56:22 2010: amrecover: append_to_tapelist(tapelist=0x13cad6e0,
label='TestSet001', file=1, partnum=-1, isafile=0)
Sat Oct 23 10:56:22 2010: amrecover: Requesting tape TestSet001 from user
Sat Oct 23 10:56:23 2010: amrecover: User prompt: 'Continue [?/Y/n/s/d]? ';
response: 'y'
Sat Oct 23 10:56:23 2010: amrecover: security_getdriver(name=bsd) returns
0x2b4b7ea21380
Sat Oct 23 10:56:23 2010: amrecover: security_handleinit(handle=0x13caee00,
driver=0x2b4b7ea21380 (BSD))
Sat Oct 23 10:56:23 2010: amrecover: dgram_send_addr(addr=0x13caee40,
dgram=0x2b4b7ea2c968)
Sat Oct 23 10:56:23 2010: amrecover: (sockaddr_in *)0x13caee40 = { 2, 10080,
192.168.29.2 }
Sat Oct 23 10:56:23 2010: amrecover: dgram_send_addr: 0x2b4b7ea2c968->socket = 3
Sat Oct 23 10:56:23 2010: amrecover: dgram_recv(dgram=0x2b4b7ea2c968,
timeout=0, fromaddr=0x2b4b7ea3c960)
Sat Oct 23 10:56:23 2010: amrecover: (sockaddr_in *)0x2b4b7ea3c960 = { 2,
10080, 192.168.29.2 }
Sat Oct 23 10:56:23 2010: amrecover: dgram_recv(dgram=0x2b4b7ea2c968,
timeout=0, fromaddr=0x2b4b7ea3c960)
Sat Oct 23 10:56:23 2010: amrecover: (sockaddr_in *)0x2b4b7ea3c960 = { 2,
10080, 192.168.29.2 }
Sat Oct 23 10:56:23 2010: amrecover: dgram_send_addr(addr=0x13caee40,
dgram=0x2b4b7ea2c968)
Sat Oct 23 10:56:23 2010: amrecover: (sockaddr_in *)0x13caee40 = { 2, 10080,
192.168.29.2 }
Sat Oct 23 10:56:23 2010: amrecover: dgram_send_addr: 0x2b4b7ea2c968->socket = 3
Sat Oct 23 10:56:23 2010: amrecover: security_streaminit(stream=0x13cba2e0,
driver=0x2b4b7ea21380 (BSD))
Sat Oct 23 10:56:23 2010: amrecover: make_socket opening socket with family 2
Sat Oct 23 10:56:23 2010: amrecover: connect_port: Try port 1024: available -
Success
Sat Oct 23 10:56:23 2010: amrecover: connected to 192.168.29.2.57705
Sat Oct 23 10:56:23 2010: amrecover: our side is 0.0.0.0.1024
Sat Oct 23 10:56:23 2010: amrecover: try_socksize: send buffer size is 65536
Sat Oct 23 10:56:23 2010: amrecover: try_socksize: receive buffer size is 65536
Sat Oct 23 10:56:23 2010: amrecover: amidxtaped_streams[0].fd = 0x13cba2e0
Sat Oct 23 10:56:23 2010: amrecover: security_streaminit(stream=0x13cc2340,
driver=0x2b4b7ea21380 (BSD))
Sat Oct 23 10:56:23 2010: amrecover: make_socket opening socket with family 2
Sat Oct 23 10:56:23 2010: amrecover: connect_port: Try port 1024: available -
Success
Sat Oct 23 10:56:23 2010: amrecover: connected to 192.168.29.2.57706
Sat Oct 23 10:56:23 2010: amrecover: our side is 0.0.0.0.1024
Sat Oct 23 10:56:23 2010: amrecover: try_socksize: send buffer size is 65536
Sat Oct 23 10:56:23 2010: amrecover: try_socksize: receive buffer size is 65536
Sat Oct 23 10:56:23 2010: amrecover: amidxtaped_streams[1].fd = 0x13cc2340
Sat Oct 23 10:56:23 2010: amrecover: security_close(handle=0x13caee00,
driver=0x2b4b7ea21380 (BSD))
Sat Oct 23 10:56:23 2010: amrecover: send_to_tape_server:
FEATURES=ffffffff9efefbffffffffff01
Sat Oct 23 10:56:23 2010: amrecover: send_to_tape_server: CONFIG=TestSet
Sat Oct 23 10:56:23 2010: amrecover: send_to_tape_server: LABEL=TestSet001:1
Sat Oct 23 10:56:23 2010: amrecover: send_to_tape_server: FSF=1
Sat Oct 23 10:56:23 2010: amrecover: send_to_tape_server: HEADER
Sat Oct 23 10:56:23 2010: amrecover: send_to_tape_server:
DEVICE=HDD_Test_Changer
Sat Oct 23 10:56:23 2010: amrecover: send_to_tape_server:
HOST=^genome.mr.lfmg.de$
Sat Oct 23 10:56:23 2010: amrecover: send_to_tape_server: DISK=^/BACKUP$
Sat Oct 23 10:56:23 2010: amrecover: send_to_tape_server:
DATESTAMP=20101022165751
Sat Oct 23 10:56:23 2010: amrecover: send_to_tape_server: END
Sat Oct 23 10:56:23 2010: amrecover: Empty amanda header: buflen=2360 lsize=2360
Sat Oct 23 10:56:23 2010: amrecover: strange amanda header: ""
Sat Oct 23 10:56:23 2010: amrecover: Expected: "<Non-empty line>" Actual:
"<null>"
Sat Oct 23 10:56:25 2010: amrecover: User prompt: 'Continue [?/Y/n]? ';
response: 'y'
Sat Oct 23 10:56:25 2010: amrecover: send_to_tape_server: AVAIL-DATAPATH AMANDA
Sat Oct 23 10:56:25 2010: amrecover: get amidxtaped line: USE-DATAPATH AMANDA
Sat Oct 23 10:56:25 2010: amrecover: Using AMANDA data-path
Sat Oct 23 10:56:25 2010: amrecover: Contents of *(dumpfile_t *)0x7fff821182b8:
Sat Oct 23 10:56:25 2010: amrecover: type = -1 (WEIRD)
Sat Oct 23 10:56:25 2010: amrecover: datestamp = ''
Sat Oct 23 10:56:25 2010: amrecover: dumplevel = 0
Sat Oct 23 10:56:25 2010: amrecover: compressed = 0
Sat Oct 23 10:56:25 2010: amrecover: encrypted = 0
Sat Oct 23 10:56:25 2010: amrecover: comp_suffix = ''
Sat Oct 23 10:56:25 2010: amrecover: encrypt_suffix = ''
Sat Oct 23 10:56:25 2010: amrecover: name = ''
Sat Oct 23 10:56:25 2010: amrecover: disk = ''
Sat Oct 23 10:56:25 2010: amrecover: program = ''
Sat Oct 23 10:56:25 2010: amrecover: application = ''
Sat Oct 23 10:56:25 2010: amrecover: srvcompprog = ''
Sat Oct 23 10:56:25 2010: amrecover: clntcompprog = ''
Sat Oct 23 10:56:25 2010: amrecover: srv_encrypt = ''
Sat Oct 23 10:56:25 2010: amrecover: clnt_encrypt = ''
Sat Oct 23 10:56:25 2010: amrecover: recover_cmd = ''
Sat Oct 23 10:56:25 2010: amrecover: uncompress_cmd = ''
Sat Oct 23 10:56:25 2010: amrecover: decrypt_cmd = ''
Sat Oct 23 10:56:25 2010: amrecover: srv_decrypt_opt = ''
Sat Oct 23 10:56:25 2010: amrecover: clnt_decrypt_opt = ''
Sat Oct 23 10:56:25 2010: amrecover: cont_filename = ''
Sat Oct 23 10:56:25 2010: amrecover: dle_str = (null)
Sat Oct 23 10:56:25 2010: amrecover: is_partial = 0
Sat Oct 23 10:56:25 2010: amrecover: partnum = 0
Sat Oct 23 10:56:25 2010: amrecover: totalparts = 0
Sat Oct 23 10:56:25 2010: amrecover: critical (fatal): bad header
/usr/lib/amanda/libamanda-3.2.0.so[0x2b4b7e7e7986]
/lib64/libglib-2.0.so.0(g_logv+0x26f)[0x31f9634d5f]
/lib64/libglib-2.0.so.0(g_log+0x83)[0x31f9634f33]
amrecover[0x408a9a]
amrecover(writer_intermediary+0x144)[0x409604]
amrecover(extract_files+0x737)[0x40a067]
amrecover(yyparse+0x60a)[0x4105da]
amrecover(process_line+0x47)[0x411997]
amrecover(main+0x76a)[0x4064ca]
/lib64/libc.so.6(__libc_start_main+0xf4)[0x31f761d994]
amrecover[0x405129]
Sat Oct 23 10:56:25 2010: amrecover: send_to_tape_server: DATAPATH-OK
Sat Oct 23 10:56:25 2010: amrecover: security_stream_close(0x13cc2340)
Sat Oct 23 10:56:25 2010: amrecover: security_stream_close(0x13cba2e0)
Sat Oct 23 10:56:26 2010: amrecover: user command: 'quit'
Sat Oct 23 10:56:26 2010: amrecover: sending: QUIT
Sat Oct 23 10:56:26 2010: amrecover: security_stream_close(0x13cb2280)
Sat Oct 23 10:56:26 2010: amrecover: pid 4887 finish time Sat Oct 23 10:56:26
2010