Database Software

Please help.
Latest OSB is installed on IBM AIX 6.1 TL7 along with Oracle 11.2.0.3, the backup library is FC(fiber) HP MSL6000 series with 1 SCSI ULTRIUM drive
OSB is integrated with EM. (Tape library and drive have latests firmware upgraded)
From Wen inteface it is possible to implement all librrary/tape commands (inventory, load, clean, etc)
It is prepared several media families and data sets with write window quite big and append enable

When performing dataset first time the unlabeled volume is succesfuly labeled and backup is performed.
But when it is perfoirmed the second time, OSB finds appropruiate media family volume (already labeled) but refuses to append on it with error

Error: this tape is not labeled. You cannot mix labeled and unlabeled backup images

and waits for another resources (tape, it is possible to unload tape
from library and load to DTE other one (unlabeled, foreign), the it will be labeled again with new sequence number and backup will be implemented)
The lack of OSB finctionality to append on volumes makes it unusable, since there are lot of scenariuos/situations when it is needed.
Thera is not possible to get other backup device (other vendor, model) to check that is because of HW or something is wrong is OSB configuration.
Can anybody have an idea what is wrong ?, I put debug optiions in operation policies, so below is the transcript of unsuccseful backup


admin/19.1: 2012/05/16.13:16:06 ______________________________________________________________________
admin/19.1: 2012/05/16.13:16:06
admin/19.1: 2012/05/16.13:16:06 Transcript for job admin/19.1 running on hprs1
admin/19.1: 2012/05/16.13:16:06
admin/19.1: 2012/05/16.13:16:06 (amh) qdv__automount_in_mh entered
admin/19.1: 2012/05/16.13:16:06 (amh) qdv__automount_in_mh hprs1_tape1 at 2012/05/16.13:16:06, flags 0x100
admin/19.1: 2012/05/16.13:16:06 (amh) mount volume options list contains:
admin/19.1: 2012/05/16.13:16:06 (amh) vtype 3 (app), vid (null), vs_create 0, family HPRS-FILE, retain (null), size 0, mediainfo 2, scratch 0
admin/19.1: 2012/05/16.13:16:08 (amh) don't preserve previous mh automount state
admin/19.1: 2012/05/16.13:16:08 (gep) getting reservation for element 0x1 (dte)
admin/19.1: 2012/05/16.13:16:08 (una) unload_anywhere entered
admin/19.1: 2012/05/16.13:16:09 (amh) beginning pass 1, mediainfo pass 1
admin/19.1: 2012/05/16.13:16:09 (gep) getting reservation for element 0x1 (se)
admin/19.1: 2012/05/16.13:16:09 (amh) 1 vacant
admin/19.1: 2012/05/16.13:16:09 (gep) getting reservation for element 0x2 (se)
admin/19.1: 2012/05/16.13:16:09 (amh) 2 no vid
admin/19.1: 2012/05/16.13:16:09 (gep) getting reservation for element 0x3 (se)
admin/19.1: 2012/05/16.13:16:09 (mmr) family HPRS-FILE != HIPREGIS_INC
admin/19.1: 2012/05/16.13:16:09 (mmr) oid 145 (vid HIPREGIS_INC-000001, tag PAA830L2, create_time 1337025595, mediainfo 0) fails mount criteria
admin/19.1: 2012/05/16.13:16:09 (amh) 3 oid 145 doesn't meet mount requirements - volume doesn't meet mount criteria (OB device mgr)
admin/19.1: 2012/05/16.13:16:09 (gep) getting reservation for element 0x4 (se)
admin/19.1: 2012/05/16.13:16:09 (mmr) family HPRS-FILE != RMAN-DEFAULT
admin/19.1: 2012/05/16.13:16:09 (mmr) oid 146 (vid RMAN-DEFAULT-000004, tag PAA833L2, create_time 1337026560, mediainfo 0) fails mount criteria
admin/19.1: 2012/05/16.13:16:09 (amh) 4 oid 146 doesn't meet mount requirements - volume doesn't meet mount criteria (OB device mgr)
admin/19.1: 2012/05/16.13:16:09 (gep) getting reservation for element 0x5 (se)
admin/19.1: 2012/05/16.13:16:09 (mmr) family HPRS-FILE != HIPREGIS_FULL
admin/19.1: 2012/05/16.13:16:09 (mmr) oid 147 (vid HIPREGIS_FULL-000003, tag PAA838L2, create_time 1337062459, mediainfo 0) fails mount criteria
admin/19.1: 2012/05/16.13:16:09 (amh) 5 oid 147 doesn't meet mount requirements - volume doesn't meet mount criteria (OB device mgr)
admin/19.1: 2012/05/16.13:16:09 (gep) getting reservation for element 0x6 (se)
admin/19.1: 2012/05/16.13:16:09 (mmr) family HPRS-FILE != HIPREGIS_FULL
admin/19.1: 2012/05/16.13:16:09 (mmr) oid 148 (vid HIPREGIS_FULL-000004, tag PAA843L2, create_time 1337071895, mediainfo 0) fails mount criteria
admin/19.1: 2012/05/16.13:16:09 (amh) 6 oid 148 doesn't meet mount requirements - volume doesn't meet mount criteria (OB device mgr)
admin/19.1: 2012/05/16.13:16:09 (gep) getting reservation for element 0x7 (se)
admin/19.1: 2012/05/16.13:16:09 (mmr) family HPRS-FILE != HIPREGIS_FULL
admin/19.1: 2012/05/16.13:16:09 (mmr) oid 149 (vid HIPREGIS_FULL-000005, tag PAA840L2, create_time 1337072850, mediainfo 0) fails mount criteria
admin/19.1: 2012/05/16.13:16:09 (amh) 7 oid 149 doesn't meet mount requirements - volume doesn't meet mount criteria (OB device mgr)
admin/19.1: 2012/05/16.13:16:09 (gep) getting reservation for element 0x8 (se)
admin/19.1: 2012/05/16.13:16:09 (mmr) family HPRS-FILE != HIPREGIS_FULL
admin/19.1: 2012/05/16.13:16:09 (mmr) oid 151 (vid HIPREGIS_FULL-000006, tag PAA835L2, create_time 1337073405, mediainfo 0) fails mount criteria
admin/19.1: 2012/05/16.13:16:09 (amh) 8 oid 151 doesn't meet mount requirements - volume doesn't meet mount criteria (OB device mgr)
admin/19.1: 2012/05/16.13:16:09 (gep) getting reservation for element 0x9 (se)
admin/19.1: 2012/05/16.13:16:09 (mmr) oid 164 (vid HPRS-FILE-000004, tag PAA839L2, create_time 1337162205, mediainfo 0) passes criteria
admin/19.1: 2012/05/16.13:16:09 (amh) 9 loading
admin/19.1: 2012/05/16.13:16:38 (atv) qdv__automount_this_vol entered
admin/19.1: 2012/05/16.13:16:38 (atv) calling qdv__mount
admin/19.1: 2012/05/16.13:16:38 (mt) qdv__read_mount_db() succeeded, found vol_oid 0
admin/19.1: 2012/05/16.13:16:45 (mt) qdv__read_label() succeeded; read 65536 bytes
admin/19.1: 2012/05/16.13:16:45 (mt) exp time obtained from label
admin/19.1: 2012/05/16.13:16:45 (mt) qdb__label_event() returned vol_oid 164
admin/19.1: 2012/05/16.13:16:45 (mt) setting vol_oid in mount_info to 164
admin/19.1: 2012/05/16.13:16:45 (mt) updated volume close time from db
admin/19.1: 2012/05/16.13:16:46 (atv) qdv__mount succeeded
admin/19.1: 2012/05/16.13:16:46 (atv) automount worked
admin/19.1: 2012/05/16.13:16:46 (atv) qdv__automount_this_vol exited
admin/19.1: 2012/05/16.13:16:46 (gep) getting reservation for element 0x1 (dte)
admin/19.1: 2012/05/16.13:16:46 (amh) 9 automount worked - returning
admin/19.1: 2012/05/16.13:16:46 (amh) end of automount at 2012/05/16.13:16:46 (0x0)
admin/19.1: 2012/05/16.13:16:46 (amh) returning from qdv__automount_in_mh
admin/19.1: 2012/05/16.13:16:46 Info: volume in hprs1_tape1 is usable for this operation.
admin/19.1: 2012/05/16.13:16:46 (pvfw) at BOT
admin/19.1: 2012/05/16.13:16:46 (pvfw) previous state is invalid
admin/19.1: 2012/05/16.13:16:46 (alv) backup image label is valid, file 1, section 1
admin/19.1: 2012/05/16.13:16:46 (pvfw) invalidating tape position in mount db
admin/19.1: 2012/05/16.13:16:46 (ial) invalidate backup image label (was valid)
admin/19.1: 2012/05/16.13:16:57 (pvfw) space to EOD
admin/19.1: 2012/05/16.13:16:57 (pvfw) inspect_recs BSR: rtypes [0] = filemark
admin/19.1: 2012/05/16.13:16:57 (pvfw) inspect_recs BSR: rtypes [1] = filemark
admin/19.1: 2012/05/16.13:16:57 (pvfw) inspect_recs BSR: rtypes [2] = data
admin/19.1: 2012/05/16.13:16:57 (pvfw) inspect_recs BSR: rtypes [3] = filemark
admin/19.1: 2012/05/16.13:16:57 (pvfw) inspect_recs FSF
admin/19.1: 2012/05/16.13:16:57 (pvfw) inspect_recs ready to mount
admin/19.1: 2012/05/16.13:16:57 (pvfw) mounting at inspect_rec's request in rw_mode 2
admin/19.1: 2012/05/16.13:17:03 (pvfw) mounted ok
admin/19.1: 2012/05/16.13:17:03 (pvfw) at OB EOD, returning (2)
admin/19.1: 2012/05/16.13:17:03 (pvfw) pos_vol_cleanup not returning pstate
admin/19.1: 13:17:04 OBTR: obtar version 10.4.0.1.0 (AIX) -- Fri Sep 23 23:54:04 PDT 2011
admin/19.1: Copyright (c) 1992, 2011, Oracle. All rights reserved.
admin/19.1: 13:17:04 OBTR: obtar -Xjob:admin/19.1 -Xob:10.4 -Xstat -Xbga:admin/19.1 -y /u02/tmp/admin@19.1.obstat -g /u02/tmp/admin@19.1.obbdf -JJJJv -F2 -f hprs1_tape1 -Xrescookie:0xCDD1A02F -H hprs1 -L 0 -zR
admin/19.1: 13:17:04 OBTR: running as root/system
admin/19.1: 13:17:04 OBTR: record storage set to internal memory
admin/19.1: 13:17:04 ATAL: reserved drive hprs1_tape1, cookie 0xCDD1A02F
admin/19.1: 13:17:04 OBTR: obsd=1, is_job=1, is_priv=0, os=5
admin/19.1: 13:17:04 OBTR: rights established for user admin, class admin
admin/19.1: 13:17:04 SUUI: user info root/root, ??/??
admin/19.1: 13:17:04 PBDF: +/u02/app/oracle/imp
admin/19.1: 13:17:04 PBDF: !core
admin/19.1: 13:17:04 PBDF: !*~
admin/19.1: 13:17:06 MAIN: using blocking factor 128 from media defaults/policies
admin/19.1: 13:17:06 STTY: background terminal I/O or is a tty
admin/19.1: 13:17:06 MAIN: interactive
admin/19.1: 13:17:06 SET: volume has no expiration time
admin/19.1: 13:17:08 CNPC: data host reports this butype_info:
admin/19.1: 13:17:08 CNPC: tar (attr 0x2C78: B_DIRECT, R_DIRECT, B_INCR, R_INCR, B_FH_DIR)
admin/19.1: 13:17:08 CNPC: DIRECT = y
admin/19.1: 13:17:08 CNPC: HISTORY = y
admin/19.1: 13:17:08 CNPC: LEVEL = 0
admin/19.1: 13:17:10 DOLM: nop (for hprs1_tape1 (raw device "/dev/obt0"))
admin/19.1: 13:17:10 DOLM: ok
admin/19.1: 13:17:12 RLE: connecting to volume/archive database host
admin/19.1: 13:17:13 RLE: device hprs1_tape1 (raw device "/dev/obt0")
admin/19.1: 13:17:13 RLE: mount_info is valid
admin/19.1: 13:17:13 RLE: qdb__device_spec_se reports vol_oid 0, arch_oid 0
admin/19.1: 13:17:13 A_O: using max blocking factor 4096 from device object
admin/19.1: 13:17:13 A_O: resetting read and write error counters to 0
admin/19.1: 13:17:13 A_O: tape device is local
admin/19.1: 13:17:13 A_O: Devname: HP,Ultrium 2-SCSI,F6AW
admin/19.1: 13:17:13 Info version: 11
admin/19.1: 13:17:13 WS version: 10.4
admin/19.1: 13:17:13 Driver version: 10.4
admin/19.1: 13:17:13 Max DMA: 2097152
admin/19.1: 13:17:13 Blocksize in use: 65536
admin/19.1: 13:17:13 Query frequency: 134217728
admin/19.1: 13:17:13 Rewind on close: false
admin/19.1: 13:17:13 Can compress: true
admin/19.1: 13:17:13 Compression enabled: true
admin/19.1: 13:17:13 Device supports encryption: false
admin/19.1: 13:17:13 8200 media: false
admin/19.1: 13:17:13 Error threshold: 8%
admin/19.1: 13:17:13 Remaining tape: 205015040
admin/19.1:
admin/19.1: 13:17:13 A_GB: ar_block at 0x11064C000, size=2097152
admin/19.1: 13:17:13 A_GB: ar_block_enc at 0x11084E000, size=2097152
admin/19.1: 13:17:13 ADMS: reset library tape selection state
admin/19.1: 13:17:13 ADMS: reset complete
admin/19.1: 13:17:13 VLBR: not at bot: 0x90000000
admin/19.1: Warning: read of 2097152 (0x200000) bytes failed - I/O error (NDMP client)
admin/19.1: Warning: (device code/resid/checks = 0x20002607/0x0/0x0)
admin/19.1: Warning: read of 2097152 (0x200000) bytes failed - I/O error (NDMP client)
admin/19.1: Warning: (device code/resid/checks = 0x20002607/0x0/0x0)
admin/19.1: 13:17:13 RLE: noticed nil label
admin/19.1: 13:17:13 RLE: qdb__noticed_se reports vol_oid 0, arch_oid 0
admin/19.1: 13:17:22 ACFD: positioning (SCSI LOCATE) is available for this device
admin/19.1: 13:17:22 GLMT: returning "PAA839L2", code = 0x0
admin/19.1: 13:17:22 VLBR: from chk_lm_tag: "PAA839L2", code = 0x0
admin/19.1: 13:17:22 VLBR: master tag set to "PAA839L2"
admin/19.1: Warning: read of 2097152 (0x200000) bytes failed - I/O error (NDMP client)
admin/19.1: Warning: (device code/resid/checks = 0x20002607/0x0/0x0)
admin/19.1: 13:17:25 BT: resid is 1
admin/19.1: Warning: read of 2097152 (0x200000) bytes failed - I/O error (NDMP client)
admin/19.1: Warning: (device code/resid/checks = 0x20002607/0x0/0x0)
admin/19.1: 13:17:25 RLE: noticed nil label
admin/19.1: 13:17:25 RLE: qdb__noticed_se reports vol_oid 0, arch_oid 0
admin/19.1: 13:17:25 PF: no label found
admin/19.1: Error: this tape is not labeled. You cannot mix labeled and unlabeled backup images
admin/19.1: on the same volume set
admin/19.1: 13:17:25 QREX: exit status upon entry is 53
admin/19.1: 13:17:25 RBTR: trouble reporting time used: handle not open (OB library mgr)
admin/19.1: 13:17:25 QREX: released reservation on tape drive hprs1_tape1
admin/19.1: 13:17:25 QREX: [17170488] connecting to hprs1 to import and/or delete ascii index file for client hprs1
admin/19.1:
admin/19.1: Backup statistics:
admin/19.1: status 53
admin/19.1: devices hprs1_tape1
admin/19.1: devices 1
admin/19.1: volumes <none>
admin/19.1: voltags <none>
admin/19.1: file 2
admin/19.1: host hprs1
admin/19.1: encryption off
admin/19.1: start_time Wed May 16 2012 at 13:17:04 (1337163424)
admin/19.1: end_time Wed May 16 2012 at 13:17:25 (1337163445)
admin/19.1: backup_time Wed May 16 2012 at 13:17:04 (1337163424)
admin/19.1: entries_scanned 0
admin/19.1: kbytes_scanned 0
admin/19.1: entries_excluded 0
admin/19.1: entries_skipped 0
admin/19.1: mount_points_skipped 0
admin/19.1: files 0
admin/19.1: directories 0
admin/19.1: hardlinks 0
admin/19.1: symlinks 0
admin/19.1: sparse_files 0
admin/19.1: filesys_errors 0
admin/19.1: unknown_type 0
admin/19.1: file_kbytes 0
admin/19.1: dev_kbytes 0
admin/19.1: dev_iosecs 0
admin/19.1: dev_iorate 1.0 KB/S
admin/19.1: wrt_iosecs 21
admin/19.1: wrt_iorate 48.8 B/S
admin/19.1: physical_blks_written 0
admin/19.1: write_errors 0
admin/19.1: physical_blks_read 0
admin/19.1: read_errors 0
admin/19.1: error_rate 0%
admin/19.1: path /u02/app/oracle/imp not started
admin/19.1: 13:17:25 RLYX: exit status 53; checking allocs...
admin/19.1: 13:17:25 RLYX: from mm__check_all: 1
admin/19.1: 2012/05/16.13:20:06 ______________________________________________________________________
admin/19.1: 2012/05/16.13:20:06
admin/19.1: 2012/05/16.13:20:06 Transcript for job admin/19.1 running on hprs1
admin/19.1: 2012/05/16.13:20:06
admin/19.1: 2012/05/16.13:20:17 Info: mount data verified.
admin/19.1: 2012/05/16.13:20:17 Info: volume in hprs1_tape1 is usable for this operation.
admin/19.1: 2012/05/16.13:20:17 (pvfw) at BOT
admin/19.1: 2012/05/16.13:20:17 (pvfw) previous state is invalid
admin/19.1: 2012/05/16.13:20:17 (alv) backup image label is valid, file 1, section 1
admin/19.1: 2012/05/16.13:20:17 (pvfw) invalidating tape position in mount db
admin/19.1: 2012/05/16.13:20:17 (ial) invalidate backup image label (was valid)
admin/19.1: 2012/05/16.13:20:27 (pvfw) space to EOD
admin/19.1: 2012/05/16.13:20:27 (pvfw) inspect_recs BSR: rtypes [0] = filemark
admin/19.1: 2012/05/16.13:20:27 (pvfw) inspect_recs BSR: rtypes [1] = filemark
admin/19.1: 2012/05/16.13:20:27 (pvfw) inspect_recs BSR: rtypes [2] = data
admin/19.1: 2012/05/16.13:20:27 (pvfw) inspect_recs BSR: rtypes [3] = filemark
admin/19.1: 2012/05/16.13:20:27 (pvfw) inspect_recs FSF
admin/19.1: 2012/05/16.13:20:27 (pvfw) inspect_recs ready to mount
admin/19.1: 2012/05/16.13:20:27 (pvfw) mounting at inspect_rec's request in rw_mode 2
admin/19.1: 2012/05/16.13:20:33 (pvfw) mounted ok
admin/19.1: 2012/05/16.13:20:33 (pvfw) at OB EOD, returning (2)
admin/19.1: 2012/05/16.13:20:33 (pvfw) pos_vol_cleanup not returning pstate
admin/19.1: 13:20:34 OBTR: obtar version 10.4.0.1.0 (AIX) -- Fri Sep 23 23:54:04 PDT 2011
admin/19.1: Copyright (c) 1992, 2011, Oracle. All rights reserved.
admin/19.1: 13:20:34 OBTR: obtar -Xjob:admin/19.1 -Xob:10.4 -Xstat -Xbga:admin/19.1 -y /u02/tmp/admin@19.1.obstat -g /u02/tmp/admin@19.1.obbdf -JJJJv -F2 -f hprs1_tape1 -Xrescookie:0xCDD1A036 -H hprs1 -L 0 -zR
admin/19.1: 13:20:34 OBTR: running as root/system
admin/19.1: 13:20:34 OBTR: record storage set to internal memory
admin/19.1: 13:20:34 ATAL: reserved drive hprs1_tape1, cookie 0xCDD1A036
admin/19.1: 13:20:34 OBTR: obsd=1, is_job=1, is_priv=0, os=5
admin/19.1: 13:20:34 OBTR: rights established for user admin, class admin
admin/19.1: 13:20:34 SUUI: user info root/root, ??/??
admin/19.1: 13:20:34 PBDF: +/u02/app/oracle/imp
admin/19.1: 13:20:34 PBDF: !core
admin/19.1: 13:20:34 PBDF: !*~
admin/19.1: 13:20:35 MAIN: using blocking factor 128 from media defaults/policies
admin/19.1: 13:20:35 STTY: background terminal I/O or is a tty
admin/19.1: 13:20:35 MAIN: interactive
admin/19.1: 13:20:35 SET: volume has no expiration time
admin/19.1: 13:20:37 CNPC: data host reports this butype_info:
admin/19.1: 13:20:37 CNPC: tar (attr 0x2C78: B_DIRECT, R_DIRECT, B_INCR, R_INCR, B_FH_DIR)
admin/19.1: 13:20:37 CNPC: DIRECT = y
admin/19.1: 13:20:37 CNPC: HISTORY = y
admin/19.1: 13:20:37 CNPC: LEVEL = 0
admin/19.1: 13:20:39 DOLM: nop (for hprs1_tape1 (raw device "/dev/obt0"))
admin/19.1: 13:20:39 DOLM: ok
admin/19.1: 13:20:42 RLE: connecting to volume/archive database host
admin/19.1: 13:20:43 RLE: device hprs1_tape1 (raw device "/dev/obt0")
admin/19.1: 13:20:43 RLE: mount_info is valid
admin/19.1: 13:20:43 RLE: qdb__device_spec_se reports vol_oid 0, arch_oid 0
admin/19.1: 13:20:43 A_O: using max blocking factor 4096 from device object
admin/19.1: 13:20:43 A_O: resetting read and write error counters to 0
admin/19.1: 13:20:43 A_O: tape device is local
admin/19.1: 13:20:43 A_O: Devname: HP,Ultrium 2-SCSI,F6AW
admin/19.1: 13:20:43 Info version: 11
admin/19.1: 13:20:43 WS version: 10.4
admin/19.1: 13:20:43 Driver version: 10.4
admin/19.1: 13:20:43 Max DMA: 2097152
admin/19.1: 13:20:43 Blocksize in use: 65536
admin/19.1: 13:20:43 Query frequency: 134217728
admin/19.1: 13:20:43 Rewind on close: false
admin/19.1: 13:20:43 Can compress: true
admin/19.1: 13:20:43 Compression enabled: true
admin/19.1: 13:20:43 Device supports encryption: false
admin/19.1: 13:20:43 8200 media: false
admin/19.1: 13:20:43 Error threshold: 8%
admin/19.1: 13:20:43 Remaining tape: 205015040
admin/19.1:
admin/19.1: 13:20:43 A_GB: ar_block at 0x11064C000, size=2097152
admin/19.1: 13:20:43 A_GB: ar_block_enc at 0x11084E000, size=2097152
admin/19.1: 13:20:43 ADMS: reset library tape selection state
admin/19.1: 13:20:43 ADMS: reset complete
admin/19.1: 13:20:43 VLBR: not at bot: 0x90000000
admin/19.1: Warning: read of 2097152 (0x200000) bytes failed - I/O error (NDMP client)
admin/19.1: Warning: (device code/resid/checks = 0x20002607/0x0/0x0)
admin/19.1: Warning: read of 2097152 (0x200000) bytes failed - I/O error (NDMP client)
admin/19.1: Warning: (device code/resid/checks = 0x20002607/0x0/0x0)
admin/19.1: 13:20:43 RLE: noticed nil label
admin/19.1: 13:20:43 RLE: qdb__noticed_se reports vol_oid 0, arch_oid 0
admin/19.1: 13:20:52 ACFD: positioning (SCSI LOCATE) is available for this device
admin/19.1: 13:20:52 GLMT: returning "PAA839L2", code = 0x0
admin/19.1: 13:20:52 VLBR: from chk_lm_tag: "PAA839L2", code = 0x0
admin/19.1: 13:20:52 VLBR: master tag set to "PAA839L2"
admin/19.1: Warning: read of 2097152 (0x200000) bytes failed - I/O error (NDMP client)
admin/19.1: Warning: (device code/resid/checks = 0x20002607/0x0/0x0)
admin/19.1: 13:20:55 BT: resid is 1
admin/19.1: Warning: read of 2097152 (0x200000) bytes failed - I/O error (NDMP client)
admin/19.1: Warning: (device code/resid/checks = 0x20002607/0x0/0x0)
admin/19.1: 13:20:55 RLE: noticed nil label
admin/19.1: 13:20:55 RLE: qdb__noticed_se reports vol_oid 0, arch_oid 0
admin/19.1: 13:20:55 PF: no label found
admin/19.1: Error: this tape is not labeled. You cannot mix labeled and unlabeled backup images
admin/19.1: on the same volume set
admin/19.1: 13:20:55 QREX: exit status upon entry is 53
admin/19.1: 13:20:55 RBTR: trouble reporting time used: handle not open (OB library mgr)
admin/19.1: 13:20:55 QREX: released reservation on tape drive hprs1_tape1
admin/19.1: 13:20:55 QREX: [14811562] connecting to hprs1 to import and/or delete ascii index file for client hprs1
admin/19.1:
admin/19.1: Backup statistics:
admin/19.1: status 53
admin/19.1: devices hprs1_tape1
admin/19.1: devices 1
admin/19.1: volumes <none>
admin/19.1: voltags <none>
admin/19.1: file 2
admin/19.1: host hprs1
admin/19.1: encryption off
admin/19.1: start_time Wed May 16 2012 at 13:20:34 (1337163634)
admin/19.1: end_time Wed May 16 2012 at 13:20:56 (1337163656)
admin/19.1: backup_time Wed May 16 2012 at 13:20:34 (1337163634)
admin/19.1: entries_scanned 0
admin/19.1: kbytes_scanned 0
admin/19.1: entries_excluded 0
admin/19.1: entries_skipped 0
admin/19.1: mount_points_skipped 0
admin/19.1: files 0
admin/19.1: directories 0
admin/19.1: hardlinks 0
admin/19.1: symlinks 0
admin/19.1: sparse_files 0
admin/19.1: filesys_errors 0
admin/19.1: unknown_type 0
admin/19.1: file_kbytes 0
admin/19.1: dev_kbytes 0
admin/19.1: dev_iosecs 0
admin/19.1: dev_iorate 1.0 KB/S
admin/19.1: wrt_iosecs 22
admin/19.1: wrt_iorate 46.5 B/S
admin/19.1: physical_blks_written 0
admin/19.1: write_errors 0
admin/19.1: physical_blks_read 0
admin/19.1: read_errors 0
admin/19.1: error_rate 0%
admin/19.1: path /u02/app/oracle/imp not started
admin/19.1: 13:20:56 RLYX: exit status 53; checking allocs...
admin/19.1: 13:20:56 RLYX: from mm__check_all: 1
admin/19.1: 2012/05/16.13:23:06 ______________________________________________________________________
admin/19.1: 2012/05/16.13:23:06
admin/19.1: 2012/05/16.13:23:06 Transcript for job admin/19.1 running on hprs1
admin/19.1: 2012/05/16.13:23:06
admin/19.1: 2012/05/16.13:23:16 Info: mount data verified.
admin/19.1: 2012/05/16.13:23:16 Info: volume in hprs1_tape1 is usable for this operation.
admin/19.1: 2012/05/16.13:23:16 (pvfw) at BOT
admin/19.1: 2012/05/16.13:23:16 (pvfw) previous state is invalid
admin/19.1: 2012/05/16.13:23:16 (alv) backup image label is valid, file 1, section 1
admin/19.1: 2012/05/16.13:23:16 (pvfw) invalidating tape position in mount db
admin/19.1: 2012/05/16.13:23:16 (ial) invalidate backup image label (was valid)
admin/19.1: 2012/05/16.13:23:27 (pvfw) space to EOD
admin/19.1: 2012/05/16.13:23:27 (pvfw) inspect_recs BSR: rtypes [0] = filemark
admin/19.1: 2012/05/16.13:23:27 (pvfw) inspect_recs BSR: rtypes [1] = filemark
admin/19.1: 2012/05/16.13:23:27 (pvfw) inspect_recs BSR: rtypes [2] = data
admin/19.1: 2012/05/16.13:23:27 (pvfw) inspect_recs BSR: rtypes [3] = filemark
admin/19.1: 2012/05/16.13:23:27 (pvfw) inspect_recs FSF
admin/19.1: 2012/05/16.13:23:27 (pvfw) inspect_recs ready to mount
admin/19.1: 2012/05/16.13:23:27 (pvfw) mounting at inspect_rec's request in rw_mode 2
admin/19.1: 2012/05/16.13:23:33 (pvfw) mounted ok
admin/19.1: 2012/05/16.13:23:33 (pvfw) at OB EOD, returning (2)
admin/19.1: 2012/05/16.13:23:33 (pvfw) pos_vol_cleanup not returning pstate
admin/19.1: 13:23:33 OBTR: obtar version 10.4.0.1.0 (AIX) -- Fri Sep 23 23:54:04 PDT 2011
admin/19.1: Copyright (c) 1992, 2011, Oracle. All rights reserved.
admin/19.1: 13:23:33 OBTR: obtar -Xjob:admin/19.1 -Xob:10.4 -Xstat -Xbga:admin/19.1 -y /u02/tmp/admin@19.1.obstat -g /u02/tmp/admin@19.1.obbdf -JJJJv -F2 -f hprs1_tape1 -Xrescookie:0xCDD1A03C -H hprs1 -L 0 -zR
admin/19.1: 13:23:33 OBTR: running as root/system
admin/19.1: 13:23:33 OBTR: record storage set to internal memory
admin/19.1: 13:23:33 ATAL: reserved drive hprs1_tape1, cookie 0xCDD1A03C
admin/19.1: 13:23:34 OBTR: obsd=1, is_job=1, is_priv=0, os=5
admin/19.1: 13:23:34 OBTR: rights established for user admin, class admin
admin/19.1: 13:23:34 SUUI: user info root/root, ??/??
admin/19.1: 13:23:34 PBDF: +/u02/app/oracle/imp
admin/19.1: 13:23:34 PBDF: !core
admin/19.1: 13:23:34 PBDF: !*~
admin/19.1: 13:23:35 MAIN: using blocking factor 128 from media defaults/policies
admin/19.1: 13:23:35 STTY: background terminal I/O or is a tty
admin/19.1: 13:23:35 MAIN: interactive
admin/19.1: 13:23:35 SET: volume has no expiration time
admin/19.1: 13:23:37 CNPC: data host reports this butype_info:
admin/19.1: 13:23:37 CNPC: tar (attr 0x2C78: B_DIRECT, R_DIRECT, B_INCR, R_INCR, B_FH_DIR)
admin/19.1: 13:23:37 CNPC: DIRECT = y
admin/19.1: 13:23:37 CNPC: HISTORY = y
admin/19.1: 13:23:37 CNPC: LEVEL = 0
admin/19.1: 13:23:39 DOLM: nop (for hprs1_tape1 (raw device "/dev/obt0"))
admin/19.1: 13:23:39 DOLM: ok
admin/19.1: 13:23:41 RLE: connecting to volume/archive database host
admin/19.1: 13:23:42 RLE: device hprs1_tape1 (raw device "/dev/obt0")
admin/19.1: 13:23:42 RLE: mount_info is valid
admin/19.1: 13:23:42 RLE: qdb__device_spec_se reports vol_oid 0, arch_oid 0
admin/19.1: 13:23:42 A_O: using max blocking factor 4096 from device object
admin/19.1: 13:23:42 A_O: resetting read and write error counters to 0
admin/19.1: 13:23:42 A_O: tape device is local
admin/19.1: 13:23:42 A_O: Devname: HP,Ultrium 2-SCSI,F6AW
admin/19.1: 13:23:42 Info version: 11
admin/19.1: 13:23:42 WS version: 10.4
admin/19.1: 13:23:42 Driver version: 10.4
admin/19.1: 13:23:42 Max DMA: 2097152
admin/19.1: 13:23:42 Blocksize in use: 65536
admin/19.1: 13:23:42 Query frequency: 134217728
admin/19.1: 13:23:42 Rewind on close: false
admin/19.1: 13:23:42 Can compress: true
admin/19.1: 13:23:42 Compression enabled: true
admin/19.1: 13:23:42 Device supports encryption: false
admin/19.1: 13:23:42 8200 media: false
admin/19.1: 13:23:42 Error threshold: 8%
admin/19.1: 13:23:42 Remaining tape: 205015040
admin/19.1:
admin/19.1: 13:23:42 A_GB: ar_block at 0x11064C000, size=2097152
admin/19.1: 13:23:42 A_GB: ar_block_enc at 0x11084E000, size=2097152
admin/19.1: 13:23:42 ADMS: reset library tape selection state
admin/19.1: 13:23:42 ADMS: reset complete
admin/19.1: 13:23:42 VLBR: not at bot: 0x90000000
admin/19.1: Warning: read of 2097152 (0x200000) bytes failed - I/O error (NDMP client)
admin/19.1: Warning: (device code/resid/checks = 0x20002607/0x0/0x0)
admin/19.1: Warning: read of 2097152 (0x200000) bytes failed - I/O error (NDMP client)
admin/19.1: Warning: (device code/resid/checks = 0x20002607/0x0/0x0)
admin/19.1: 13:23:42 RLE: noticed nil label
admin/19.1: 13:23:42 RLE: qdb__noticed_se reports vol_oid 0, arch_oid 0
admin/19.1: 13:23:51 ACFD: positioning (SCSI LOCATE) is available for this device
admin/19.1: 13:23:51 GLMT: returning "PAA839L2", code = 0x0
admin/19.1: 13:23:51 VLBR: from chk_lm_tag: "PAA839L2", code = 0x0
admin/19.1: 13:23:51 VLBR: master tag set to "PAA839L2"
admin/19.1: Warning: read of 2097152 (0x200000) bytes failed - I/O error (NDMP client)
admin/19.1: Warning: (device code/resid/checks = 0x20002607/0x0/0x0)
admin/19.1: 13:23:54 BT: resid is 1
admin/19.1: Warning: read of 2097152 (0x200000) bytes failed - I/O error (NDMP client)
admin/19.1: Warning: (device code/resid/checks = 0x20002607/0x0/0x0)
admin/19.1: 13:23:54 RLE: noticed nil label
admin/19.1: 13:23:54 RLE: qdb__noticed_se reports vol_oid 0, arch_oid 0
admin/19.1: 13:23:54 PF: no label found
admin/19.1: Error: this tape is not labeled. You cannot mix labeled and unlabeled backup images
admin/19.1: on the same volume set
admin/19.1: 13:23:54 QREX: exit status upon entry is 53
admin/19.1: 13:23:54 RBTR: trouble reporting time used: handle not open (OB library mgr)
admin/19.1: 13:23:54 QREX: released reservation on tape drive hprs1_tape1
admin/19.1: 13:23:54 QREX: [7536928] connecting to hprs1 to import and/or delete ascii index file for client hprs1
admin/19.1:
admin/19.1: Backup statistics:
admin/19.1: status 53
admin/19.1: devices hprs1_tape1
admin/19.1: devices 1
admin/19.1: volumes <none>
admin/19.1: voltags <none>
admin/19.1: file 2
admin/19.1: host hprs1
admin/19.1: encryption off
admin/19.1: start_time Wed May 16 2012 at 13:23:33 (1337163813)
admin/19.1: end_time Wed May 16 2012 at 13:23:54 (1337163834)
admin/19.1: backup_time Wed May 16 2012 at 13:23:33 (1337163813)
admin/19.1: entries_scanned 0
admin/19.1: kbytes_scanned 0
admin/19.1: entries_excluded 0
admin/19.1: entries_skipped 0
admin/19.1: mount_points_skipped 0
admin/19.1: files 0
admin/19.1: directories 0
admin/19.1: hardlinks 0
admin/19.1: symlinks 0
admin/19.1: sparse_files 0
admin/19.1: filesys_errors 0
admin/19.1: unknown_type 0
admin/19.1: file_kbytes 0
admin/19.1: dev_kbytes 0
admin/19.1: dev_iosecs 0
admin/19.1: dev_iorate 1.0 KB/S
admin/19.1: wrt_iosecs 21
admin/19.1: wrt_iorate 48.8 B/S
admin/19.1: physical_blks_written 0
admin/19.1: write_errors 0
admin/19.1: physical_blks_read 0
admin/19.1: read_errors 0
admin/19.1: error_rate 0%
admin/19.1: path /u02/app/oracle/imp not started
admin/19.1: 13:23:54 RLYX: exit status 53; checking allocs...
admin/19.1: 13:23:54 RLYX: from mm__check_all: 1