Amanda-Users

RE: Amanda 2.6.0 spanning

2008-06-20 06:21:43
Subject: RE: Amanda 2.6.0 spanning
From: "Johan Booysen" <johan AT matrix-data.co DOT uk>
To: <amanda-users AT amanda DOT org>
Date: Fri, 20 Jun 2008 11:15:19 +0100
Just tried manually loading the tape to the next slot again, with
amtape, and this is recorded in the log amtape.20080620111119.debug:

-sh-3.2$ cat amtape.20080620111119.debug
1213956679.328930: amtape: pid 23539 ruid 500 euid 500: start at Fri Jun
20 11:11:19 2008
1213956679.331499: amtape: pid 23539 ruid 500 euid 500: rename at Fri
Jun 20 11:11:19 2008
1213956679.833938: amtape: changer_query: changer return was 2 1
1213956679.833995: amtape: changer_query: searchable = 0
1213956679.834037: amtape: changer_find: looking for NULL changer is
searchable = 0
1213956680.645786: amtape: changer_label: daily-1 for slot 2
Can't open tape device /dev/nst0: Bad file descriptor
1213956680.831431: amtape: changer_query: changer return was 2 1
1213956680.831471: amtape: changer_query: searchable = 0
1213956755.193788: amtape: changer_label: daily-2 for slot 1
Can't open tape device /dev/nst0: Bad file descriptor
1213956755.375027: amtape: changer_query: changer return was 2 1
1213956755.375069: amtape: changer_query: searchable = 0
1213956755.375138: amtape: pid 23539 finish time Fri Jun 20 11:12:35
2008

-----Original Message-----
From: Johan Booysen 
Sent: 20 June 2008 11:09
To: amanda-users AT amanda DOT org
Subject: RE: Amanda 2.6.0 spanning

I changed chg-manual so it contains "lastslot=2", and tested the drive
with amtape, and it seemed load tapes ok.  So last night I ran an
amdump, and this morning amstatus says:

server:/what/ever 0 132181049k writing to tape (94371840k done)
(23:43:17), waiting for a new tape

So I pop in the new tape, but writing to tape doesn't resume.

If I manually use amtape now, it still seems to load tapes ok, but still
writing to tape doesn't resume:

-sh-3.2$ amtape daily slot next
Insert tape into slot 2 and press return
amtape: changed to slot 2 on tape:/dev/nst0

-sh-3.2$ amtape daily current
amtape: scanning current slot in tape-changer rack:
slot   2: time X              label daily-2

The only thing in the log files I can see that seems relevant is in
amtape.20080620105825.debug:

1213955906.014687: amtape: changer: got exit: 1 str: <none>
/usr/libexec/amanda/chg-manual: illegal slot: nextclear
1213955906.014749: amtape: critical (fatal): could not load slot <none>:
/usr/libexec/amanda/chg-manual: illegal slot: nextclear

Please help.

Johan

-----Original Message-----
From: owner-amanda-users AT amanda DOT org
[mailto:owner-amanda-users AT amanda DOT org] On Behalf Of Johan Booysen
Sent: 18 June 2008 16:16
To: amanda-users AT amanda DOT org
Subject: Amanda 2.6.0 spanning

Dear all,

I've now installed the newest version of Amanda, and have completed a
full backup to test tape spanning.  However, as soon as Amanda ran out
of space on the first tape, it "failed".

The email report contains:

FAILURE DUMP SUMMARY:
   server /what/ever lev 0  FAILED "No new tape."
   server /what/ever lev 0  FAILED [too many taper retries]

/var/log/amanda/server/daily/taper.20080617210001.debug contains:

1213795301.960369: taper: putresult: 26 REQUEST-NEW-TAPE
1213795301.961442: taper: getcmd: NEW-TAPE
1213795308.760033: taper: changer_query: changer return was 1 1
1213795308.760072: taper: changer_query: searchable = 0
1213795308.760085: taper: changer_find: looking for NULL changer is
searchable = 0
1213795309.008124: taper: putresult: 19 NO-NEW-TAPE
1213795309.008194: taper: putresult: 4 PARTIAL
1213795309.008550: taper: getcmd: FILE-WRITE 00-00025
/holding/disk/20080617210001/server._what_ever.0 server /what/ever 0
20080617210001 1073741824
1213795310.483950: taper: putresult: 26 REQUEST-NEW-TAPE
1213795310.484806: taper: getcmd: NEW-TAPE
1213795310.996988: taper: changer_query: changer return was 1 1
1213795310.997023: taper: changer_query: searchable = 0
1213795310.997036: taper: changer_find: looking for NULL changer is
searchable = 0
1213795311.586995: taper: putresult: 19 NO-NEW-TAPE
1213795311.587116: taper: putresult: 10 FAILED
1213795311.587564: taper: getcmd: QUIT
1213795311.587581: taper: putresult: 2 QUITTING

/var/log/amanda/changer.debug contains lots of these:

-> status tape:/dev/nst0
Exit -> 1 1 1
args -> -info
-> status tape:/dev/nst0
Exit -> 1 1 1
args -> -slot current
-> status tape:/dev/nst0
Exit -> 1 tape:/dev/nst0
args -> -info
-> status tape:/dev/nst0
Exit -> 1 1 1
args -> -slot current
-> status tape:/dev/nst0
Exit -> 1 tape:/dev/nst0

Again, my amanda.conf is pretty much standard, except for:

dumpcycle 0
runtapes 2
tpchanger "chg-manual"
tapedev "tape:/dev/nst0"
changerfile "/etc/amanda/daily/changer.conf"
changerdev "/dev/null"

chg-manual contains:

firstslot=1
lastslot=1

I've "exercised" the tape device using the amtape command, and it seemed
ok to me although I wasn't entirely sure what results to expect.

Can anyone maybe see a reason why it failed to span?  I'll do another
test using lastslot=2 in chg-manual, but wanted to ask in the meantime.

Thanks very much.

Johan

<Prev in Thread] Current Thread [Next in Thread>