PDA

View Full Version : amrecover Could not read tapelist



vpatton
June 30th, 2010, 12:08 PM
AMRECOVER Version 3.1.1. Contacting server on localhost ...
220 cvstore AMANDA index server (3.1.1) ready.
Setting restore date to today (2010-06-30)
200 Working date set to 2010-06-30.
501 Could not read tapelist file /etc/amanda/DailySet1/tapelist!

amcheck and the backup ran just fine

here's the amrecover debug
Wed Jun 30 15:02:20 2010: amrecover: pid 24568 ruid 0 euid 0 version 3.1.1: start at Wed Jun 30 15:02:20 2010
Wed Jun 30 15:02:20 2010: amrecover: pid 24568 ruid 0 euid 0 version 3.1.1: rename at Wed Jun 30 15:02:20 2010
Wed Jun 30 15:02:20 2010: amrecover: security_getdriver(name=bsdtcp) returns 0xb7e871e0
Wed Jun 30 15:02:20 2010: amrecover: security_handleinit(handle=0x806b500, driver=0xb7e871e0 (BSDTCP))
Wed Jun 30 15:02:20 2010: amrecover: security_streaminit(stream=0x806b5d0, driver=0xb7e871e0 (BSDTCP))
Wed Jun 30 15:02:20 2010: amrecover: make_socket opening socket with family 2
Wed Jun 30 15:02:20 2010: amrecover: connect_port: Try port 700: available - Success
Wed Jun 30 15:02:20 2010: amrecover: connected to 127.0.0.1.10080
Wed Jun 30 15:02:20 2010: amrecover: our side is 0.0.0.0.700
Wed Jun 30 15:02:20 2010: amrecover: try_socksize: send buffer size is 65536
Wed Jun 30 15:02:20 2010: amrecover: try_socksize: receive buffer size is 65536
Wed Jun 30 15:02:20 2010: amrecover: tcpm_send_token: data is still flowing
Wed Jun 30 15:02:20 2010: amrecover: security_streaminit(stream=0x80751b0, driver=0xb7e871e0 (BSDTCP))
Wed Jun 30 15:02:20 2010: amrecover: security_close(handle=0x806b500, driver=0xb7e871e0 (BSDTCP))
Wed Jun 30 15:02:20 2010: amrecover: security_stream_close(0x806b5d0)
Wed Jun 30 15:02:20 2010: amrecover: sending: FEATURES ffffffff9efefbffffffffff01^M


Wed Jun 30 15:02:20 2010: amrecover: sending: DATE 2010-06-30^M


Wed Jun 30 15:02:20 2010: amrecover: sending: SCNF DailySet1^M


Wed Jun 30 15:02:25 2010: amrecover: user command: 'listdisk'
Wed Jun 30 15:02:25 2010: amrecover: sending: LISTDISK^M


Wed Jun 30 15:02:35 2010: amrecover: user command: 'host hostl.thishost.com'
Wed Jun 30 15:02:40 2010: amrecover: user command: 'sethost host.thishost.com'
Wed Jun 30 15:02:40 2010: amrecover: sending: HOST host.thishost.com^M


Wed Jun 30 15:02:40 2010: amrecover: tcpm_send_token: data is still flowing
Wed Jun 30 15:02:54 2010: amrecover: user command: 'listdisk'
Wed Jun 30 15:02:54 2010: amrecover: sending: LISTDISK^M


Wed Jun 30 15:02:54 2010: amrecover: tcpm_send_token: data is still flowing
Wed Jun 30 15:06:03 2010: amrecover: user command: 'exit'
Wed Jun 30 15:06:03 2010: amrecover: sending: QUIT^M


Wed Jun 30 15:06:03 2010: amrecover: tcpm_send_token: data is still flowing
Wed Jun 30 15:06:03 2010: amrecover: security_stream_close(0x80751b0)
Wed Jun 30 15:06:03 2010: amrecover: pid 24568 finish time Wed Jun 30 15:06:03 2010


Thanks

martineau
June 30th, 2010, 12:37 PM
What's in the amindexd debug file?
What's in the /etc/amanda/DailySet1/tapelist file

vpatton
June 30th, 2010, 12:48 PM
amindexd
Wed Jun 30 16:06:22 2010: amindexd: pid 26657 ruid 1010 euid 1010 version 3.1.1: start at Wed Jun 30 16:06:22 2010
Wed Jun 30 16:06:22 2010: amindexd: version 3.1.1
Wed Jun 30 16:06:22 2010: amindexd: < 220 cvstore AMANDA index server (3.1.1) ready.
Wed Jun 30 16:06:22 2010: amindexd: > FEATURES ffffffff9efefbffffffffff01
Wed Jun 30 16:06:22 2010: amindexd: < 200 FEATURES ffffffff9efefbffffffffff01
Wed Jun 30 16:06:22 2010: amindexd: > DATE 2010-06-30
Wed Jun 30 16:06:22 2010: amindexd: < 200 Working date set to 2010-06-30.
Wed Jun 30 16:06:22 2010: amindexd: > SCNF DailySet1
Wed Jun 30 16:06:22 2010: amindexd: NOTE: running as 'amandabackup', which is the client user, not the dumpuser ('root'); forging on anyway
Wed Jun 30 16:06:22 2010: amindexd: pid 26657 ruid 1010 euid 1010 version 3.1.1: rename at Wed Jun 30 16:06:22 2010
Wed Jun 30 16:06:22 2010: amindexd: < 200 Config set to DailySet1.
Wed Jun 30 16:06:22 2010: amindexd: > HOST cvstore
Wed Jun 30 16:06:22 2010: amindexd: < 501 Host cvstore is not in your disklist.
Wed Jun 30 16:06:22 2010: amindexd: > HOST cvstore.internal.care-view.com
Wed Jun 30 16:06:22 2010: amindexd: < 501 Host cvstore.internal.care-view.com is not in your disklist.
Wed Jun 30 16:06:22 2010: amindexd: > HOST cvstore
Wed Jun 30 16:06:22 2010: amindexd: < 501 Host cvstore is not in your disklist.
Wed Jun 30 16:06:22 2010: amindexd: > HOST xplanner
Wed Jun 30 16:06:22 2010: amindexd: < 501 Host xplanner is not in your disklist.
Wed Jun 30 16:06:22 2010: amindexd: > HOST cvstore.internal.care-view.com
Wed Jun 30 16:06:22 2010: amindexd: < 501 Host cvstore.internal.care-view.com is not in your disklist.
Wed Jun 30 16:06:57 2010: amindexd: > HOST central.care-view.com
Wed Jun 30 16:06:57 2010: amindexd: < 200 Dump host set to central.care-view.com.
Wed Jun 30 16:07:20 2010: amindexd: > LISTDISK
Wed Jun 30 16:07:20 2010: amindexd: < 200- List of disk for host central.care-view.com
Wed Jun 30 16:07:20 2010: amindexd: < 200 List of disk for host central.care-view.com
Wed Jun 30 16:07:31 2010: amindexd: > DISK /mysqlbak
Wed Jun 30 16:07:31 2010: amindexd: append_to_tapelist(tapelist=(nil), label='DailySet1-25', file=1, partnum=1, isafile=0)
Wed Jun 30 16:07:31 2010: amindexd: - 2010-06-30-13-43-28 0 DailySet1-25 1 1 1
Wed Jun 30 16:07:31 2010: amindexd: < 200 Disk set to /mysqlbak.
Wed Jun 30 16:07:31 2010: amindexd: > OISD /
Wed Jun 30 16:07:31 2010: amindexd: Spawning "/bin/gzip /bin/gzip -dc /etc/amanda/DailySet1/index/central.care-view.com/_mysqlbak/20100630134328_0.gz" in pipeline
Wed Jun 30 16:07:31 2010: amindexd: Spawning "/usr/bin/sort /usr/bin/sort" in pipeline
Wed Jun 30 16:07:31 2010: amindexd: f /etc/amanda/DailySet1/index/central.care-view.com/_mysqlbak/20100630134328_0
Wed Jun 30 16:07:31 2010: amindexd: < 200 "/" is a valid directory
Wed Jun 30 16:07:31 2010: amindexd: > OLSD /
Wed Jun 30 16:07:31 2010: amindexd: < 200- Opaque list of /
Wed Jun 30 16:07:31 2010: amindexd: < 200 Opaque list of /
Wed Jun 30 16:07:31 2010: amindexd: > DLE
Wed Jun 30 16:07:31 2010: amindexd: < 200 "<dle>\n <program>GNUTAR</program>\n <disk>/mysqlbak</disk>\n <auth>bsd</auth>\n <compress>FAST</compress>\n <record>YES</record>\n <index>YES</index
Wed Jun 30 16:08:21 2010: amindexd: > TAPE
Wed Jun 30 16:08:21 2010: amindexd: tapedev_is amrecover_changer: changer
Wed Jun 30 16:08:21 2010: amindexd: < 200 changer


But I make sure to run as root or I do a su is there a file I have to change to tell amanda to run as root?

and here is the

20100630134328 DailySet1-25 reuse
0 DailySet1-24 reuse
0 DailySet1-23 reuse
0 DailySet1-22 reuse
0 DailySet1-21 reuse
0 DailySet1-20 reuse
0 DailySet1-19 reuse
0 DailySet1-18 reuse
0 DailySet1-17 reuse
0 DailySet1-16 reuse
0 DailySet1-15 reuse
0 DailySet1-14 reuse
0 DailySet1-13 reuse
0 DailySet1-12 reuse
0 DailySet1-11 reuse
0 DailySet1-10 reuse
0 DailySet1-9 reuse
0 DailySet1-8 reuse
0 DailySet1-7 reuse
0 DailySet1-6 reuse
0 DailySet1-5 reuse
0 DailySet1-4 reuse
0 DailySet1-3 reuse
0 DailySet1-2 reuse
0 DailySet1-1 reuse

martineau
June 30th, 2010, 01:36 PM
Configuring the server to be run as root is bad, Why do you want amanda to be run as root?
If so, then amandad on the server must be configure to be run as root too.

A better solution is to change the dumpuser in amanda.conf to amandabackup and run all amanda command (except amrecover) from the amandabackup user.

vpatton
July 2nd, 2010, 05:29 AM
Ok, I changed it to amandabackup, I'll see what happens after a couple of backup jobs, thank you