mhVTL - A Linux Virtual Tape Library

TSM not recognising correct IBM drive type

classic Classic list List threaded Threaded
♦
♦
 14 messages Options
Tiger22
Reply | Threaded
Open this post in threaded view
♦
♦
|

TSM not recognising correct IBM drive type

Tiger22
I've been successfully using mhVTL with TSM on a platform which is all Linux. I have just tried to install TSM on windows 2003 and connect to the mhVTL library via iSCSI (using tgt framework on Linux). On Windows I am using the IBMtape drivers with IBM some defined library/drives in mhVTL.

Everything goes OK until the very last stage - the point where I try and label some LTO3 media and check the tapes into the TSM library. At this point TSM seems to think that the media is 3592 and not LTO3 and complains it cannot find an appropriate drive to load the media into (ANR8847E No  3592-type drives are currently available in library IBM_VTL).

Any ideas? Here is some config/diagnosis:

[root@mhvtl mhvtl]# cat device.conf
VERSION: 5

Library: 10 CHANNEL: 00 TARGET: 00 LUN: 00
 Vendor identification: IBM
 Product identification: 03584L22
 Product revision level: 4.02
 Unit serial number: 70000050
 NAA: 30:22:33:44:ab:00:08:00
 Home directory: /opt/mhvtl
 Backoff: 400
# fifo: /var/tmp/mhvtl

Drive: 11 CHANNEL: 00 TARGET: 01 LUN: 00
 Library ID: 10 Slot: 01
 Vendor identification: IBM
 Product identification: ULT3580-TD3
 Unit serial number: 1068047945
 NAA: 10:22:33:44:ab:00:01:00
 Compression: factor 1 enabled 1
 Compression type: lzo
 Backoff: 400
# fifo: /var/tmp/mhvtl

Drive: 12 CHANNEL: 00 TARGET: 02 LUN: 00
 Library ID: 10 Slot: 02
 Vendor identification: IBM
 Product identification: ULT3580-TD3
 Product revision level: 252D
 Unit serial number: 70000051
 NAA: 50:11:22:33:ab:1:00:01
 Compression: factor 1 enabled 1
 Compression type: lzo
 Backoff: 400

Drive: 13 CHANNEL: 00 TARGET: 03 LUN: 00
 Library ID: 10 Slot: 03
 Vendor identification: IBM
 Product identification: ULT3580-TD3
 Product revision level: 252D
 Unit serial number: 70000052
 NAA: 50:11:22:33:ab:1:00:2
 Compression: factor 1 enabled 1
 Compression type: lzo
 Backoff: 400

Drive: 14 CHANNEL: 00 TARGET: 04 LUN: 00
 Library ID: 10 Slot: 04
 Vendor identification: IBM
 Product identification: ULT3580-TD3
 Product revision level: 252D
 Unit serial number: 70000053
 NAA: 50:11:22:33:ab:1:00:3
 Compression: factor 1 enabled 1
 Compression type: lzo
 Backoff: 400


 
 
[root@mhvtl mhvtl]# cat mhvtl.conf
# Home directory for config file(s)
MHVTL_CONFIG_PATH=/etc/mhvtl

# Default media capacity (500 M)
CAPACITY=500

# Set default verbosity [0|1|2|3]
VERBOSE=1

# Set kernel module debuging [0|1]
VTL_DEBUG=1




[root@mhvtl mhvtl]# cat library_contents.10

Drive 1:
Drive 2:
Drive 3:
Drive 4:

Picker 1:

MAP 1:
MAP 2:
MAP 3:
MAP 4:

# Slot 1 - ?, no gaps
# Slot N: [barcode]
# [barcode]
# a barcode is comprised of three fields: [Leading] [identifier] [Trailing]
# Leading "CLN" -- cleaning tape
# Leading "W" -- WORM tape
# Leading "NOBAR" -- will appear to have no barcode
# If the barcode is at least 8 character long, then the last two characters are Trailing
# Trailing "S3" - SDLT600
# Trailing "X4" - AIT-4
# Trailing "L1" - LTO 1, "L2" - LTO 2, "L3" - LTO 3, "L4" - LTO 4, "L5" - LTO 5
# Trailing "LT" - LTO 3 WORM, "LU" -  LTO 4 WORM, "LV" - LTO 5 WORM
# Trailing "L6" - LTO 6, "LW" - LTO 6 WORM
# Trailing "TA" - T10000+
# Trailing "TZ" - 9840A, "TY" - 9840B, "TX" - 9840C, "TW" - 9840D
# Trailing "TV" - 9940A, "TU" - 9940B
# Trailing "JA" - 3592+
# Trailing "JB" - 3592E05+
# Trailing "JW" - WORM 3592+
# Trailing "JX" - WORM 3592E05+
# Trailing "D7" - DLT7000 media (DLT IV)
#
Slot 1: E01001L3
Slot 2: E01002L3
Slot 3: E01003L3
Slot 4: E01004L3
Slot 5: E01005L3
Slot 6: E01006L3
Slot 7: E01007L3
Slot 8: E01008L3
Slot 9: E01009L3
Slot 10: E01010L3
Slot 11: E01011L3
Slot 12: E01012L3
Slot 13: E01013L3
Slot 14: E01014L3
Slot 15: E01015L3
Slot 16: E01016L3
Slot 17: E01017L3
Slot 18: E01018L3
Slot 19: E01019L3
Slot 20: E01020L3
Slot 21:
Slot 22:
Slot 23:
Slot 24:



Here are the commands within TSM I used to set up the library and drives:


tsm: VMTSM55WIN>define library IBM_VTL libtype=scsi
ANR8400I Library IBM_VTL defined.

tsm: VMTSM55WIN>define path VMTSM55WIN IBM_VTL srctype=server desttype=library device=lb0.5.0.3
ANR1720I A path from VMTSM55WIN to IBM_VTL has been defined.

tsm: VMTSM55WIN>q libr f=d

                  Library Name: IBM_VTL
                  Library Type: SCSI
                        ACS Id:
              Private Category:
              Scratch Category:
         WORM Scratch Category:
              External Manager:
                RSM Media Type:
                        Shared: No
                       LanFree:
            ObeyMountRetention:
       Primary Library Manager:
                           WWN:
                 Serial Number: 70000050
                     AutoLabel: No
                  Reset Drives: No
Last Update by (administrator): ADMIN
         Last Update Date/Time: 08/25/2013 23:34:15


tsm: VMTSM55WIN>define drive IBM_VTL DRIVE_1
ANR8404I Drive DRIVE_1 defined in library IBM_VTL.

tsm: VMTSM55WIN>define drive IBM_VTL DRIVE_2
ANR8404I Drive DRIVE_2 defined in library IBM_VTL.

tsm: VMTSM55WIN>define drive IBM_VTL DRIVE_3
ANR8404I Drive DRIVE_3 defined in library IBM_VTL.

tsm: VMTSM55WIN>define drive IBM_VTL DRIVE_4
ANR8404I Drive DRIVE_4 defined in library IBM_VTL.

tsm: VMTSM55WIN>define path VMTSM55WIN  DRIVE_1 srctype=server desttype=drive library=IBM_VTL device=mt0.1.0.3
ANR1720I A path from VMTSM55WIN to IBM_VTL DRIVE_1 has been defined.

tsm: VMTSM55WIN>define path VMTSM55WIN  DRIVE_2 srctype=server desttype=drive library=IBM_VTL device=mt0.2.0.3
ANR1720I A path from VMTSM55WIN to IBM_VTL DRIVE_2 has been defined.

tsm: VMTSM55WIN>define path VMTSM55WIN  DRIVE_3 srctype=server desttype=drive library=IBM_VTL device=mt0.3.0.3
ANR1720I A path from VMTSM55WIN to IBM_VTL DRIVE_3 has been defined.

tsm: VMTSM55WIN>define path VMTSM55WIN  DRIVE_4 srctype=server desttype=drive library=IBM_VTL device=mt0.4.0.3
ANR1720I A path from VMTSM55WIN to IBM_VTL DRIVE_4 has been defined.

tsm: VMTSM55WIN>q drive f=d

                                Library Name: IBM_VTL
                                  Drive Name: DRIVE_1
                                 Device Type: LTO
                                     On-Line: Yes
                                Read Formats: ULTRIUM3C,ULTRIUM3,ULTRIUM2C,ULTRIUM2,ULTRIUMC,ULTRIUM
                               Write Formats: ULTRIUM3C,ULTRIUM3,ULTRIUM2C,ULTRIUM2
                                     Element: 1
                                 Drive State: UNKNOWN
                                 Volume Name:
                                Allocated to:
                                         WWN: 50223344AB000100
                               Serial Number: 1068047945
              Last Update by (administrator): ADMIN
                       Last Update Date/Time: 08/25/2013 23:35:58
Cleaning Frequency (Gigabytes/ASNEEDED/NONE): NONE

                                Library Name: IBM_VTL
                                  Drive Name: DRIVE_2
                                 Device Type: LTO
                                     On-Line: Yes
                                Read Formats: ULTRIUM3C,ULTRIUM3,ULTRIUM2C,ULTRIUM2,ULTRIUMC,ULTRIUM
                               Write Formats: ULTRIUM3C,ULTRIUM3,ULTRIUM2C,ULTRIUM2
                                     Element: 2
                                 Drive State: UNKNOWN
                                 Volume Name:
                                Allocated to:
                                         WWN: 50112233AB010001
                               Serial Number: 70000051
              Last Update by (administrator): ADMIN
                       Last Update Date/Time: 08/25/2013 23:36:08
Cleaning Frequency (Gigabytes/ASNEEDED/NONE): NONE

                                Library Name: IBM_VTL
                                  Drive Name: DRIVE_3
                                 Device Type: LTO
                                     On-Line: Yes
                                Read Formats: ULTRIUM3C,ULTRIUM3,ULTRIUM2C,ULTRIUM2,ULTRIUMC,ULTRIUM
                               Write Formats: ULTRIUM3C,ULTRIUM3,ULTRIUM2C,ULTRIUM2
                                     Element: 3
                                 Drive State: UNKNOWN
                                 Volume Name:
                                Allocated to:
                                         WWN: 50112233AB010002
                               Serial Number: 70000052
              Last Update by (administrator): ADMIN
                       Last Update Date/Time: 08/25/2013 23:36:16
Cleaning Frequency (Gigabytes/ASNEEDED/NONE): NONE

                                Library Name: IBM_VTL
                                  Drive Name: DRIVE_4
                                 Device Type: LTO
more...   (<ENTER> to continue, 'C' to cancel)

                                     On-Line: Yes
                                Read Formats: ULTRIUM3C,ULTRIUM3,ULTRIUM2C,ULTRIUM2,ULTRIUMC,ULTRIUM
                               Write Formats: ULTRIUM3C,ULTRIUM3,ULTRIUM2C,ULTRIUM2
                                     Element: 4
                                 Drive State: UNKNOWN
                                 Volume Name:
                                Allocated to:
                                         WWN: 50112233AB010003
                               Serial Number: 70000053
              Last Update by (administrator): ADMIN
                       Last Update Date/Time: 08/25/2013 23:36:25
Cleaning Frequency (Gigabytes/ASNEEDED/NONE): NONE

tsm: VMTSM55WIN>define devclass VTL_LTO library=IBM_VTL devtype=LTO estcapacity=500M
ANR2203I Device class VTL_LTO defined.

tsm: VMTSM55WIN>define stgpool VTL_PRIMARY VTL_LTO maxscratch=10
ANR2200I Storage pool VTL_PRIMARY defined (device class VTL_LTO).

tsm: VMTSM55WIN>label libvol IBM_VTL search=yes labelsource=barcode checkin=scratch
ANS8003I Process number 3 started.

tsm: VMTSM55WIN>q libvol
ANR2034E QUERY LIBVOLUME: No match found using this criteria.
ANS8001I Return code 11.

tsm: VMTSM55WIN>q act

Date/Time                Message
--------------------     ----------------------------------------------------------
08/25/2013 23:40:20      ANR2017I Administrator ADMIN issued command: LABEL
                          LIBVOLUME IBM_VTL search=yes labelsource=barcode
                          checkin=scratch  (SESSION: 3)
08/25/2013 23:40:20      ANR0984I Process 3 for LABEL LIBVOLUME started in the
                          BACKGROUND at 23:40:20. (SESSION: 3, PROCESS: 3)
08/25/2013 23:40:20      ANR8799I LABEL LIBVOLUME: Operation for library IBM_VTL
                          started as process 3. (SESSION: 3, PROCESS: 3)
08/25/2013 23:40:20      ANR8439I SCSI library IBM_VTL is ready for operations.
                          (SESSION: 3, PROCESS: 3)
08/25/2013 23:40:21      ANR8847E No  3592-type drives are currently available in
                          library IBM_VTL. (SESSION: 3, PROCESS: 3)
08/25/2013 23:40:21      ANR8801I LABEL LIBVOLUME process 3 for library IBM_VTL
                          completed; 0 volume(s) labeled, 0 volume(s) checked-in.
                          (SESSION: 3, PROCESS: 3)
08/25/2013 23:40:21      ANR0985I Process 3 for LABEL LIBVOLUME running in the
                          BACKGROUND completed with completion state SUCCESS at
                          23:40:21. (SESSION: 3, PROCESS: 3)

                                                 
                                                 
And here is the debug output from mhVTL when I issued the TSM command to label and check-in the tape media:
                                                 
                                                 
Aug 26 00:48:09 mhvtl vtllibrary[1585]: processMessageQ(): verbose: enabled at level 3
Aug 26 00:48:17 mhvtl kernel: mhvtl: CDB (2774) 16 bytes
Aug 26 00:48:17 mhvtl kernel: 12 00 00 00 38 00 00 00 00 00 00 00 00 00 00 00
Aug 26 00:48:17 mhvtl vtllibrary[1585]: CDB (2774) (delay 91605): 12 00 00 00 38 00
Aug 26 00:48:17 mhvtl vtllibrary[1585]: spc_inquiry(): INQUIRY ** (2774)
Aug 26 00:48:17 mhvtl vtllibrary[1585]: completeSCSICommand(): OP s/n: (2774), sz: 64, sam_status: 0
Aug 26 00:48:17 mhvtl vtllibrary[1585]: CDB (2775) (delay 805): 12 01 80 00 04 00
Aug 26 00:48:17 mhvtl vtllibrary[1585]: spc_inquiry(): INQUIRY ** (2775)
Aug 26 00:48:17 mhvtl vtllibrary[1585]: spc_inquiry(): Page code 0x80
Aug 26 00:48:17 mhvtl vtllibrary[1585]: spc_inquiry(): Found page 0x80
Aug 26 00:48:17 mhvtl vtllibrary[1585]: completeSCSICommand(): OP s/n: (2775), sz: 14, sam_status: 0
Aug 26 00:48:17 mhvtl kernel: mhvtl: CDB (2775) 16 bytes
Aug 26 00:48:17 mhvtl kernel: 12 01 80 00 04 00 00 00 00 00 00 00 00 00 00 00
Aug 26 00:48:17 mhvtl vtllibrary[1585]: CDB (2776) (delay 805): 12 01 80 00 0e 00
Aug 26 00:48:17 mhvtl vtllibrary[1585]: spc_inquiry(): INQUIRY ** (2776)
Aug 26 00:48:17 mhvtl vtllibrary[1585]: spc_inquiry(): Page code 0x80
Aug 26 00:48:17 mhvtl vtllibrary[1585]: spc_inquiry(): Found page 0x80
Aug 26 00:48:17 mhvtl vtllibrary[1585]: completeSCSICommand(): OP s/n: (2776), sz: 14, sam_status: 0
Aug 26 00:48:17 mhvtl kernel: mhvtl: CDB (2776) 16 bytes
Aug 26 00:48:17 mhvtl kernel: 12 01 80 00 0e 00 00 00 00 00 00 00 00 00 00 00
Aug 26 00:48:17 mhvtl vtllibrary[1585]: CDB (2777) (delay 805): 12 01 83 00 04 00
Aug 26 00:48:17 mhvtl vtllibrary[1585]: spc_inquiry(): INQUIRY ** (2777)
Aug 26 00:48:17 mhvtl vtllibrary[1585]: spc_inquiry(): Page code 0x83
Aug 26 00:48:17 mhvtl vtllibrary[1585]: spc_inquiry(): Found page 0x83
Aug 26 00:48:17 mhvtl vtllibrary[1585]: completeSCSICommand(): OP s/n: (2777), sz: 54, sam_status: 0
Aug 26 00:48:17 mhvtl kernel: mhvtl: CDB (2777) 16 bytes
Aug 26 00:48:17 mhvtl kernel: 12 01 83 00 04 00 00 00 00 00 00 00 00 00 00 00
Aug 26 00:48:17 mhvtl kernel: mhvtl: CDB (2778) 16 bytes
Aug 26 00:48:17 mhvtl kernel: 12 01 83 00 36 00 00 00 00 00 00 00 00 00 00 00
Aug 26 00:48:17 mhvtl vtllibrary[1585]: CDB (2778) (delay 805): 12 01 83 00 36 00
Aug 26 00:48:17 mhvtl vtllibrary[1585]: spc_inquiry(): INQUIRY ** (2778)
Aug 26 00:48:17 mhvtl vtllibrary[1585]: spc_inquiry(): Page code 0x83
Aug 26 00:48:17 mhvtl vtllibrary[1585]: spc_inquiry(): Found page 0x83
Aug 26 00:48:17 mhvtl vtllibrary[1585]: completeSCSICommand(): OP s/n: (2778), sz: 54, sam_status: 0
Aug 26 00:48:17 mhvtl kernel: mhvtl: CDB (2779) 16 bytes
Aug 26 00:48:17 mhvtl kernel: 07 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
Aug 26 00:48:17 mhvtl vtllibrary[1585]: CDB (2779) (delay 805): 07 00 00 00 00 00
Aug 26 00:48:17 mhvtl vtllibrary[1585]: smc_initialize_element_status(): INITIALIZE ELEMENT (2779) **
Aug 26 00:48:18 mhvtl vtllibrary[1585]: completeSCSICommand(): OP s/n: (2779), sz: 0, sam_status: 0
Aug 26 00:48:18 mhvtl kernel: mhvtl: CDB (2780) 16 bytes
Aug 26 00:48:18 mhvtl kernel: 12 00 00 00 38 00 00 00 00 00 00 00 00 00 00 00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: CDB (2780) (delay 1205): 12 00 00 00 38 00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: spc_inquiry(): INQUIRY ** (2780)
Aug 26 00:48:18 mhvtl vtllibrary[1585]: completeSCSICommand(): OP s/n: (2780), sz: 64, sam_status: 0
Aug 26 00:48:18 mhvtl kernel: mhvtl: CDB (2781) 16 bytes
Aug 26 00:48:18 mhvtl kernel: 12 01 80 00 04 00 00 00 00 00 00 00 00 00 00 00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: CDB (2781) (delay 805): 12 01 80 00 04 00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: spc_inquiry(): INQUIRY ** (2781)
Aug 26 00:48:18 mhvtl vtllibrary[1585]: spc_inquiry(): Page code 0x80
Aug 26 00:48:18 mhvtl vtllibrary[1585]: spc_inquiry(): Found page 0x80
Aug 26 00:48:18 mhvtl vtllibrary[1585]: completeSCSICommand(): OP s/n: (2781), sz: 14, sam_status: 0
Aug 26 00:48:18 mhvtl kernel: mhvtl: CDB (2782) 16 bytes
Aug 26 00:48:18 mhvtl kernel: 12 01 80 00 0e 00 00 00 00 00 00 00 00 00 00 00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: CDB (2782) (delay 805): 12 01 80 00 0e 00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: spc_inquiry(): INQUIRY ** (2782)
Aug 26 00:48:18 mhvtl vtllibrary[1585]: spc_inquiry(): Page code 0x80
Aug 26 00:48:18 mhvtl vtllibrary[1585]: spc_inquiry(): Found page 0x80
Aug 26 00:48:18 mhvtl vtllibrary[1585]: completeSCSICommand(): OP s/n: (2782), sz: 14, sam_status: 0
Aug 26 00:48:18 mhvtl kernel: mhvtl: CDB (2783) 16 bytes
Aug 26 00:48:18 mhvtl kernel: 12 01 83 00 04 00 00 00 00 00 00 00 00 00 00 00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: CDB (2783) (delay 805): 12 01 83 00 04 00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: spc_inquiry(): INQUIRY ** (2783)
Aug 26 00:48:18 mhvtl vtllibrary[1585]: spc_inquiry(): Page code 0x83
Aug 26 00:48:18 mhvtl vtllibrary[1585]: spc_inquiry(): Found page 0x83
Aug 26 00:48:18 mhvtl vtllibrary[1585]: completeSCSICommand(): OP s/n: (2783), sz: 54, sam_status: 0
Aug 26 00:48:18 mhvtl kernel: mhvtl: CDB (2784) 16 bytes
Aug 26 00:48:18 mhvtl kernel: 12 01 83 00 36 00 00 00 00 00 00 00 00 00 00 00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: CDB (2784) (delay 805): 12 01 83 00 36 00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: spc_inquiry(): INQUIRY ** (2784)
Aug 26 00:48:18 mhvtl vtllibrary[1585]: spc_inquiry(): Page code 0x83
Aug 26 00:48:18 mhvtl vtllibrary[1585]: spc_inquiry(): Found page 0x83
Aug 26 00:48:18 mhvtl vtllibrary[1585]: completeSCSICommand(): OP s/n: (2784), sz: 54, sam_status: 0
Aug 26 00:48:18 mhvtl kernel: mhvtl: CDB (2785) 16 bytes
Aug 26 00:48:18 mhvtl kernel: b8 12 04 00 00 18 00 00 04 f0 00 00 00 00 00 00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: CDB (2785) (delay 805): b8 12 04 00 00 18 00 00 04 f0 00 00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: smc_read_element_status(): READ ELEMENT STATUS (2785) **
Aug 26 00:48:18 mhvtl vtllibrary[1585]: smc_read_element_status():  Element type(2) => Storage
Aug 26 00:48:18 mhvtl vtllibrary[1585]: smc_read_element_status():   Starting Element Address: 1024
Aug 26 00:48:18 mhvtl vtllibrary[1585]: smc_read_element_status():   Number of Elements      : 24
Aug 26 00:48:18 mhvtl vtllibrary[1585]: smc_read_element_status():   Allocation length       : 1264 (0x04f0)
Aug 26 00:48:18 mhvtl vtllibrary[1585]: smc_read_element_status():   Device ID: No, voltag: Yes
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_page(): Query 24 elements starting from addr: 1024 of type: (2) Storage
Aug 26 00:48:18 mhvtl vtllibrary[1585]: num_available_elements(): Determing 24 elements of type Storage starting at 1024, returning 24
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_page(): Available count: 24, type: 2
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_status_page_hdr(): Element Status Page Header: 02 80 00 34 00 00 04 e0
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Slot location: 1024, DVCID: 0, VOLTAG: 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Returning 52 bytes
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_page(): Count: 1, max_count: 24, slot: 1024
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Slot location: 1025, DVCID: 0, VOLTAG: 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Returning 52 bytes
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_page(): Count: 2, max_count: 24, slot: 1025
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Slot location: 1026, DVCID: 0, VOLTAG: 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Returning 52 bytes
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_page(): Count: 3, max_count: 24, slot: 1026
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Slot location: 1027, DVCID: 0, VOLTAG: 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Returning 52 bytes
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_page(): Count: 4, max_count: 24, slot: 1027
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Slot location: 1028, DVCID: 0, VOLTAG: 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Returning 52 bytes
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_page(): Count: 5, max_count: 24, slot: 1028
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Slot location: 1029, DVCID: 0, VOLTAG: 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Returning 52 bytes
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_page(): Count: 6, max_count: 24, slot: 1029
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Slot location: 1030, DVCID: 0, VOLTAG: 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Returning 52 bytes
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_page(): Count: 7, max_count: 24, slot: 1030
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Slot location: 1031, DVCID: 0, VOLTAG: 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Returning 52 bytes
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_page(): Count: 8, max_count: 24, slot: 1031
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Slot location: 1032, DVCID: 0, VOLTAG: 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Returning 52 bytes
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_page(): Count: 9, max_count: 24, slot: 1032
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Slot location: 1033, DVCID: 0, VOLTAG: 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Returning 52 bytes
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_page(): Count: 10, max_count: 24, slot: 1033
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Slot location: 1034, DVCID: 0, VOLTAG: 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Returning 52 bytes
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_page(): Count: 11, max_count: 24, slot: 1034
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Slot location: 1035, DVCID: 0, VOLTAG: 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Returning 52 bytes
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_page(): Count: 12, max_count: 24, slot: 1035
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Slot location: 1036, DVCID: 0, VOLTAG: 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Returning 52 bytes
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_page(): Count: 13, max_count: 24, slot: 1036
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Slot location: 1037, DVCID: 0, VOLTAG: 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Returning 52 bytes
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_page(): Count: 14, max_count: 24, slot: 1037
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Slot location: 1038, DVCID: 0, VOLTAG: 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Returning 52 bytes
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_page(): Count: 15, max_count: 24, slot: 1038
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Slot location: 1039, DVCID: 0, VOLTAG: 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Returning 52 bytes
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_page(): Count: 16, max_count: 24, slot: 1039
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Slot location: 1040, DVCID: 0, VOLTAG: 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Returning 52 bytes
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_page(): Count: 17, max_count: 24, slot: 1040
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Slot location: 1041, DVCID: 0, VOLTAG: 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Returning 52 bytes
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_page(): Count: 18, max_count: 24, slot: 1041
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Slot location: 1042, DVCID: 0, VOLTAG: 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Returning 52 bytes
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_page(): Count: 19, max_count: 24, slot: 1042
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Slot location: 1043, DVCID: 0, VOLTAG: 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Returning 52 bytes
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_page(): Count: 20, max_count: 24, slot: 1043
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Slot location: 1044, DVCID: 0, VOLTAG: 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Returning 52 bytes
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_page(): Count: 21, max_count: 24, slot: 1044
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Slot location: 1045, DVCID: 0, VOLTAG: 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Returning 52 bytes
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_page(): Count: 22, max_count: 24, slot: 1045
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Slot location: 1046, DVCID: 0, VOLTAG: 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Returning 52 bytes
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_page(): Count: 23, max_count: 24, slot: 1046
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Slot location: 1047, DVCID: 0, VOLTAG: 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_descriptor(): Returning 52 bytes
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_page(): Count: 24, max_count: 24, slot: 1047
Aug 26 00:48:18 mhvtl vtllibrary[1585]: num_available_elements(): Determing 24 elements of type Storage starting at 1024, returning 24
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_status_data_hdr(): Building READ ELEMENT STATUS Header struct
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_status_data_hdr():  Starting slot: 1024, number of configured slots: 24
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_status_data_hdr():  Element Status Data HEADER: 04 00 00 18 00 00 04 f0
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_status_data_hdr():  Decoded:
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_status_data_hdr():   First element Address    : 1024
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_status_data_hdr():   Number elements reported : 24
Aug 26 00:48:18 mhvtl vtllibrary[1585]: fill_element_status_data_hdr():   Total byte count         : 1264 (0x04f0)
Aug 26 00:48:18 mhvtl vtllibrary[1585]: decode_element_status(): Element Status Data
Aug 26 00:48:18 mhvtl vtllibrary[1585]: decode_element_status():   First element reported       : 1024
Aug 26 00:48:18 mhvtl vtllibrary[1585]: decode_element_status():   Number of elements available : 24
Aug 26 00:48:18 mhvtl vtllibrary[1585]: decode_element_status():   Byte count of report         : 1264
Aug 26 00:48:18 mhvtl vtllibrary[1585]: decode_element_status(): Element Status Page
Aug 26 00:48:18 mhvtl vtllibrary[1585]: decode_element_status():   Element Type code            : 2 (Storage)
Aug 26 00:48:18 mhvtl vtllibrary[1585]: decode_element_status():   Primary Vol Tag              : Yes
Aug 26 00:48:18 mhvtl vtllibrary[1585]: decode_element_status():   Alt Vol Tag                  : No
Aug 26 00:48:18 mhvtl vtllibrary[1585]: decode_element_status():   Element descriptor length    : 52
Aug 26 00:48:18 mhvtl vtllibrary[1585]: decode_element_status():   Byte count of descriptor data: 1248
Aug 26 00:48:18 mhvtl vtllibrary[1585]: decode_element_status(): Element Descriptor(s) : Num of Elements 24
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Debug.... i = 0, len = 52
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Element Address             : 1024
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Status                      : 0x09
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Medium type                 : 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Voltag info...
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Identification Descriptor
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Code Set                     : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier type              : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier length            : 0
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Debug.... i = 52, len = 52
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Element Address             : 1025
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Status                      : 0x09
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Medium type                 : 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Voltag info...
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Identification Descriptor
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Code Set                     : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier type              : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier length            : 0
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Debug.... i = 104, len = 52
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Element Address             : 1026
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Status                      : 0x09
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Medium type                 : 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Voltag info...
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Identification Descriptor
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Code Set                     : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier type              : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier length            : 0
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Debug.... i = 156, len = 52
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Element Address             : 1027
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Status                      : 0x09
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Medium type                 : 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Voltag info...
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Identification Descriptor
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Code Set                     : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier type              : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier length            : 0
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Debug.... i = 208, len = 52
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Element Address             : 1028
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Status                      : 0x09
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Medium type                 : 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Voltag info...
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Identification Descriptor
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Code Set                     : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier type              : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier length            : 0
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Debug.... i = 260, len = 52
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Element Address             : 1029
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Status                      : 0x09
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Medium type                 : 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Voltag info...
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Identification Descriptor
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Code Set                     : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier type              : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier length            : 0
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Debug.... i = 312, len = 52
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Element Address             : 1030
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Status                      : 0x09
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Medium type                 : 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Voltag info...
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Identification Descriptor
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Code Set                     : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier type              : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier length            : 0
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Debug.... i = 364, len = 52
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Element Address             : 1031
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Status                      : 0x09
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Medium type                 : 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Voltag info...
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Identification Descriptor
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Code Set                     : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier type              : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier length            : 0
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Debug.... i = 416, len = 52
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Element Address             : 1032
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Status                      : 0x09
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Medium type                 : 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Voltag info...
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Identification Descriptor
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Code Set                     : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier type              : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier length            : 0
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Debug.... i = 468, len = 52
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Element Address             : 1033
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Status                      : 0x09
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Medium type                 : 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Voltag info...
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Identification Descriptor
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Code Set                     : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier type              : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier length            : 0
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Debug.... i = 520, len = 52
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Element Address             : 1034
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Status                      : 0x09
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Medium type                 : 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Voltag info...
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Identification Descriptor
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Code Set                     : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier type              : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier length            : 0
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Debug.... i = 572, len = 52
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Element Address             : 1035
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Status                      : 0x09
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Medium type                 : 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Voltag info...
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Identification Descriptor
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Code Set                     : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier type              : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier length            : 0
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Debug.... i = 624, len = 52
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Element Address             : 1036
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Status                      : 0x09
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Medium type                 : 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Voltag info...
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Identification Descriptor
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Code Set                     : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier type              : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier length            : 0
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Debug.... i = 676, len = 52
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Element Address             : 1037
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Status                      : 0x09
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Medium type                 : 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Voltag info...
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Identification Descriptor
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Code Set                     : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier type              : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier length            : 0
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Debug.... i = 728, len = 52
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Element Address             : 1038
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Status                      : 0x09
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Medium type                 : 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Voltag info...
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Identification Descriptor
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Code Set                     : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier type              : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier length            : 0
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Debug.... i = 780, len = 52
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Element Address             : 1039
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Status                      : 0x09
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Medium type                 : 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Voltag info...
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Identification Descriptor
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Code Set                     : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier type              : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier length            : 0
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Debug.... i = 832, len = 52
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Element Address             : 1040
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Status                      : 0x09
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Medium type                 : 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Voltag info...
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Identification Descriptor
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Code Set                     : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier type              : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier length            : 0
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Debug.... i = 884, len = 52
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Element Address             : 1041
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Status                      : 0x09
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Medium type                 : 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Voltag info...
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Identification Descriptor
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Code Set                     : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier type              : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier length            : 0
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Debug.... i = 936, len = 52
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Element Address             : 1042
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Status                      : 0x09
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Medium type                 : 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Voltag info...
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Identification Descriptor
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Code Set                     : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier type              : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier length            : 0
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Debug.... i = 988, len = 52
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Element Address             : 1043
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Status                      : 0x09
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Medium type                 : 1
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Voltag info...
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Identification Descriptor
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Code Set                     : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier type              : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier length            : 0
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Debug.... i = 1040, len = 52
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Element Address             : 1044
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Status                      : 0x08
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Medium type                 : 0
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Voltag info...
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Identification Descriptor
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Code Set                     : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier type              : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier length            : 0
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Debug.... i = 1092, len = 52
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Element Address             : 1045
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Status                      : 0x08
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Medium type                 : 0
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Voltag info...
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Identification Descriptor
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Code Set                     : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier type              : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier length            : 0
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Debug.... i = 1144, len = 52
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Element Address             : 1046
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Status                      : 0x08
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Medium type                 : 0
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Voltag info...
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Identification Descriptor
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Code Set                     : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier type              : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier length            : 0
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Debug.... i = 1196, len = 52
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Element Address             : 1047
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Status                      : 0x08
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Medium type                 : 0
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Voltag info...
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():  Identification Descriptor
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Code Set                     : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier type              : 0x00
Aug 26 00:48:18 mhvtl vtllibrary[1585]: dump_element_desc():   Identifier length            : 0
Aug 26 00:48:18 mhvtl vtllibrary[1585]: smc_read_element_status(): Element count: 24, Elem byte count: 0x04f0, alloc_len: 1264
Aug 26 00:48:18 mhvtl vtllibrary[1585]: completeSCSICommand(): OP s/n: (2785), sz: 1264, sam_status: 0
Aug 26 00:48:23 mhvtl kernel: mhvtl: CDB (2786) 16 bytes
Aug 26 00:48:23 mhvtl kernel: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
Aug 26 00:48:23 mhvtl vtltape[1569]: CDB (2786) (delay 154405): 00 00 00 00 00 00
Aug 26 00:48:23 mhvtl vtltape[1569]: mkSenseBuf(): SENSE [Key/ASC/ASCQ] [02 3a 00]
Aug 26 00:48:23 mhvtl vtltape[1569]: ssc_tur(): Test Unit Ready (2786) ** : No, No tape loaded
Aug 26 00:48:25 mhvtl kernel: mhvtl: CDB (2787) 16 bytes
Aug 26 00:48:25 mhvtl kernel: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
Aug 26 00:48:25 mhvtl vtltape[1575]: CDB (2787) (delay 154805): 00 00 00 00 00 00
Aug 26 00:48:25 mhvtl vtltape[1575]: mkSenseBuf(): SENSE [Key/ASC/ASCQ] [02 3a 00]
Aug 26 00:48:25 mhvtl vtltape[1575]: ssc_tur(): Test Unit Ready (2787) ** : No, No tape loaded
Aug 26 00:48:27 mhvtl kernel: mhvtl: CDB (2788) 16 bytes
Aug 26 00:48:27 mhvtl kernel: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
Aug 26 00:48:27 mhvtl vtltape[1578]: CDB (2788) (delay 154805): 00 00 00 00 00 00
Aug 26 00:48:27 mhvtl vtltape[1578]: mkSenseBuf(): SENSE [Key/ASC/ASCQ] [02 3a 00]
Aug 26 00:48:27 mhvtl vtltape[1578]: ssc_tur(): Test Unit Ready (2788) ** : No, No tape loaded
Aug 26 00:48:29 mhvtl kernel: mhvtl: CDB (2789) 16 bytes
Aug 26 00:48:29 mhvtl kernel: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
Aug 26 00:48:29 mhvtl vtltape[1581]: CDB (2789) (delay 154805): 00 00 00 00 00 00
Aug 26 00:48:29 mhvtl vtltape[1581]: mkSenseBuf(): SENSE [Key/ASC/ASCQ] [02 3a 00]
Aug 26 00:48:29 mhvtl vtltape[1581]: ssc_tur(): Test Unit Ready (2789) ** : No, No tape loaded
sbcedservice
Reply | Threaded
Open this post in threaded view
♦
♦
|

Re: TSM not recognising correct IBM drive type

sbcedservice
mayby you are missing the Product revision level on device at Drive: 11

Tiger22
Reply | Threaded
Open this post in threaded view
♦
♦
|

Re: TSM not recognising correct IBM drive type

Tiger22
Thanks for pointing out the omission but that hasn't resolved anything.

I can't claim to understand the mhvtl debug log but I'm wondering if what is being passed to TSM during the tape label process is correct. I assume TSM is enquiring from the VTL what media (via the barcode reader) is in the slots and, based upon the media types being returned, attempts to find a compatible drive to load and label them. Now TSM recognises it has LTO-3 drives as it has correctly picked up the formats the drive supports when they were defined to TSM. I suspect however that when it is getting info about the actual tapes it somehow thinks they are 3592 tapes, for which it doesn't have an appropriate drive.

Is mhVTL somehow providing incorrect information to TSM or is TSM misunderstanding the information it is being given about the media?
Mark Harvey
Reply | Threaded
Open this post in threaded view
♦
♦
|

Re: TSM not recognising correct IBM drive type

Mark Harvey
Administrator
At this point in development, there is no 'personality module' for the Libraries.

While you are able to adjust the SCSI Inquiry string, nothing is tweaked within the code to attempt to emulate the library type.

If your backup software expects certain behaviour on different SCSI inquiry strings, you may find the backup software will be 'confused'.

i.e. NetBackup:
For mhVTL libraries to work with NetBackup, check the device_mappings.txt file and confirm the Inquiry strings match up with entries which are marked 'LIBRARY_SERIALIZATION=2' (not a 100% guarantee - but is a good starting point)
e.g.
[CHANGER:STK L700]
<cut>
LIBRARY_SERIALIZATION=2
<cut>

Based on postings on this forum, TSM seems to work best if the library vendor is the same as the drive vendor.
i.e.
- For IBM drives - Use IBM library inquiry strings.
- For STK (Now Oracle) drives, use STK library

In an ideal world, the software should read the MODE SENSE which returns the library dynamics (slots, drives, co-ordinates etc) and dynamically handle the information. Unfortunately, library behaviour is often hard coded - or at least some pre-set idea about the configuration is.
When the backup software sees 'brand X', it will often expect 'Y' behaviour.

mhVTL only presents 'Z' behaviour at this point in time.
So the trick is finding SCSI inquiry string that matches 'type Z behaviour' to your software..

Until I can find time to create library personality modules that is...
Regards from Australia
Mark Harvey
nia
Reply | Threaded
Open this post in threaded view
♦
♦
|

Re: TSM not recognising correct IBM drive type

nia
Administrator
In reply to this post by Tiger22
Tiger22 wrote
tsm: VMTSM55WIN>label libvol IBM_VTL search=yes labelsource=barcode checkin=scratch
ANS8003I Process number 3 started.

tsm: VMTSM55WIN>q libvol
ANR2034E QUERY LIBVOLUME: No match found using this criteria.
ANS8001I Return code 11.
Try using the following :

update library IBM_VTL AutoLabel=yes RelabelScratch=yes
CHECKIn LIBVolume  IBM_VTL CHECKLabel=barcode SEARCH=Yes status=scratch devt=lto


Regards,
-nia
Tiger22
Reply | Threaded
Open this post in threaded view
♦
♦
|

Re: TSM not recognising correct IBM drive type

Tiger22
In reply to this post by Mark Harvey
Mark Harvey wrote
At this point in development, there is no 'personality module' for the Libraries.
I did know that but somehow forgot about it in the midst of this new configuration. Oops. I have successfully modified the inquiry string now to emulate a TS3200 library (which these days uses LTO exclusively) and everything worked fine.

It is strange that the Linux and Windows versions of the IBM library/tape drivers behave differently as I didn't have any problems using the 03584L22 inquiry string on Linux with LTO drives.

Thanks for your help.
zy
Reply | Threaded
Open this post in threaded view
♦
♦
|

Re: TSM not recognising correct IBM drive type

zy
In reply to this post by Tiger22
if you use 03584L22 library,tsm drives (windows) will search element number from 257,but the element of mhvtl driver begin at 1,so tsm say no 3592 driver .if use ts3200 library it search element number from 1 ,so tsm work ok.

hope this infomation help you.
ps.
i want to know how to edit mhvtl element number.
Mark Harvey
Reply | Threaded
Open this post in threaded view
♦
♦
|

Re: TSM not recognising correct IBM drive type

Mark Harvey
Administrator
In 'smc.h' are the following entries 

*
 * FIXME: The following should be dynamic (read from config file)
 *
 **** Danger Will Robinson!! ****:
 *   START_DRIVE HAS TO start at slot 1
 *      The Order of Drives with lowest start, followed by Picker, followed
 *      by MAP, finally Storage slots is IMPORTANT. - You have been warned.
 *   Some of the logic in this source depends on it.
 */
#define START_DRIVE     0x0001
#define START_PICKER    0x02c0
#define START_MAP       0x0300
#define START_STORAGE   0x0400

Perhaps the 'START_DRIVE HAS TO start at slot 1' is a little misleading.

The order is important - so the drives should come first, followed by the PICKER, followed by the MAP and finally the Storage Slots.

Some of the original logic has been replaced with location independent code..
BUT I've never attempted to try swapping order of slot types..

Feel free to test and report back (I'd recommend creating a new post for any such reports).

Patches are (as always) welcome - but so is testing and bug / feature requests..

Time constraints will dictate how soon such reported items are dealt with :)
Regards from Australia
Mark Harvey
Mark Harvey
Reply | Threaded
Open this post in threaded view
♦
♦
|

Re: TSM not recognising correct IBM drive type

Mark Harvey
Administrator
If anybody does attempt to change the slot order - check vtllibrary.c 
/* Linked list data needs to be built in slot order */
static void init_slot_info(struct lu_phy_attr *lu)
{
        __init_slot_info(lu, DATA_TRANSFER);
        __init_slot_info(lu, MEDIUM_TRANSPORT);
        __init_slot_info(lu, MAP_ELEMENT);
        __init_slot_info(lu, STORAGE_ELEMENT);
}

The 'initialization' order will need to be swapped in the 'init_slot_info()' routine so the list of slots is initialised "lowest to highest".
Regards from Australia
Mark Harvey
Mark Harvey
Reply | Threaded
Open this post in threaded view
♦
♦
|

Re: TSM not recognising correct IBM drive type

Mark Harvey
Administrator
In reply to this post by zy
zy wrote
if you use 03584L22 library,tsm drives (windows) will search element number from 257,but the element of mhvtl driver begin at 1,so tsm say no 3592 driver .if use ts3200 library it search element number from 1 ,so tsm work ok.

hope this infomation help you.
This information is very helpful and explains why TSM has problems with some configurations - but no error messages from mhVTL side of things.

Where/how did you determine that the first "search element number from 257" ?

I reviewed the previous logs and information and can see no place where this information was collected / recorded.

i.e. If I can reproduce/test, it saves a lot of time asking for other people to perform the tests on my behalf.
Regards from Australia
Mark Harvey
zy
Reply | Threaded
Open this post in threaded view
♦
♦
|

Re: TSM not recognising correct IBM drive type

zy
In reply to this post by Tiger22
Sorry , i make a mistake.
when we use tsm lable wizards ,it can`t find driver`s element,and,it will let you select one library type (or manual input element),but you select `ibm ultrium 3584` the element will change to 257.

the really reason of ERROR no 3593-type is 03584l22 library olny support the drive that like 3592-e05(or e06 e07 eu6 j1a,that i find it from IBM econfig).

03584l32 support drive ultrium 3 4 5 6(lto)

so,if use 03584l22 library,you should use supported drive modle.(03592e05 or 03592j1)

i had tested 03584l32 with lto5 drive,it works ok.(manual input element with 1)
but tested 03584l22 with 3592 drive not yet ok,i think it`s tsm config problem.
my config:
DEFINE Library 358422lib libtype=scsi serial=70000050 AutoLabel=overwrite resetdrives=yes shared=yes wwn=70112233ab060000
DEFINE Devc 358422class library=358422lib devt=3592 format=drive mountret=4
DEFINE PATH TSMa 358422lib SRCType=SERVER DESTType=LIBRary Device=changer0 ONLine=y
DEFINE drive 358422lib 358422drv1 serial=70000051 element=autod wwn=70112233ab060001 online=yes
DEFINE PATH TSMA 358422drv1 SRCType=SERVER DESTType=drive LIBRary=358422lib Device=\\.\Tape0 ONLine=yes
LABEL LIBVOLUME 358422lib SEARCH=yes labelsource=barcode  CHECKIN=SCRATCH OVERWRITE=yes WAITTIME=0
the error:
anr8302e i/o error on drive 358422drv1 ........

sorry,my english is very poor.hope this infomation is helpful.

Arsenal
Reply | Threaded
Open this post in threaded view
♦
♦
|

Re: TSM not recognising correct IBM drive type

Arsenal
In reply to this post by Tiger22
Hello, guys !
I'm trying to use mhVTL on RHEL6 x86.64 + TSM 5.5.6

I tried to made as  usual:

1) create library,
2) create path to library,
3) create drive?
4) create path to drive.

The fist and second steps - are OK, informations obtained from library, I can see its status and so on.
The third step - OK, created, but when I tried to create path to library's drives I faced with problem:

DEFINE PATH  oradb1 3573DRV1 SRCTYPE=SERVER  DESTTYPE=DRIVE  LIBRARY=3573LIB DEVICE=/dev/st0
ANR8420E DEFINE PATH: An I/O error occurred while accessing drive 3573DRV1.
ANS8001I Return code 15.

trace messages:

Nov 12 21:46:46 oradb vtltape[1311]: CDB (24809) (delay 768005): 00 00 00 00 00 00
Nov 12 21:46:46 oradb vtltape[1311]: return_sense(): [Key/ASC/ASCQ] [02 3a 00]
Nov 12 21:46:46 oradb vtltape[1311]: ssc_tur(): Test Unit Ready (24809) ** : No, No tape loaded
Nov 12 21:46:46 oradb vtltape[1311]: completeSCSICommand(): s/n: (24809), sz: 0, sam_status: 2 [02 3a 00]

another variant:

DEFINE PATH  oradb1 3573DRV1 SRCTYPE=SERVER  DESTTYPE=DRIVE  LIBRARY=3573LIB DEVICE=/dev/sg3
ANR8420E DEFINE PATH: An I/O error occurred while accessing drive 3573DRV1.
ANS8001I Return code 15.

trace message:

Nov 12 21:47:15 oradb vtltape[1311]: CDB (24810) (delay 151205): 12 00 00 00 38 00
Nov 12 21:47:15 oradb vtltape[1311]: spc_inquiry(): INQUIRY ** (24810)
Nov 12 21:47:15 oradb vtltape[1311]: completeSCSICommand(): OP s/n: (24810), sz: 64, sam_status: 0

configuration:

 lsscsi -g
[0:0:0:0]    disk    VBOX     HARDDISK         1.0   /dev/sda   /dev/sg0
[0:0:1:0]    disk    VBOX     HARDDISK         1.0   /dev/sdb   /dev/sg1
[0:0:2:0]    cd/dvd  VBOX     CD-ROM           1.0   /dev/sr0   /dev/sg2
[1:3:0:0]    mediumx IBM      3573-TL          4.02  /dev/sch0  /dev/sg5
[1:3:0:1]    tape    IBM      ULT3580-TD4      252D  /dev/st0   /dev/sg3
[1:3:0:2]    tape    IBM      ULT3580-TD4      252D  /dev/st1   /dev/sg4

devices.conf:

Library: 90 CHANNEL: 3 TARGET: 00 LUN: 00
 Vendor identification: IBM
 Product identification: 3573-TL
 Product revision level: 4.02
 Unit serial number: 70000090
 NAA: 90:11:22:33:ab:3:00:00
 Home directory: /opt/mhvtl/90
 Backoff: 400

Drive: 91 CHANNEL: 3 TARGET: 00 LUN: 01
 Library ID: 90 Slot: 01
 Vendor identification: IBM
 Product identification: ULT3580-TD4
 Product revision level: 252D
 Unit serial number: 70000091
 NAA: 90:11:22:33:ab:3:00:01
 Compression: factor 1 enabled 1
 Compression type: lzo
 Backoff: 400

Drive: 92 CHANNEL: 3 TARGET: 00 LUN: 2
 Library ID: 90 Slot: 2
 Vendor identification: IBM
 Product identification: ULT3580-TD4
 Product revision level: 252D
 Unit serial number: 70000092
 NAA: 90:11:22:33:ab:3:00:2
 Compression: factor 1 enabled 1
 Compression type: lzo
 Backoff: 400

library_contents.90:

Drive1:
Drive2:

Picker 1:

MAP 1:
MAP 2:
MAP 3:
MAP 4:
MAP 5:

Slot 1: M00001L4
Slot 2: M00002L4
Slot 3: M00003L4
Slot 4: M00004L4
Slot 5: M00005L4
Slot 6: M00006L4
Slot 7: M00007L4
Slot 8: M00008L4
Slot 9: M00009L4
Slot 10: M00000L4
Slot 11:
Slot 12:
Slot 13:
Slot 14:
Slot 15:

Why I have the bad result unlike  people who use Win2K for TSM server instance ? I'm trying to do step by step except device parameter device ( /dev/ instead ld(mt) ?
zy
Reply | Threaded
Open this post in threaded view
♦
♦
|

Re: Re: TSM not recognising correct IBM drive type

zy
Hi,guys!
give me your config command for define drive
You try this command:
DEFINE drive 3573LIB 3573DRV1 serial=70000091 element=autod wwn=90112233ab030001 online=yes
good luck!

 
Date: 2016-11-13 03:57
Subject: Re: TSM not recognising correct IBM drive type
Hello, guys !
I'm trying to use mhVTL on RHEL6 x86.64 + TSM 5.5.6

I tied to made as  usual:

1) create library,
2) create path to library,
3) create drive?
4) create path to drive.

The fist and second steps - are OK, informations obtained from library, I can see its status and so on.
The third step - OK, created, but when I tried to create path to library's drives I faced with problem:

DEFINE PATH  oradb1 3573DRV1 SRCTYPE=SERVER  DESTTYPE=DRIVE  LIBRARY=3573LIB DEVICE=/dev/st0
ANR8420E DEFINE PATH: An I/O error occurred while accessing drive 3573DRV1.
ANS8001I Return code 15.

trace messages:

Nov 12 21:46:46 oradb vtltape[1311]: CDB (24809) (delay 768005): 00 00 00 00 00 00
Nov 12 21:46:46 oradb vtltape[1311]: return_sense(): [Key/ASC/ASCQ] [02 3a 00]
Nov 12 21:46:46 oradb vtltape[1311]: ssc_tur(): Test Unit Ready (24809) ** : No, No tape loaded
Nov 12 21:46:46 oradb vtltape[1311]: completeSCSICommand(): s/n: (24809), sz: 0, sam_status: 2 [02 3a 00]

another variant:

DEFINE PATH  oradb1 3573DRV1 SRCTYPE=SERVER  DESTTYPE=DRIVE  LIBRARY=3573LIB DEVICE=/dev/sg3
ANR8420E DEFINE PATH: An I/O error occurred while accessing drive 3573DRV1.
ANS8001I Return code 15.

trace message:

Nov 12 21:47:15 oradb vtltape[1311]: CDB (24810) (delay 151205): 12 00 00 00 38 00
Nov 12 21:47:15 oradb vtltape[1311]: spc_inquiry(): INQUIRY ** (24810)
Nov 12 21:47:15 oradb vtltape[1311]: completeSCSICommand(): OP s/n: (24810), sz: 64, sam_status: 0

configuration:

 lsscsi -g
[0:0:0:0]    disk    VBOX     HARDDISK         1.0   /dev/sda   /dev/sg0
[0:0:1:0]    disk    VBOX     HARDDISK         1.0   /dev/sdb   /dev/sg1
[0:0:2:0]    cd/dvd  VBOX     CD-ROM           1.0   /dev/sr0   /dev/sg2
[1:3:0:0]    mediumx IBM      3573-TL          4.02  /dev/sch0  /dev/sg5
[1:3:0:1]    tape    IBM      ULT3580-TD4      252D  /dev/st0   /dev/sg3
[1:3:0:2]    tape    IBM      ULT3580-TD4      252D  /dev/st1   /dev/sg4

devices.conf:

Library: 90 CHANNEL: 3 TARGET: 00 LUN: 00
 Vendor identification: IBM
 Product identification: 3573-TL
 Product revision level: 4.02
 Unit serial number: 70000090
 NAA: 90:11:22:33:ab:3:00:00
 Home directory: /opt/mhvtl/90
 Backoff: 400

Drive: 91 CHANNEL: 3 TARGET: 00 LUN: 01
 Library ID: 90 Slot: 01
 Vendor identification: IBM
 Product identification: ULT3580-TD4
 Product revision level: 252D
 Unit serial number: 70000091
 NAA: 90:11:22:33:ab:3:00:01
 Compression: factor 1 enabled 1
 Compression type: lzo
 Backoff: 400

Drive: 92 CHANNEL: 3 TARGET: 00 LUN: 2
 Library ID: 90 Slot: 2
 Vendor identification: IBM
 Product identification: ULT3580-TD4
 Product revision level: 252D
 Unit serial number: 70000092
 NAA: 90:11:22:33:ab:3:00:2
 Compression: factor 1 enabled 1
 Compression type: lzo
 Backoff: 400

library_contents.90:

Drive1:
Drive2:

Picker 1:

MAP 1:
MAP 2:
MAP 3:
MAP 4:
MAP 5:

Slot 1: M00001L4
Slot 2: M00002L4
Slot 3: M00003L4
Slot 4: M00004L4
Slot 5: M00005L4
Slot 6: M00006L4
Slot 7: M00007L4
Slot 8: M00008L4
Slot 9: M00009L4
Slot 10: M00000L4
Slot 11:
Slot 12:
Slot 13:
Slot 14:
Slot 15:

Why I have the bad result unlike  people who use Win2K for TSM server instance ? I'm trying to do step by step except device parameter device ( /dev/ instead ld(mt) ?

To unsubscribe from TSM not recognising correct IBM drive type, click here.
NAML
Arsenal
Reply | Threaded
Open this post in threaded view
♦
♦
|

Re: Re: TSM not recognising correct IBM drive type

Arsenal
Hello,
Thank you for response!

Problem was solved by using scenario of user named danlthom.
Here are the link to article :

http://mhvtl-a-linux-virtual-tape-library.966029.n3.nabble.com/Details-on-testing-TSM-with-mhvtl-emulated-TS3500-and-LTO5-LTO4-td4025929.html

Need to use IBM lin_tape driver for LTO drives with IBM library.
Free forum by Nabble Edit this page