There were no errors reported as shown in the taper log below. There
is not enough data to fill one tape in the test disklist I was using
but it contain 14 DLEs. I assumed it would use both drives.
ts2:/var/log/amanda/server/daily$ cat taper.20101110162643.debug
Wed Nov 10 16:26:43 2010: taper: pid 22378 ruid 6111 euid 6111 version
3.2.0: start at Wed Nov 10 16:26:43 2010
Wed Nov 10 16:26:43 2010: taper: pid 22378 ruid 6111 euid 6111 version
3.2.0: rename at Wed Nov 10 16:26:43 2010
Wed Nov 10 16:26:43 2010: taper: chg-robot: using statefile '/var/
amanda/chg-robot-dev-sg8'
Wed Nov 10 16:26:43 2010: taper: Amanda::Taper::Scan::traditional
stage 1: search for oldest reusable volume
Wed Nov 10 16:26:43 2010: taper: Amanda::Taper::Scan::traditional
oldest reusable volume is 'daily2-00000033'
Wed Nov 10 16:26:43 2010: taper: Amanda::Taper::Scan::traditional
stage 1: searching oldest reusable volume 'daily2-00000033'
Wed Nov 10 16:26:43 2010: taper: invoking /usr/sbin/mtx -f /dev/sg8
status
Wed Nov 10 16:26:43 2010: taper: robot: updating state
Wed Nov 10 16:26:43 2010: taper: robot: loading label 'daily2-00000033'
Wed Nov 10 16:26:43 2010: taper: robot: requested volume is already in
drive 3
Wed Nov 10 16:26:43 2010: taper: robot: polling 'tape:/dev/nst0' to
see if it's ready
Wed Nov 10 16:26:43 2010: taper: robot: setting current slot to 75
Wed Nov 10 16:26:43 2010: taper: Amanda::Taper::Scan::traditional
result: 'daily2-00000033' on tape:/dev/nst0 slot 75, mode 2
Wed Nov 10 16:26:50 2010: taper: Amanda::Taper::Scribe preparing to
write, part size 2147483648, using cache_inform (splitter) (no LEOM)
Wed Nov 10 16:26:50 2010: taper: Starting <x...@0x19e3ed0
(<xfersourcehold...@0x19e96d0> -> <xferdesttapersplit...@0x1a733c0>)>
Wed Nov 10 16:26:50 2010: taper: Final linkage:
<xfersourcehold...@0x19e96d0> -(PULL_BUFFER)->
<xferelementg...@0x1999fd0> -(PUSH_BUFFER)->
<xferdesttapersplit...@0x1a733c0>
Wed Nov 10 16:26:50 2010: taper: Building type TAPESTART header of
32768-32768 bytes with name='daily2-00000033' disk='' dumplevel=0 and
blocksize=32768
Wed Nov 10 16:26:54 2010: taper: invoking /usr/sbin/mtx -f /dev/sg8
status
Wed Nov 10 16:26:54 2010: taper: Amanda::Taper::Scan::traditional
stage 1: search for oldest reusable volume
Wed Nov 10 16:26:54 2010: taper: Amanda::Taper::Scan::traditional
oldest reusable volume is 'daily2-00000034'
Wed Nov 10 16:26:54 2010: taper: Amanda::Taper::Scan::traditional
stage 1: searching oldest reusable volume 'daily2-00000034'
Wed Nov 10 16:26:54 2010: taper: robot: updating state
Wed Nov 10 16:26:54 2010: taper: Building type SPLIT_FILE header of
32768-32768 bytes with name='gs1-data.intrepid.alcf.anl.gov' disk='/
dev/' dumplevel=0 and blocksize=32768
Wed Nov 10 16:26:55 2010: taper: robot: too early for another 'status'
invocation
Wed Nov 10 16:26:55 2010: taper: robot: loading label 'daily2-00000034'
Wed Nov 10 16:26:55 2010: taper: robot: requested volume is already in
drive 2
Wed Nov 10 16:26:55 2010: taper: robot: polling 'tape:/dev/nst1' to
see if it's ready
Wed Nov 10 16:26:55 2010: taper: robot: setting current slot to 76
Wed Nov 10 16:26:55 2010: taper: Amanda::Taper::Scan::traditional
result: 'daily2-00000034' on tape:/dev/nst1 slot 76, mode 2
Wed Nov 10 16:34:09 2010: taper: Amanda::Taper::Scribe preparing to
write, part size 2147483648, using cache_inform (splitter) (no LEOM)
Wed Nov 10 16:34:09 2010: taper: Starting <x...@0x1958f10
(<xfersourcehold...@0x1b8de90> -> <xferdesttapersplit...@0x1958dd0>)>
Wed Nov 10 16:34:09 2010: taper: Final linkage:
<xfersourcehold...@0x1b8de90> -(PULL_BUFFER)->
<xferelementg...@0x1739b00> -(PUSH_BUFFER)->
<xferdesttapersplit...@0x1958dd0>
Wed Nov 10 16:34:09 2010: taper: Building type SPLIT_FILE header of
32768-32768 bytes with name='gs2-data.intrepid.alcf.anl.gov' disk='/
dev/' dumplevel=0 and blocksize=32768
Wed Nov 10 16:34:11 2010: taper: Amanda::Taper::Scribe preparing to
write, part size 2147483648, using cache_inform (splitter) (no LEOM)
Wed Nov 10 16:34:11 2010: taper: Starting <x...@0x1979dd0
(<xfersourcehold...@0x1979d40> -> <xferdesttapersplit...@0x1979c00>)>
Wed Nov 10 16:34:11 2010: taper: Final linkage:
<xfersourcehold...@0x1979d40> -(PULL_BUFFER)->
<xferelementg...@0x184fec0> -(PUSH_BUFFER)->
<xferdesttapersplit...@0x1979c00>
Wed Nov 10 16:34:11 2010: taper: Building type SPLIT_FILE header of
32768-32768 bytes with name='ts1-mgmt.ether.alcf.anl.gov' disk='/var/
lib/amanda/' dumplevel=0 and blocksize=32768
Wed Nov 10 16:34:13 2010: taper: Amanda::Taper::Scribe preparing to
write, part size 2147483648, using cache_inform (splitter) (no LEOM)
Wed Nov 10 16:34:13 2010: taper: Starting <x...@0x1925d80
(<xfersourcehold...@0x1925cf0> -> <xferdesttapersplit...@0x1925bb0>)>
Wed Nov 10 16:34:13 2010: taper: Final linkage:
<xfersourcehold...@0x1925cf0> -(PULL_BUFFER)->
<xferelementg...@0x1b560c0> -(PUSH_BUFFER)->
<xferdesttapersplit...@0x1925bb0>
Wed Nov 10 16:34:13 2010: taper: Building type SPLIT_FILE header of
32768-32768 bytes with name='gs1-data.intrepid.alcf.anl.gov' disk='/
tmp/' dumplevel=0 and blocksize=32768
Wed Nov 10 16:34:15 2010: taper: Amanda::Taper::Scribe preparing to
write, part size 2147483648, using cache_inform (splitter) (no LEOM)
Wed Nov 10 16:34:15 2010: taper: Starting <x...@0x16408d0
(<xfersourcehold...@0x1b7b9e0> -> <xferdesttapersplit...@0x1b7b8a0>)>
Wed Nov 10 16:34:15 2010: taper: Final linkage:
<xfersourcehold...@0x1b7b9e0> -(PULL_BUFFER)->
<xferelementg...@0x18e3370> -(PUSH_BUFFER)->
<xferdesttapersplit...@0x1b7b8a0>
Wed Nov 10 16:34:15 2010: taper: Building type SPLIT_FILE header of
32768-32768 bytes with name='gs2-data.intrepid.alcf.anl.gov' disk='/
opt' dumplevel=0 and blocksize=32768
Wed Nov 10 16:34:18 2010: taper: Amanda::Taper::Scribe preparing to
write, part size 2147483648, using cache_inform (splitter) (no LEOM)
Wed Nov 10 16:34:18 2010: taper: Starting <x...@0x1925950
(<xfersourcehold...@0x1652180> -> <xferdesttapersplit...@0x1652010>)>
Wed Nov 10 16:34:18 2010: taper: Final linkage:
<xfersourcehold...@0x1652180> -(PULL_BUFFER)->
<xferelementg...@0x1a3bff0> -(PUSH_BUFFER)->
<xferdesttapersplit...@0x1652010>
Wed Nov 10 16:34:18 2010: taper: Building type SPLIT_FILE header of
32768-32768 bytes with name='gs1-data.intrepid.alcf.anl.gov' disk='/
opt' dumplevel=0 and blocksize=32768
Wed Nov 10 16:34:23 2010: taper: Amanda::Taper::Scribe preparing to
write, part size 2147483648, using cache_inform (splitter) (no LEOM)
Wed Nov 10 16:34:23 2010: taper: Starting <x...@0x18ce520
(<xfersourcehold...@0x19d4180> -> <xferdesttapersplit...@0x1652010>)>
Wed Nov 10 16:34:23 2010: taper: Final linkage:
<xfersourcehold...@0x19d4180> -(PULL_BUFFER)->
<xferelementg...@0x1981ac0> -(PUSH_BUFFER)->
<xferdesttapersplit...@0x1652010>
Wed Nov 10 16:34:23 2010: taper: Building type SPLIT_FILE header of
32768-32768 bytes with name='gs2-data.intrepid.alcf.anl.gov' disk='/
tmp/' dumplevel=0 and blocksize=32768
Wed Nov 10 16:34:29 2010: taper: Amanda::Taper::Scribe preparing to
write, part size 2147483648, using cache_inform (splitter) (no LEOM)
Wed Nov 10 16:34:29 2010: taper: Starting <x...@0x1ad1610
(<xfersourcehold...@0x1b7b970> -> <xferdesttapersplit...@0x1ad14d0>)>
Wed Nov 10 16:34:29 2010: taper: Final linkage:
<xfersourcehold...@0x1b7b970> -(PULL_BUFFER)->
<xferelementg...@0x160f130> -(PUSH_BUFFER)->
<xferdesttapersplit...@0x1ad14d0>
Wed Nov 10 16:34:29 2010: taper: Building type SPLIT_FILE header of
32768-32768 bytes with name='ts1-mgmt.ether.alcf.anl.gov' disk='/etc/
amanda/' dumplevel=0 and blocksize=32768
Wed Nov 10 16:34:45 2010: taper: Amanda::Taper::Scribe preparing to
write, part size 2147483648, using cache_inform (splitter) (no LEOM)
Wed Nov 10 16:34:45 2010: taper: Starting <x...@0x1a16440
(<xfersourcehold...@0x1b7bd40> -> <xferdesttapersplit...@0x1a162d0>)>
Wed Nov 10 16:34:45 2010: taper: Final linkage:
<xfersourcehold...@0x1b7bd40> -(PULL_BUFFER)->
<xferelementg...@0x16047a0> -(PUSH_BUFFER)->
<xferdesttapersplit...@0x1a162d0>
Wed Nov 10 16:34:45 2010: taper: Building type SPLIT_FILE header of
32768-32768 bytes with name='gs1-data.intrepid.alcf.anl.gov' disk='/
var/' dumplevel=0 and blocksize=32768
Wed Nov 10 16:35:01 2010: taper: Amanda::Taper::Scribe preparing to
write, part size 2147483648, using cache_inform (splitter) (no LEOM)
Wed Nov 10 16:35:01 2010: taper: Starting <x...@0x19d3d00
(<xfersourcehold...@0x160efc0> -> <xferdesttapersplit...@0x974100>)>
Wed Nov 10 16:35:01 2010: taper: Final linkage:
<xfersourcehold...@0x160efc0> -(PULL_BUFFER)->
<xferelementg...@0x19cdce0> -(PUSH_BUFFER)->
<xferdesttapersplit...@0x974100>
Wed Nov 10 16:35:01 2010: taper: Building type SPLIT_FILE header of
32768-32768 bytes with name='gs2-data.intrepid.alcf.anl.gov' disk='/
var/' dumplevel=0 and blocksize=32768
Wed Nov 10 16:35:15 2010: taper: Amanda::Taper::Scribe preparing to
write, part size 2147483648, using cache_inform (splitter) (no LEOM)
Wed Nov 10 16:35:15 2010: taper: Starting <x...@0x165fb30
(<xfersourcehold...@0x165fa50> -> <xferdesttapersplit...@0x165f910>)>
Wed Nov 10 16:35:15 2010: taper: Final linkage:
<xfersourcehold...@0x165fa50> -(PULL_BUFFER)->
<xferelementg...@0x16bb620> -(PUSH_BUFFER)->
<xferdesttapersplit...@0x165f910>
Wed Nov 10 16:35:15 2010: taper: Building type SPLIT_FILE header of
32768-32768 bytes with name='gs1-data.intrepid.alcf.anl.gov' disk='/
local/' dumplevel=0 and blocksize=32768
Wed Nov 10 16:35:40 2010: taper: Building type SPLIT_FILE header of
32768-32768 bytes with name='gs1-data.intrepid.alcf.anl.gov' disk='/
local/' dumplevel=0 and blocksize=32768
Wed Nov 10 16:35:58 2010: taper: Amanda::Taper::Scribe preparing to
write, part size 2147483648, using cache_inform (splitter) (no LEOM)
Wed Nov 10 16:35:58 2010: taper: Starting <x...@0x97aa60
(<xfersourcehold...@0x165fc00> -> <xferdesttapersplit...@0x165fac0>)>
Wed Nov 10 16:35:58 2010: taper: Final linkage:
<xfersourcehold...@0x165fc00> -(PULL_BUFFER)->
<xferelementg...@0x1adbc10> -(PUSH_BUFFER)->
<xferdesttapersplit...@0x165fac0>
Wed Nov 10 16:35:58 2010: taper: Building type SPLIT_FILE header of
32768-32768 bytes with name='gs2-data.intrepid.alcf.anl.gov' disk='/
local/' dumplevel=0 and blocksize=32768
Wed Nov 10 16:36:27 2010: taper: Building type SPLIT_FILE header of
32768-32768 bytes with name='gs2-data.intrepid.alcf.anl.gov' disk='/
local/' dumplevel=0 and blocksize=32768
Wed Nov 10 16:36:46 2010: taper: Building type SPLIT_FILE header of
32768-32768 bytes with name='gs2-data.intrepid.alcf.anl.gov' disk='/
local/' dumplevel=0 and blocksize=32768
Wed Nov 10 16:37:00 2010: taper: Amanda::Taper::Scribe preparing to
write, part size 2147483648, using cache_inform (splitter) (no LEOM)
Wed Nov 10 16:37:00 2010: taper: Starting <x...@0x19bd080
(<xfersourcehold...@0x1adbbb0> -> <xferdesttapersplit...@0x1adba70>)>
Wed Nov 10 16:37:00 2010: taper: Final linkage:
<xfersourcehold...@0x1adbbb0> -(PULL_BUFFER)->
<xferelementg...@0x1a3d930> -(PUSH_BUFFER)->
<xferdesttapersplit...@0x1adba70>
Wed Nov 10 16:37:00 2010: taper: Building type SPLIT_FILE header of
32768-32768 bytes with name='gs1-data.intrepid.alcf.anl.gov' disk='/'
dumplevel=0 and blocksize=32768
Wed Nov 10 16:37:31 2010: taper: Building type SPLIT_FILE header of
32768-32768 bytes with name='gs1-data.intrepid.alcf.anl.gov' disk='/'
dumplevel=0 and blocksize=32768
Wed Nov 10 16:37:44 2010: taper: Amanda::Taper::Scribe preparing to
write, part size 2147483648, using cache_inform (splitter) (no LEOM)
Wed Nov 10 16:37:44 2010: taper: Starting <x...@0x16bb8b0
(<xfersourcehold...@0x1adbbf0> -> <xferdesttapersplit...@0x1adbab0>)>
Wed Nov 10 16:37:44 2010: taper: Final linkage:
<xfersourcehold...@0x1adbbf0> -(PULL_BUFFER)->
<xferelementg...@0x16e4c40> -(PUSH_BUFFER)->
<xferdesttapersplit...@0x1adbab0>
Wed Nov 10 16:37:44 2010: taper: Building type SPLIT_FILE header of
32768-32768 bytes with name='gs2-data.intrepid.alcf.anl.gov' disk='/'
dumplevel=0 and blocksize=32768
Wed Nov 10 16:38:11 2010: taper: Building type SPLIT_FILE header of
32768-32768 bytes with name='gs2-data.intrepid.alcf.anl.gov' disk='/'
dumplevel=0 and blocksize=32768
Wed Nov 10 16:39:23 2010: taper: invoking /usr/sbin/mtx -f /dev/sg8
status
Wed Nov 10 16:39:23 2010: taper: robot: updating state
Wed Nov 10 16:39:24 2010: taper: robot: too early for another 'status'
invocation
Wed Nov 10 16:39:24 2010: taper: pid 22378 finish time Wed Nov 10
16:39:24 2010
On Nov 11, 2010, at 9:58 AM, Jean-Louis Martineau wrote:
There is a million of reason,
What's the error reported by amanda?
Do you have enough data to fill more than one tape?
Jean-Louis
Jack O'Connell wrote:
I've upgraded to version 3.2.0 and have enabled parallel writes to
tape as follows. Although 2 tapes get mounted, only one gets
written to. Amcheck only mounts one tape, the second tape doesn't
mount until amdump is started. Any ideas?
taper-parallel-write 2 define changer robot { tapedev "chg-robot:/
dev/sg8" # your changer device file property "tape-device"
"3=tape:/dev/nst0" property append "tape-device" "2=tape:/dev/
nst1" } tpchanger "robot" Thanks,
Jack O'Connell
ALCF - Storage
(630)252-3610
joco...@alcf.anl.gov <mailto:joco...@alcf.anl.gov>
Thanks,
Jack O'Connell
ALCF - Storage
(630)252-3610
joco...@alcf.anl.gov