Hi,
tried this with:
http://www.zmanda.com/downloads/community/Amanda/3.4.2/Redhat_Enterprise_6.0/amanda-backup_server-3.4.2-1.rhel6.x86_64.rpm
(and also 3.4.1)
Oracle Linux Server release 6.8
# uname -rsv
Linux 4.1.12-61.1.23.el6uek.x86_64 #2 SMP Tue Dec 20 16:51:41 PST 2016
Tapeinfo:
Vendor ID: 'HP '
Product ID: 'Ultrium 4-SCSI '
Revision: 'H63Z'
The test backup doesn't fit on one tape. After I get the E-Mail from the
interactivity module, I can see with lsof that the taper still has a
lock on /dev/nst1:
> # lsof /dev/nst1
COMMAND PID USER FD TYPE DEVICE SIZE/OFF NODE NAME
taper 1168 amandabackup 5u CHR 9,129 0t0 1812371 /dev/nst1
touching the check-file looks like this in
/var/log/amanda/server/ptxhamtest/taper.20170208122530.debug:
Wed Feb 08 16:21:12.035824026 2017: pid 1168: thd-0x240ad70: taper: xfer_queue_message:
MSG: <XMsg@0x7ff8bc012390 type=XMSG_PART_DONE
elt=<XferDestTaperSplitter@0x24090a0> version=0>
Wed Feb 08 16:21:12.036846793 2017: pid 1168: thd-0x240ad70: taper: Building
type SPLIT_FILE header of 32768-32768 bytes with name='localhost'
disk='/amanda/testbackupsrc' dumplevel=0 and blocksize=32768
Wed Feb 08 16:22:52.113249836 2017: pid 1168: thd-0x240ad70: taper: Device
tape:/dev/nst1 error = 'No space left on device'
Wed Feb 08 16:22:52.113278102 2017: pid 1168: thd-0x240ad70: taper: Device
tape:/dev/nst1 setting status flag(s): DEVICE_STATUS_VOLUME_ERROR
Wed Feb 08 16:22:53.101250403 2017: pid 1168: thd-0x240ad70: taper: xfer_queue_message:
MSG: <XMsg@0x7ff8bc012670 type=XMSG_PART_DONE
elt=<XferDestTaperSplitter@0x24090a0> version=0>
Wed Feb 08 16:23:19.976805822 2017: pid 1168: thd-0x1454d20: taper: Will
request retry of failed split part.
Wed Feb 08 16:23:19.977170240 2017: pid 1168: thd-0x1454d20: taper: tape
HAM-M-029-L4 kb 754974720 fm 73 [OK]
Wed Feb 08 16:23:19.980883703 2017: pid 1168: thd-0x1454d20: taper: Device is
in variable block size
Wed Feb 08 16:23:40.882859608 2017: pid 1168: thd-0x1454d20: taper: new
Amanda::Changer::Error: type='failed', reason='notfound', message='No
acceptable volumes found'
Wed Feb 08 16:23:40.882974991 2017: pid 1168: thd-0x1454d20: taper: cmd:
/usr/bin/Mail -s AMANDA VOLUME REQUEST: new volume x...@xxx.xxx
Wed Feb 08 16:23:50.888937917 2017: pid 1168: thd-0x1454d20: taper: new
Amanda::Changer::Error: type='failed', reason='notfound', message='No
acceptable volumes found'
Wed Feb 08 16:24:00.960351367 2017: pid 1168: thd-0x1454d20: taper: new
Amanda::Changer::Error: type='failed', reason='notfound', message='No
acceptable volumes found'
Wed Feb 08 16:24:10.960959061 2017: pid 1168: thd-0x1454d20: taper: new
Amanda::Changer::Error: type='failed', reason='notfound', message='No
acceptable volumes found'
...
Wed Feb 08 17:20:55.510368422 2017: pid 1168: thd-0x1454d20: taper: new
Amanda::Changer::Error: type='failed', reason='notfound', message='No
acceptable volumes found'
Wed Feb 08 17:21:05.512939917 2017: pid 1168: thd-0x1454d20: taper: new
Amanda::Changer::Error: type='failed', reason='notfound', message='No
acceptable volumes found'
Wed Feb 08 17:21:15.515187884 2017: pid 1168: thd-0x1454d20: taper: new
Amanda::Changer::Error: type='failed', reason='notfound', message='No
acceptable volumes found'
Wed Feb 08 17:21:25.517437824 2017: pid 1168: thd-0x1454d20: taper: Device
tape:/dev/nst1 error = 'Can't open tape device /dev/nst1: Device or resource
busy'
Wed Feb 08 17:21:25.517455484 2017: pid 1168: thd-0x1454d20: taper: Device
tape:/dev/nst1 setting status flag(s): DEVICE_STATUS_DEVICE_BUSY
Wed Feb 08 17:21:25.517680908 2017: pid 1168: thd-0x1454d20: taper: Slot 1
without label can be labeled
Wed Feb 08 17:21:25.517775016 2017: pid 1168: thd-0x1454d20: taper: new
Amanda::Changer::Error: type='fatal', message='Can't open tape device
/dev/nst1: Device or resource busy'
Wed Feb 08 17:21:25.518772880 2017: pid 1168: thd-0x1454d20: taper: cmd:
/usr/bin/Mail -s AMANDA VOLUME REQUEST: new volume x...@xxx.xxx
if I remove "eject-volume yes" from amanda.conf, lsof doesn't show
/dev/nst1 as open after the mail and logfile looks like this when
touching the check-file:
Sun Feb 05 22:01:45.892621331 2017: pid 14498: thd-0x36592a0: taper: xfer_queue_message:
MSG: <XMsg@0x7f5770012690 type=XMSG_PART_DONE
elt=<XferDestTaperSplitter@0x3226530> version=0>
Sun Feb 05 22:01:45.893809646 2017: pid 14498: thd-0x36592a0: taper: Building
type SPLIT_FILE header of 32768-32768 bytes with name='localhost'
disk='abc-rman' dumplevel=0 and blocksize=32768
Sun Feb 05 22:02:27.050993044 2017: pid 14498: thd-0x36592a0: taper: Device
tape:/dev/nst1 error = 'No space left on device'
Sun Feb 05 22:02:27.051019886 2017: pid 14498: thd-0x36592a0: taper: Device
tape:/dev/nst1 setting status flag(s): DEVICE_STATUS_VOLUME_ERROR
Sun Feb 05 22:02:28.006847900 2017: pid 14498: thd-0x36592a0: taper: xfer_queue_message:
MSG: <XMsg@0x7f5770016d70 type=XMSG_PART_DONE
elt=<XferDestTaperSplitter@0x3226530> version=0>
Sun Feb 05 22:02:54.991253275 2017: pid 14498: thd-0x2258610: taper: Will
request retry of failed split part.
Sun Feb 05 22:02:54.992089576 2017: pid 14498: thd-0x2258610: taper: tape
HAM-M-025-L4 kb 804625975 fm 137 [OK]
Sun Feb 05 22:02:54.993163873 2017: pid 14498: thd-0x2258610: taper: new
Amanda::Changer::Error: type='failed', reason='notfound', message='No
acceptable volumes found'
Sun Feb 05 22:02:54.993302419 2017: pid 14498: thd-0x2258610: taper: cmd:
/usr/bin/Mail -s AMANDA VOLUME REQUEST: new volume x...@xxx.xxx
Sun Feb 05 22:03:04.998826673 2017: pid 14498: thd-0x2258610: taper: new
Amanda::Changer::Error: type='failed', reason='notfound', message='No
acceptable volumes found'
Sun Feb 05 22:03:15.005238432 2017: pid 14498: thd-0x2258610: taper: new
Amanda::Changer::Error: type='failed', reason='notfound', message='No
acceptable volumes found'
Sun Feb 05 22:03:25.009766390 2017: pid 14498: thd-0x2258610: taper: new
Amanda::Changer::Error: type='failed', reason='notfound', message='No
acceptable volumes found'
...
Mon Feb 06 09:13:13.437584985 2017: pid 14498: thd-0x2258610: taper: new
Amanda::Changer::Error: type='failed', reason='notfound', message='No
acceptable volumes found'
Mon Feb 06 09:13:23.455771038 2017: pid 14498: thd-0x2258610: taper: new
Amanda::Changer::Error: type='failed', reason='notfound', message='No
acceptable volumes found'
Mon Feb 06 09:13:33.473860747 2017: pid 14498: thd-0x2258610: taper: new
Amanda::Changer::Error: type='failed', reason='notfound', message='No
acceptable volumes found'
Mon Feb 06 09:13:38.596670849 2017: pid 14498: thd-0x2258610: taper: Device is
in variable block size
Mon Feb 06 09:13:40.734257638 2017: pid 14498: thd-0x2258610: taper: Slot 1
with label HAM-M-026-L4 is usable
Mon Feb 06 09:13:45.889592195 2017: pid 14498: thd-0x2258610: taper: Building
type TAPESTART header of 32768-32768 bytes with name='HAM-M-026-L4' disk=''
dumplevel=0 and blocksize=32768
Thanks,
Thilo
org "MyConfig"
infofile "/amanda/state_ptxhamtest/curinfo"
logdir "/amanda/state_ptxhamtest/log"
indexdir "/amanda/state_ptxhamtest/index"
dumpuser "amandabackup"
mailto "x...@xxx.xxx"
send-amreport-on all
define changer my_single {
tpchanger "chg-single:tape:/dev/nst1"
}
tpchanger "my_single"
labelstr "HAM-[DM]-[0-9][0-9][0-9]-L4"
tapecycle 12
dumpcycle 0
runtapes 10
eject-volume yes
define interactivity "by-email" {
plugin "email"
property "resend-delay" "0" #one mail only
property "check-file" "/tmp/email_input"
property "check-file-delay" "10" #every 10 seconds
}
interactivity "by-email"
define taperscan "scan-oldest" {
plugin "oldest"
}
taperscan "scan-oldest"
define tapetype PTX-TAPE {
comment "HP LTO-4 Ultrium; C7974A"
length 794365568 kbytes
filemark 271 kbytes
speed 75266 kps
blocksize 32 kbytes
part-size 10 gbytes
}
tapetype "PTX-TAPE"
define dumptype simple-gnutar-local {
auth "local"
compress none
program "GNUTAR"
allow_split 1
estimate server
}
holdingdisk hd1 {
directory "/amanda/holding/test"
use -10 gbytes
chunksize 2 gbyte
}
