One of our regular backups has stopped using multiple tapes, with the message:

Code:
These dumps were to tape Fs1Scheduled-43-BNR378L5.
Not using all tapes because taperflush criteria not met.
There are 244842M of dumps left in the holding disk.
They will be flushed on the next run.
However, I cannot see how this is the case. amanda.conf contains the following parameters:

Code:
autoflush yes
flush-threshold-dumped 0
flush-threshold-scheduled 0
taperflush 0
which (if I have understood the documentation correctly) should ensure that the taperflush criteria are always met. Can anyone comment on what might be going wrong?

We are using Amanda 3.3.9 on a CentOS 6 system, with an LTO-5 drive in a Quantum SuperLoader3.

Digging a bit further, the taper.debug file shows that when the end of the first tape is reached, the next tape is found and loaded in the drive, but the taper process then stops:

Code:
Sat Jan 21 16:40:24 2017: thd-0x2a1dec0: taper: quantum-superloader3: unloading drive 0
Sat Jan 21 16:40:24 2017: thd-0x2a1dec0: taper: invoking /usr/sbin/mtx -f /dev/sg4 unload 2 0
Sat Jan 21 16:41:51 2017: thd-0x2a1dec0: taper: quantum-superloader3: unload complete
Sat Jan 21 16:41:51 2017: thd-0x2a1dec0: taper: invoking /usr/sbin/mtx -f /dev/sg4 load 3 0
Sat Jan 21 16:43:07 2017: thd-0x2a1dec0: taper: quantum-superloader3: polling 'tape:/dev/nst0' to see if it's ready
Sat Jan 21 16:43:07 2017: thd-0x2a1dec0: taper: Device is in variable block size
Sat Jan 21 16:43:09 2017: thd-0x2a1dec0: taper: quantum-superloader3: setting current slot to 3
Sat Jan 21 16:43:09 2017: thd-0x2a1dec0: taper: Amanda::Taper::Scan::traditional result: 'Fs1Scheduled-44-BNR379L5' on tape:/dev/nst0 slot 3, mode 2
Sat Jan 21 16:43:09 2017: thd-0x2a1dec0: taper: invoking /usr/sbin/mtx -f /dev/sg4 status
Sat Jan 21 16:43:11 2017: thd-0x2a1dec0: taper: mtx:   Storage Changer /dev/sg4:1 Drives, 16 Slots ( 0 Import/Export )
Sat Jan 21 16:43:11 2017: thd-0x2a1dec0: taper: mtx: Data Transfer Element 0:Full (Storage Element 3 Loaded):VolumeTag = BNR379L5                        
Sat Jan 21 16:43:11 2017: thd-0x2a1dec0: taper: mtx:       Storage Element 1:Full :VolumeTag=BNR377L5                        
Sat Jan 21 16:43:11 2017: thd-0x2a1dec0: taper: mtx:       Storage Element 2:Full :VolumeTag=BNR378L5                        
Sat Jan 21 16:43:11 2017: thd-0x2a1dec0: taper: mtx:       Storage Element 3:Empty
Sat Jan 21 16:43:11 2017: thd-0x2a1dec0: taper: mtx:       Storage Element 4:Full :VolumeTag=BNR380L5                        
Sat Jan 21 16:43:11 2017: thd-0x2a1dec0: taper: mtx:       Storage Element 5:Full :VolumeTag=BNR381L5                        
Sat Jan 21 16:43:11 2017: thd-0x2a1dec0: taper: mtx:       Storage Element 6:Full :VolumeTag=BNR382L5                        
Sat Jan 21 16:43:11 2017: thd-0x2a1dec0: taper: mtx:       Storage Element 7:Full :VolumeTag=BNR383L5                        
Sat Jan 21 16:43:11 2017: thd-0x2a1dec0: taper: mtx:       Storage Element 8:Full :VolumeTag=BNR384L5                        
Sat Jan 21 16:43:11 2017: thd-0x2a1dec0: taper: mtx:       Storage Element 9:Full :VolumeTag=BNR385L5                        
Sat Jan 21 16:43:11 2017: thd-0x2a1dec0: taper: mtx:       Storage Element 10:Full :VolumeTag=BNR386L5                        
Sat Jan 21 16:43:11 2017: thd-0x2a1dec0: taper: mtx:       Storage Element 11:Full 
Sat Jan 21 16:43:11 2017: thd-0x2a1dec0: taper: mtx:       Storage Element 12:Empty
Sat Jan 21 16:43:11 2017: thd-0x2a1dec0: taper: mtx:       Storage Element 13:Empty
Sat Jan 21 16:43:11 2017: thd-0x2a1dec0: taper: mtx:       Storage Element 14:Empty
Sat Jan 21 16:43:11 2017: thd-0x2a1dec0: taper: mtx:       Storage Element 15:Empty
Sat Jan 21 16:43:11 2017: thd-0x2a1dec0: taper: mtx:       Storage Element 16:Full :VolumeTag=CLNU03L1                        
Sat Jan 21 16:43:11 2017: thd-0x2a1dec0: taper: quantum-superloader3: updating state
Sat Jan 21 16:43:11 2017: thd-0x2a1dec0: taper: Cancelling <Xfer@0x3865190 (<XferSourceHolding@0x35a6420> -> <XferDestTaperSplitter@0x35d10a0>)>
Sat Jan 21 16:43:11 2017: thd-0x3883a60: taper: xfer-source-holding CRC: ba3bdc13:155254390784
Sat Jan 21 16:43:11 2017: thd-0x3883a10: taper: xfer-dest-taper-splitter CRC: d832f061:155243773952
Sat Jan 21 16:43:11 2017: thd-0x2a1dec0: taper: ru_utime   : 1092
Sat Jan 21 16:43:11 2017: thd-0x2a1dec0: taper: ru_stime   : 2808
Sat Jan 21 16:43:11 2017: thd-0x2a1dec0: taper: ru_maxrss  : 43148
Sat Jan 21 16:43:11 2017: thd-0x2a1dec0: taper: ru_ixrss   : 0
Sat Jan 21 16:43:11 2017: thd-0x2a1dec0: taper: ru_idrss   : 0
Sat Jan 21 16:43:11 2017: thd-0x2a1dec0: taper: ru_isrss   : 0
Sat Jan 21 16:43:11 2017: thd-0x2a1dec0: taper: ru_minflt  : 25151
Sat Jan 21 16:43:11 2017: thd-0x2a1dec0: taper: ru_majflt  : 474
Sat Jan 21 16:43:11 2017: thd-0x2a1dec0: taper: ru_nswap   : 0
Sat Jan 21 16:43:11 2017: thd-0x2a1dec0: taper: ru_inblock : 1672799728
Sat Jan 21 16:43:11 2017: thd-0x2a1dec0: taper: ru_oublock : 11632
Sat Jan 21 16:43:11 2017: thd-0x2a1dec0: taper: ru_msgsnd  : 0
Sat Jan 21 16:43:11 2017: thd-0x2a1dec0: taper: ru_msgrcv  : 0
Sat Jan 21 16:43:11 2017: thd-0x2a1dec0: taper: ru_nsignals: 0
Sat Jan 21 16:43:11 2017: thd-0x2a1dec0: taper: ru_nvcsw   : 31449149
Sat Jan 21 16:43:11 2017: thd-0x2a1dec0: taper: ru_nivcsw  : 1925402
Sat Jan 21 16:43:11 2017: thd-0x2a1dec0: taper: pid 8643 finish time Sat Jan 21 16:43:11 2017