Oracle HSM: Status Shows Tape Drive down: can not clear drive, move failed

(Doc ID 2348038.1)

Last updated on JANUARY 18, 2018

Applies to:

Oracle Hierarchical Storage Manager (HSM) and StorageTek QFS Software - Version 5.0 to 6.1 [Release 5.0 to 6.0]
Information in this document applies to any platform.

Symptoms

 The 'samcmd t' command shows a tape drive 'down' status, "can not clear drive, move failed".

root@fst-mds1:~# samcmd t

Tape drive status samcmd 6.1.18 18:11:23 Dec 14 2017
samcmd on fst-mds1.naist.jp

ty eq status act use state vsn
ti 901 ---------p 0 0% notrdy
empty
ti 902 ---------p 0 0% down
can not clear drive, move failed
root@fst-mds1:~#

root@fst-mds1:~# samcmd off 902
root@fst-mds1:~#
root@fst-mds1:~# samcmd on 902
root@fst-mds1:~#
root@fst-mds1:~# samcmd t

Tape drive status samcmd 6.1.18 11:58:54 Dec 15 2017
samcmd on fst-mds1.naist.jp

ty eq status act use state vsn
ti 901 ---------p 0 0% notrdy
empty
ti 902 ---------p 0 0% down
can not clear drive, move failed
root@fst-mds1:~#

 The 'samcmd v' command shows volume status 'Unavailable' ('U' bit) and has no "o" bit set

samcmd v

590 2017/12/13 06:32 155 51% -il---b---U- ti 140590

 ACSLS checked the volume returned to Home Cell

ACSSA> q volume 140590
2018-01-12 09:32:55 Volume Status
Identifier Status Current Location Type
140590 home 0, 0,18, 4, 0 T10000T2
ACSSA>

 

 From sam-log file we can see that SAMFS was trying to dismount the media/volume from drive 902.

/var/adm/messages:
=============
Dec 15 11:58:07 fst-mds1.naist.jp stk-900[1822]: [ID 702911 local7.crit] Device 902: State set to OFF by user. Check device log.
Dec 15 11:58:07 fst-mds1.naist.jp stk-900[1822]: [ID 702911 local7.alert] Volume is in drive 902 that is off or down.
Dec 15 11:58:46 fst-mds1.naist.jp stk-900[1822]: [ID 702911 local7.error] clear_drive(902): Move failed.
Dec 15 11:58:46 fst-mds1.naist.jp stk-900[1822]: [ID 702911 local7.crit] crit Device 902: State set to DOWN by Oracle HSM. Check device log.
Dec 15 11:58:46 fst-mds1.naist.jp stk-900[1822]: [ID 702911 local7.alert] Volume is in drive 902 that is off or down.

/var/adm/sam-log:
=============
Dec 15 11:58:07 fst-mds1.naist.jp stk-900[1822]: [ID 702911 local7.crit] Device 902: State set to OFF by user. Check device log.
Dec 15 11:58:07 fst-mds1.naist.jp stk-900[1822]: [ID 702911 local7.alert] Volume is in drive 902 that is off or down.
Dec 15 11:58:07 fst-mds1.naist.jp stk-900[1822]: [ID 702911 local7.notice] Volume (900:590) in drive 902 set to Unavailable.
Dec 15 11:58:46 fst-mds1.naist.jp stk-900[1822]: [ID 702911 local7.info] dismount_media:0,1,1,0:returned:STATUS_DRIVE_AVAILABLE
Dec 15 11:58:46 fst-mds1.naist.jp stk-900[1822]: [ID 702911 local7.error] clear_drive(902): Move failed.
Dec 15 11:58:46 fst-mds1.naist.jp stk-900[1822]: [ID 702911 local7.crit] crit Device 902: State set to DOWN by Oracle HSM. Check device log.
Dec 15 11:58:46 fst-mds1.naist.jp stk-900[1822]: [ID 702911 local7.alert] Volume is in drive 902 that is off or down.
Dec 15 11:58:46 fst-mds1.naist.jp stk-900[1822]: [ID 702911 local7.notice] Volume (900:590) in drive 902 set to Unavailable.

/var/opt/SUNWsamfs/devlog/902:
====================
2017/12/15 11:58:07 1009 [1822:5] Changing state to OFF
2017/12/15 11:58:21 1002 [1822:5] Device is STK , T10000D
2017/12/15 11:58:21 1003 [1822:5] Serial 579004002201, rev 4.11.111
2017/12/15 11:58:21 1005 [1822:5] Known as STK Titanium Tape(ti)
2017/12/15 11:58:21 12001 [1822:5] TapeAlert supported
2017/12/15 11:58:21 3261 [1822:5] VolSafe media supported
2017/12/15 11:58:21 3358 [1822:5] XCopy copymgr supported
2017/12/15 11:58:21 11100 [1822:5] SEF supported
2017/12/15 11:58:21 0000 [1822:5] cdb: 03 00 00 00 20 00
2017/12/15 11:58:21 0000 [1822:5] cdb: 03 00 00 00 20 00
2017/12/15 11:58:46 1008 [1822:5] Changing state to DOWN
2017/12/15 11:58:46 1008 [1822:5] Changing state to DOWN

 But, from ACSLS and SL8500 Snapshot, we know that the drive status in Empty.

ACSSA> query drive all
2017-12-15 09:43:11 Drive Status
Identifier State Status Volume Type
0, 0, 1, 3 online available T1D
0, 0, 1,15 online available T1D
0, 1, 1, 0 online available T1D                                         <- Here
0, 1, 1,12 online available T1D
0, 2, 1, 0 online available T1D
0, 2, 1,12 online available T1D
0, 3, 1, 0 online available T1D
0, 3, 1,12 online available T1D
ACSSA>

From Library Log, Current Drive status is empty
-----------------------------------------
Drive Address Bay DMOD # Tray Serial # Type Vendor Drive Status Firmware Tray Health IP
1.1.-2.1.4 52 579004000240 unknown T10000d StorageTek empty 4.11.111-5.60 ok 172.18.18.100
1.1.2.1.4 49 579004002249 unknown T10000d StorageTek empty 4.11.111-5.60 ok 172.18.18.101
1.2.-2.1.1 48 579004002201 unknown T10000d StorageTek empty 4.11.111-5.60 ok 172.18.18.102     <- Here
1.2.2.1.1 45 579004002272 unknown T10000d StorageTek empty 4.11.111-5.60 ok 172.18.18.103
1.3.-2.1.1 32 579004002253 unknown T10000d StorageTek empty 4.11.111-5.60 ok 172.18.18.104
1.3.2.1.1 29 579004002263 unknown T10000d StorageTek empty 4.11.111-5.60 ok 172.18.18.105
1.4.-2.1.1 16 579004002251 unknown T10000d StorageTek empty 4.11.111-5.60 ok 172.18.18.106
1.4.2.1.1 13 579004005990 unknown T10000d StorageTek empty 4.11.111-5.60 ok 172.18.18.107

 

Cause

Sign In with your My Oracle Support account

Don't have a My Oracle Support account? Click to get started

My Oracle Support provides customers with access to over a
Million Knowledge Articles and hundreds of Community platforms