cancel
Showing results for 
Search instead for 
Did you mean: 

tape drive dropping offline in the middle of a job

Julie_Barnes
Level 4


The issue we’re seeing is as follows: Backup Exec 2010 R3 SP2: We have a Tandberg Storage Library T24 with two HP LTO5 drives in it. It’s attached by fiber to the Q-Logic 8Gb FC Dual-port HBA. We have 2 backup jobs that run nightly. One goes directly to tape and the other goes to disk and then to tape. Tandberg has swapped out both tape drives and the tape library. We’ve tried different fiber cables and now we’ve swapped out the Q-Logic card. One of the tape drives drops offline in the middle of the disk-to-tape portion of the job. I am unable to find WHY it drops anywhere. I’ve verified the SCSI configuration and I do not see any problems. I’m not seeing the tell-tale Event ID 9 or 11 that would suggest a problem.

If I restart BE services, I can rerun the duplicate to tape job fine, but it fails again at it's next scheduled run.

I'm about to pull my hair out! Any help would be greatly appreciated.

26 REPLIES 26

Julie_Barnes
Level 4

Addam log now attached.

Julie_Barnes
Level 4

These are the errors that appear in my application log when the drive drops offline. Maybe someone can make good sense of it.

 

Log Name:      Application
Source:        Backup Exec
Date:          10/2/2012 2:48:02 AM
Event ID:      58053
Task Category: None
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
Backup Exec Alert: Device Error
(Server: "SVRTAPE") The drive hardware is offline.

Please confirm that the drive hardware is powered on and properly cabled.

 For more information, click the following link:
http://eventlookup.veritas.com/eventlookup/EventLookup.jhtml
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">58053</EventID>
    <Level>2</Level>
    <Task>0</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-02T07:48:02.000000000Z" />
    <EventRecordID>35815</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>Backup Exec Alert: Device Error
(Server: "SVRTAPE") The drive hardware is offline.

Please confirm that the drive hardware is powered on and properly cabled.</Data>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/2/2012 2:47:57 AM
Event ID:      34113
Task Category: None
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
Backup Exec Alert: Job Failed
(Server: "SVRTAPE") (Job: "Financial Full Backup-Financial Backup Job-Duplicate Financial Backup Sets") Financial Full Backup-Financial Backup Job-Duplicate Financial Backup Sets -- The job failed with the following error: The device timed out.
 

 For more information, click the following link:
http://eventlookup.veritas.com/eventlookup/EventLookup.jhtml
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">34113</EventID>
    <Level>2</Level>
    <Task>0</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-02T07:47:57.000000000Z" />
    <EventRecordID>35814</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>Backup Exec Alert: Job Failed
(Server: "SVRTAPE") (Job: "Financial Full Backup-Financial Backup Job-Duplicate Financial Backup Sets") Financial Full Backup-Financial Backup Job-Duplicate Financial Backup Sets -- The job failed with the following error: The device timed out.
</Data>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/2/2012 2:47:57 AM
Event ID:      58053
Task Category: None
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
Backup Exec Alert: Device Error
(Server: "SVRTAPE") The drive hardware is offline.

Please confirm that the drive hardware is powered on and properly cabled.

 For more information, click the following link:
http://eventlookup.veritas.com/eventlookup/EventLookup.jhtml
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">58053</EventID>
    <Level>2</Level>
    <Task>0</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-02T07:47:57.000000000Z" />
    <EventRecordID>35813</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>Backup Exec Alert: Device Error
(Server: "SVRTAPE") The drive hardware is offline.

Please confirm that the drive hardware is powered on and properly cabled.</Data>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/2/2012 2:47:51 AM
Event ID:      33152
Task Category: (1)
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
[2784] 10/02/12 02:47:51 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape0", SCSI cmd 1a, new handle 788, error 55

%2
%3
%4
%5
%6
%7
%8
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">33152</EventID>
    <Level>2</Level>
    <Task>1</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-02T07:47:51.000000000Z" />
    <EventRecordID>35812</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>[2784] 10/02/12 02:47:51 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape0", SCSI cmd 1a, new handle 788, error 55
</Data>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/2/2012 2:47:51 AM
Event ID:      33152
Task Category: (1)
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
[2784] 10/02/12 02:47:51 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape0", SCSI cmd 01, new handle 788, error 0

%2
%3
%4
%5
%6
%7
%8
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">33152</EventID>
    <Level>2</Level>
    <Task>1</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-02T07:47:51.000000000Z" />
    <EventRecordID>35811</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>[2784] 10/02/12 02:47:51 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape0", SCSI cmd 01, new handle 788, error 0
</Data>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/2/2012 2:47:51 AM
Event ID:      57665
Task Category: None
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
Storage device "HP 0003" reported an error on a request to write data to media.

Error reported:
This operation returned because the timeout period expired.
.

 For more information, click the following link:
http://eventlookup.veritas.com/eventlookup/EventLookup.jhtml
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">57665</EventID>
    <Level>2</Level>
    <Task>0</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-02T07:47:51.000000000Z" />
    <EventRecordID>35810</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>HP 0003</Data>
    <Data>write data to media</Data>
    <Data>This operation returned because the timeout period expired.
</Data>
    <Binary>B4050000F08400E0000001000000000093030000</Binary>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/2/2012 2:47:51 AM
Event ID:      33152
Task Category: (1)
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
[5340] 10/02/12 02:47:51 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape0", SCSI cmd 1a, new handle 858, error 0

%2
%3
%4
%5
%6
%7
%8
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">33152</EventID>
    <Level>2</Level>
    <Task>1</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-02T07:47:51.000000000Z" />
    <EventRecordID>35809</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>[5340] 10/02/12 02:47:51 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape0", SCSI cmd 1a, new handle 858, error 0
</Data>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/2/2012 2:47:51 AM
Event ID:      33152
Task Category: (1)
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
[5340] 10/02/12 02:47:51 Adamm Mover Error: DeviceIo: 00:00:00:00 - Retry Logic: Failed to enable/disable compression on device: HP       Ultrium 5-SCSI 

%2
%3
%4
%5
%6
%7
%8
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">33152</EventID>
    <Level>2</Level>
    <Task>1</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-02T07:47:51.000000000Z" />
    <EventRecordID>35808</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>[5340] 10/02/12 02:47:51 Adamm Mover Error: DeviceIo: 00:00:00:00 - Retry Logic: Failed to enable/disable compression on device: HP       Ultrium 5-SCSI 
</Data>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/2/2012 2:47:51 AM
Event ID:      33152
Task Category: (1)
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
[5340] 10/02/12 02:47:51 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape0", SCSI cmd 1a, new handle 858, error 0

%2
%3
%4
%5
%6
%7
%8
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">33152</EventID>
    <Level>2</Level>
    <Task>1</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-02T07:47:51.000000000Z" />
    <EventRecordID>35807</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>[5340] 10/02/12 02:47:51 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape0", SCSI cmd 1a, new handle 858, error 0
</Data>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/2/2012 2:47:51 AM
Event ID:      33152
Task Category: (1)
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
[5340] 10/02/12 02:47:51 Adamm Mover Error: DeviceIo: 00:00:00:00 - Retry Logic: 2 TURs Failed on device: HP       Ultrium 5-SCSI 

%2
%3
%4
%5
%6
%7
%8
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">33152</EventID>
    <Level>2</Level>
    <Task>1</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-02T07:47:51.000000000Z" />
    <EventRecordID>35806</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>[5340] 10/02/12 02:47:51 Adamm Mover Error: DeviceIo: 00:00:00:00 - Retry Logic: 2 TURs Failed on device: HP       Ultrium 5-SCSI 
</Data>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/2/2012 2:47:51 AM
Event ID:      33152
Task Category: (1)
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
[5340] 10/02/12 02:47:51 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape0", SCSI cmd 00, new handle 858, error 55

%2
%3
%4
%5
%6
%7
%8
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">33152</EventID>
    <Level>2</Level>
    <Task>1</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-02T07:47:51.000000000Z" />
    <EventRecordID>35805</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>[5340] 10/02/12 02:47:51 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape0", SCSI cmd 00, new handle 858, error 55
</Data>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/2/2012 2:47:51 AM
Event ID:      33152
Task Category: (1)
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
[5340] 10/02/12 02:47:51 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape0", SCSI cmd 00, new handle 858, error 0

%2
%3
%4
%5
%6
%7
%8
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">33152</EventID>
    <Level>2</Level>
    <Task>1</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-02T07:47:51.000000000Z" />
    <EventRecordID>35804</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>[5340] 10/02/12 02:47:51 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape0", SCSI cmd 00, new handle 858, error 0
</Data>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/2/2012 2:47:51 AM
Event ID:      33152
Task Category: (1)
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
[5340] 10/02/12 02:47:51 Adamm Mover Error: DeviceIo: 00:00:00:00 - Retry Logic: Retry logic was engaged on device: HP       Ultrium 5-SCSI 

%2
%3
%4
%5
%6
%7
%8
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">33152</EventID>
    <Level>2</Level>
    <Task>1</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-02T07:47:51.000000000Z" />
    <EventRecordID>35803</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>[5340] 10/02/12 02:47:51 Adamm Mover Error: DeviceIo: 00:00:00:00 - Retry Logic: Retry logic was engaged on device: HP       Ultrium 5-SCSI 
</Data>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/2/2012 2:42:51 AM
Event ID:      33152
Task Category: (1)
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
[5340] 10/02/12 02:42:51 Adamm Mover Error: DeviceIo: 05:00:00:00 - Device error 1167 on "\\.\Tape0", SCSI cmd 0a, 1 total errors

%2
%3
%4
%5
%6
%7
%8
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">33152</EventID>
    <Level>2</Level>
    <Task>1</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-02T07:42:51.000000000Z" />
    <EventRecordID>35802</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>[5340] 10/02/12 02:42:51 Adamm Mover Error: DeviceIo: 05:00:00:00 - Device error 1167 on "\\.\Tape0", SCSI cmd 0a, 1 total errors
</Data>
  </EventData>
</Event>

 

Larry_Fine
Moderator
Moderator
   VIP   

The adamm.log shows that command 34 (read_position) failed.  BE then took the drive offline.

[1764] 10/02/12 02:47:51.617 DeviceIo: 05:00:00:00 - Device error 55 on "\\.\Tape0", SCSI cmd 34, 1 total errors
[1764] 10/02/12 02:47:56.896 PvlDrive::DisableAccess() - ReserveDevice failed, offline device
       Drive = 1026 "HP 0003"
       ERROR = 0x0000001F (ERROR_GEN_FAILURE)

[1764] 10/02/12 02:47:56.903 PvlDrive::UpdateOnlineState()
       Drive = 1026 "HP 0003"
       ERROR = The device is offline!

 

The Windows event logs show communication issues.

[2784] 10/02/12 02:47:51 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape0", SCSI cmd 1a, new handle 788, error 55

Description:
Storage device "HP 0003" reported an error on a request to write data to media. Error reported:
This operation returned because the timeout period expired.

 

Do you have the latest drivers and firmware for yout QLogic card?

 

 

 

Julie_Barnes
Level 4

Yes. IBM verified that before they replaced my HBA last week.

Larry_Fine
Moderator
Moderator
   VIP   

Is it always the B2D2T job that has issues?  and the B2T job always works fine?

Is it always the same drive that goes offline?  Can you change the job to use the "good" drive as a test?

Julie_Barnes
Level 4

Job 1 = a backup straight to tape job - always works

Job 2 = D2D2T - worked fine for months. The D2D portion always works fine, but the D2T fails somewhere in the middle of the job when the drive goes offline for whatever reason.

I will swap the drives tonight to see what happens tonight. We did swap every combination of the previous drives, cables and HBA ports and the problem always followed the previous drive. Tandberg sent us a replacement drive and the problem persisted. That's when we went to IBM. They had us update the firmware on the QLogic HBA. Job still failed. IBM had us download and run their DSA utility. I didn't notice any obvious issues, but they sent us a replacement HBA to no avail.

Thanks, Larry. Will update with results.

Larry_Fine
Moderator
Moderator
   VIP   

Just a single BE server and no FC switch, right?

So, it seems you had the issue isolated to a single tape drive, but the replacement tape drive had the same issue?  That is weird, but it sounds like you are on the right tactic to try and identify the bad link in the chain.

Julie_Barnes
Level 4

That is correct. No FC switch. The tape library and both drives test out good with Tandberg's and HP's library and tape utilities. So I moved the QLogic card to a different slot...no change. Then swapped out QLogic HBA...no change. I don't think anything has changed within BE. This is why I'm pulling my hair out. Thanks again!

Julie_Barnes
Level 4

Symantec tech support had me change my library to used "unknown driver" under devices. I did that and then followed the power down/up sequence as suggested. Only wanting to make one change at a time while testing, I did not swap drives yet. But I did not receive a "device not ready (event id 15)" in my system log last night.

Here are the errors from the application log:

Log Name:      Application
Source:        Backup Exec
Date:          10/3/2012 12:37:37 AM
Event ID:      58053
Task Category: None
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
Backup Exec Alert: Device Error
(Server: "SVRTAPE") The drive hardware is offline.

Please confirm that the drive hardware is powered on and properly cabled.

 For more information, click the following link:
http://eventlookup.veritas.com/eventlookup/EventLookup.jhtml
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">58053</EventID>
    <Level>2</Level>
    <Task>0</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-03T05:37:37.000000000Z" />
    <EventRecordID>36232</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>Backup Exec Alert: Device Error
(Server: "SVRTAPE") The drive hardware is offline.

Please confirm that the drive hardware is powered on and properly cabled.</Data>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/3/2012 12:37:32 AM
Event ID:      34113
Task Category: None
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
Backup Exec Alert: Job Failed
(Server: "SVRTAPE") (Job: "Financial Full Backup-Financial Backup Job-Duplicate Financial Backup Sets") Financial Full Backup-Financial Backup Job-Duplicate Financial Backup Sets -- The job failed with the following error: The device timed out.
 

 For more information, click the following link:
http://eventlookup.veritas.com/eventlookup/EventLookup.jhtml
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">34113</EventID>
    <Level>2</Level>
    <Task>0</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-03T05:37:32.000000000Z" />
    <EventRecordID>36231</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>Backup Exec Alert: Job Failed
(Server: "SVRTAPE") (Job: "Financial Full Backup-Financial Backup Job-Duplicate Financial Backup Sets") Financial Full Backup-Financial Backup Job-Duplicate Financial Backup Sets -- The job failed with the following error: The device timed out.
</Data>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/3/2012 12:37:32 AM
Event ID:      58053
Task Category: None
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
Backup Exec Alert: Device Error
(Server: "SVRTAPE") The drive hardware is offline.

Please confirm that the drive hardware is powered on and properly cabled.

 For more information, click the following link:
http://eventlookup.veritas.com/eventlookup/EventLookup.jhtml
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">58053</EventID>
    <Level>2</Level>
    <Task>0</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-03T05:37:32.000000000Z" />
    <EventRecordID>36230</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>Backup Exec Alert: Device Error
(Server: "SVRTAPE") The drive hardware is offline.

Please confirm that the drive hardware is powered on and properly cabled.</Data>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/3/2012 12:37:27 AM
Event ID:      33152
Task Category: (1)
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
[6044] 10/03/12 00:37:27 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape0", SCSI cmd 1a, new handle 8c0, error 0

%2
%3
%4
%5
%6
%7
%8
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">33152</EventID>
    <Level>2</Level>
    <Task>1</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-03T05:37:27.000000000Z" />
    <EventRecordID>36229</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>[6044] 10/03/12 00:37:27 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape0", SCSI cmd 1a, new handle 8c0, error 0
</Data>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/3/2012 12:37:27 AM
Event ID:      33152
Task Category: (1)
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
[6044] 10/03/12 00:37:27 Adamm Mover Error: DeviceIo: 05:00:00:00 - Device error 55 on "\\.\Tape0", SCSI cmd 01, 6 total errors

%2
%3
%4
%5
%6
%7
%8
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">33152</EventID>
    <Level>2</Level>
    <Task>1</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-03T05:37:27.000000000Z" />
    <EventRecordID>36228</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>[6044] 10/03/12 00:37:27 Adamm Mover Error: DeviceIo: 05:00:00:00 - Device error 55 on "\\.\Tape0", SCSI cmd 01, 6 total errors
</Data>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/3/2012 12:37:27 AM
Event ID:      33152
Task Category: (1)
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
[6044] 10/03/12 00:37:27 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape0", SCSI cmd 01, new handle 8c0, error 0

%2
%3
%4
%5
%6
%7
%8
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">33152</EventID>
    <Level>2</Level>
    <Task>1</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-03T05:37:27.000000000Z" />
    <EventRecordID>36227</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>[6044] 10/03/12 00:37:27 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape0", SCSI cmd 01, new handle 8c0, error 0
</Data>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/3/2012 12:37:26 AM
Event ID:      57665
Task Category: None
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
Storage device "HP 0003" reported an error on a request to write data to media.

Error reported:
This operation returned because the timeout period expired.
.

 For more information, click the following link:
http://eventlookup.veritas.com/eventlookup/EventLookup.jhtml
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">57665</EventID>
    <Level>2</Level>
    <Task>0</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-03T05:37:26.000000000Z" />
    <EventRecordID>36226</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>HP 0003</Data>
    <Data>write data to media</Data>
    <Data>This operation returned because the timeout period expired.
</Data>
    <Binary>B4050000F08400E0000001000000000093030000</Binary>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/3/2012 12:37:26 AM
Event ID:      33152
Task Category: (1)
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
[4616] 10/03/12 00:37:26 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape0", SCSI cmd 1a, new handle 748, error 0

%2
%3
%4
%5
%6
%7
%8
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">33152</EventID>
    <Level>2</Level>
    <Task>1</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-03T05:37:26.000000000Z" />
    <EventRecordID>36225</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>[4616] 10/03/12 00:37:26 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape0", SCSI cmd 1a, new handle 748, error 0
</Data>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/3/2012 12:37:26 AM
Event ID:      33152
Task Category: (1)
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
[4616] 10/03/12 00:37:26 Adamm Mover Error: DeviceIo: 00:00:00:00 - Retry Logic: Failed to enable/disable compression on device: HP       Ultrium 5-SCSI  

%2
%3
%4
%5
%6
%7
%8
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">33152</EventID>
    <Level>2</Level>
    <Task>1</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-03T05:37:26.000000000Z" />
    <EventRecordID>36224</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>[4616] 10/03/12 00:37:26 Adamm Mover Error: DeviceIo: 00:00:00:00 - Retry Logic: Failed to enable/disable compression on device: HP       Ultrium 5-SCSI  
</Data>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/3/2012 12:37:26 AM
Event ID:      33152
Task Category: (1)
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
[4616] 10/03/12 00:37:26 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape0", SCSI cmd 1a, new handle 748, error 0

%2
%3
%4
%5
%6
%7
%8
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">33152</EventID>
    <Level>2</Level>
    <Task>1</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-03T05:37:26.000000000Z" />
    <EventRecordID>36223</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>[4616] 10/03/12 00:37:26 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape0", SCSI cmd 1a, new handle 748, error 0
</Data>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/3/2012 12:37:26 AM
Event ID:      33152
Task Category: (1)
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
[4616] 10/03/12 00:37:26 Adamm Mover Error: DeviceIo: 00:00:00:00 - Retry Logic: 2 TURs Failed on device: HP       Ultrium 5-SCSI  

%2
%3
%4
%5
%6
%7
%8
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">33152</EventID>
    <Level>2</Level>
    <Task>1</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-03T05:37:26.000000000Z" />
    <EventRecordID>36222</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>[4616] 10/03/12 00:37:26 Adamm Mover Error: DeviceIo: 00:00:00:00 - Retry Logic: 2 TURs Failed on device: HP       Ultrium 5-SCSI  
</Data>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/3/2012 12:37:26 AM
Event ID:      33152
Task Category: (1)
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
[4616] 10/03/12 00:37:26 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape0", SCSI cmd 00, new handle 748, error 55

%2
%3
%4
%5
%6
%7
%8
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">33152</EventID>
    <Level>2</Level>
    <Task>1</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-03T05:37:26.000000000Z" />
    <EventRecordID>36221</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>[4616] 10/03/12 00:37:26 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape0", SCSI cmd 00, new handle 748, error 55
</Data>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/3/2012 12:37:26 AM
Event ID:      33152
Task Category: (1)
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
[4616] 10/03/12 00:37:26 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape0", SCSI cmd 00, new handle 748, error 0

%2
%3
%4
%5
%6
%7
%8
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">33152</EventID>
    <Level>2</Level>
    <Task>1</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-03T05:37:26.000000000Z" />
    <EventRecordID>36220</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>[4616] 10/03/12 00:37:26 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape0", SCSI cmd 00, new handle 748, error 0
</Data>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/3/2012 12:37:26 AM
Event ID:      33152
Task Category: (1)
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
[4616] 10/03/12 00:37:26 Adamm Mover Error: DeviceIo: 00:00:00:00 - Retry Logic: Retry logic was engaged on device: HP       Ultrium 5-SCSI  

%2
%3
%4
%5
%6
%7
%8
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">33152</EventID>
    <Level>2</Level>
    <Task>1</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-03T05:37:26.000000000Z" />
    <EventRecordID>36219</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>[4616] 10/03/12 00:37:26 Adamm Mover Error: DeviceIo: 00:00:00:00 - Retry Logic: Retry logic was engaged on device: HP       Ultrium 5-SCSI  
</Data>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/3/2012 12:32:26 AM
Event ID:      33152
Task Category: (1)
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
[4616] 10/03/12 00:32:26 Adamm Mover Error: DeviceIo: 05:00:00:00 - Device error 1167 on "\\.\Tape0", SCSI cmd 0a, 1 total errors

%2
%3
%4
%5
%6
%7
%8
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">33152</EventID>
    <Level>2</Level>
    <Task>1</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-03T05:32:26.000000000Z" />
    <EventRecordID>36218</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>[4616] 10/03/12 00:32:26 Adamm Mover Error: DeviceIo: 05:00:00:00 - Device error 1167 on "\\.\Tape0", SCSI cmd 0a, 1 total errors
</Data>
  </EventData>
</Event>

 

I'll continue to work with Symante Tech Support, but if someone here sees something, please let me know. As things stand now, I do plan to switch the drives around tonight. What's frustrating is that everything else works fine. I did numerous inventories, catalogs and restores yesterday using both drives. It only craps out on me while writing.

Thanks again!

Larry_Fine
Moderator
Moderator
   VIP   

re: [6044] 10/03/12 00:37:27 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape0", SCSI cmd 1a, new handle 8c0, error 0

 

the "refresh handle" indicates that the device went away from the operating system and everything after that is BE trying to find the device and recover.  That woud imply a hardware issue to me.

Julie_Barnes
Level 4

Will run library and tape diagnostics again. They all ran fine last week and no errors in system log. I'm not sure what's more frustrating...the hardware or the software. Thanks, Larry.

Jaydeep_S
Level 6
Employee Accredited Certified

As a help in this error I am not sure how the Library and Tape Tools might help you detect the cause as such.

Try to look up the event viewer around the same time stamp as that error message. See if there was any events that indicate either a connection to device lost or any errors or warnings.

re: [6044] 10/03/12 00:37:27 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape0", SCSI cmd 1a, new handle 8c0, error 0

re: [6044] 10/03/12 00:37:27 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape0", SCSI cmd 1a, new handle 8c0, error 0

 

Julie_Barnes
Level 4

Jaydeep - There were no corresponding errors. The Symantec tech that was working on the issue with me kept insisting it had to be hardware. So, I ran through the gamut of hardware tests yet again with no errors.

Everything worked fine last night. Here's my thinking, but I have no hard proof to back it up. A while back, we did lose a tape drive in the library and had to replace it. While waiting for the replacement drive, we moved the good drive to the primary slot in our library. When we got the replacement drive installed, Backup Exec recognized the 2 drives as Tape2 and Tape3. But Tape2 in BE was actually Tape2 in the library and Tape3 in BE was actually Tape1 in the library.

I'm *thinking* maybe the drives being "out of order" so-to-speak might have been causing an issue.

Yesterday, I removed all references to the changer and drives in both BE and the O/S and reinstalled in the correct order, making sure Tape1 in the library was now Tape1 in BE and Tape2 in the library was now Tape2 and making sure the changer was using Microsoft unknown device drivers and the tape drives were using Symantec drivers. Now I'm not 100% sure if my line of thinking is correct or not, but both jobs ran successfully last night and both drives remained online.

Jaydeep_S
Level 6
Employee Accredited Certified

Julie this might be correct. I have seen these entries cause an issue. Hence I normally advice to remove the Tape Drive an Changer entry from Backup Exec and restart the services after any hardware change as a best practise.

Julie_Barnes
Level 4

Well so much for that. Drive dropped offline again last night. No errors in system log. Device manager shows everything as good.

Application log errors as follows:

Log Name:      Application
Source:        Backup Exec
Date:          10/5/2012 12:06:04 AM
Event ID:      58053
Task Category: None
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
Backup Exec Alert: Device Error
(Server: "SVRTAPE") The drive hardware is offline.

Please confirm that the drive hardware is powered on and properly cabled.

 For more information, click the following link:
http://eventlookup.veritas.com/eventlookup/EventLookup.jhtml
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">58053</EventID>
    <Level>2</Level>
    <Task>0</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-05T05:06:04.000000000Z" />
    <EventRecordID>39024</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>Backup Exec Alert: Device Error
(Server: "SVRTAPE") The drive hardware is offline.

Please confirm that the drive hardware is powered on and properly cabled.</Data>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/5/2012 12:05:58 AM
Event ID:      57665
Task Category: None
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
Storage device "HP 0001" reported an error on a request to rewind the media.

Error reported:
A device attached to the system is not functioning.
.

 For more information, click the following link:
http://eventlookup.veritas.com/eventlookup/EventLookup.jhtml
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">57665</EventID>
    <Level>2</Level>
    <Task>0</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-05T05:05:58.000000000Z" />
    <EventRecordID>39023</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>HP 0001</Data>
    <Data>rewind the media</Data>
    <Data>A device attached to the system is not functioning.
</Data>
    <Binary>1F000000F48400E000000000000000009B030000</Binary>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/5/2012 12:05:58 AM
Event ID:      33152
Task Category: (1)
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
[4960] 10/05/12 00:05:58 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape1", SCSI cmd 1a, new handle 914, error 0

%2
%3
%4
%5
%6
%7
%8
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">33152</EventID>
    <Level>2</Level>
    <Task>1</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-05T05:05:58.000000000Z" />
    <EventRecordID>39022</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>[4960] 10/05/12 00:05:58 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape1", SCSI cmd 1a, new handle 914, error 0
</Data>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/5/2012 12:05:58 AM
Event ID:      33152
Task Category: (1)
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
[4960] 10/05/12 00:05:58 Adamm Mover Error: DeviceIo: 05:00:00:00 - Device error 55 on "\\.\Tape1", SCSI cmd 01, 6 total errors

%2
%3
%4
%5
%6
%7
%8
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">33152</EventID>
    <Level>2</Level>
    <Task>1</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-05T05:05:58.000000000Z" />
    <EventRecordID>39021</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>[4960] 10/05/12 00:05:58 Adamm Mover Error: DeviceIo: 05:00:00:00 - Device error 55 on "\\.\Tape1", SCSI cmd 01, 6 total errors
</Data>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/5/2012 12:05:58 AM
Event ID:      33152
Task Category: (1)
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
[4960] 10/05/12 00:05:58 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape1", SCSI cmd 01, new handle 914, error 87

%2
%3
%4
%5
%6
%7
%8
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">33152</EventID>
    <Level>2</Level>
    <Task>1</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-05T05:05:58.000000000Z" />
    <EventRecordID>39020</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>[4960] 10/05/12 00:05:58 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape1", SCSI cmd 01, new handle 914, error 87
</Data>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/5/2012 12:05:57 AM
Event ID:      57665
Task Category: None
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
Storage device "HP 0001" reported an error on a request to write data to media.

Error reported:
This operation returned because the timeout period expired.
.

 For more information, click the following link:
http://eventlookup.veritas.com/eventlookup/EventLookup.jhtml
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">57665</EventID>
    <Level>2</Level>
    <Task>0</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-05T05:05:57.000000000Z" />
    <EventRecordID>39019</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>HP 0001</Data>
    <Data>write data to media</Data>
    <Data>This operation returned because the timeout period expired.
</Data>
    <Binary>B4050000F08400E0000001000000000093030000</Binary>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/5/2012 12:05:57 AM
Event ID:      33152
Task Category: (1)
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
[4616] 10/05/12 00:05:57 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape1", SCSI cmd 1a, new handle 944, error 0

%2
%3
%4
%5
%6
%7
%8
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">33152</EventID>
    <Level>2</Level>
    <Task>1</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-05T05:05:57.000000000Z" />
    <EventRecordID>39018</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>[4616] 10/05/12 00:05:57 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape1", SCSI cmd 1a, new handle 944, error 0
</Data>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/5/2012 12:05:57 AM
Event ID:      33152
Task Category: (1)
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
[4616] 10/05/12 00:05:57 Adamm Mover Error: DeviceIo: 00:00:00:00 - Retry Logic: Failed to enable/disable compression on device: HP       Ultrium 5-SCSI 

%2
%3
%4
%5
%6
%7
%8
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">33152</EventID>
    <Level>2</Level>
    <Task>1</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-05T05:05:57.000000000Z" />
    <EventRecordID>39017</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>[4616] 10/05/12 00:05:57 Adamm Mover Error: DeviceIo: 00:00:00:00 - Retry Logic: Failed to enable/disable compression on device: HP       Ultrium 5-SCSI 
</Data>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/5/2012 12:05:57 AM
Event ID:      33152
Task Category: (1)
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
[4616] 10/05/12 00:05:57 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape1", SCSI cmd 1a, new handle 944, error 0

%2
%3
%4
%5
%6
%7
%8
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">33152</EventID>
    <Level>2</Level>
    <Task>1</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-05T05:05:57.000000000Z" />
    <EventRecordID>39016</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>[4616] 10/05/12 00:05:57 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape1", SCSI cmd 1a, new handle 944, error 0
</Data>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/5/2012 12:05:57 AM
Event ID:      33152
Task Category: (1)
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
[4616] 10/05/12 00:05:57 Adamm Mover Error: DeviceIo: 00:00:00:00 - Retry Logic: 2 TURs Failed on device: HP       Ultrium 5-SCSI 

%2
%3
%4
%5
%6
%7
%8
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">33152</EventID>
    <Level>2</Level>
    <Task>1</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-05T05:05:57.000000000Z" />
    <EventRecordID>39015</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>[4616] 10/05/12 00:05:57 Adamm Mover Error: DeviceIo: 00:00:00:00 - Retry Logic: 2 TURs Failed on device: HP       Ultrium 5-SCSI 
</Data>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/5/2012 12:05:57 AM
Event ID:      33152
Task Category: (1)
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
[4616] 10/05/12 00:05:57 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape1", SCSI cmd 00, new handle 944, error 55

%2
%3
%4
%5
%6
%7
%8
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">33152</EventID>
    <Level>2</Level>
    <Task>1</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-05T05:05:57.000000000Z" />
    <EventRecordID>39014</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>[4616] 10/05/12 00:05:57 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape1", SCSI cmd 00, new handle 944, error 55
</Data>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/5/2012 12:05:57 AM
Event ID:      33152
Task Category: (1)
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
[4616] 10/05/12 00:05:57 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape1", SCSI cmd 00, new handle 944, error 0

%2
%3
%4
%5
%6
%7
%8
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">33152</EventID>
    <Level>2</Level>
    <Task>1</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-05T05:05:57.000000000Z" />
    <EventRecordID>39013</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>[4616] 10/05/12 00:05:57 Adamm Mover Error: DeviceIo: 05:00:00:00 - Refresh handle on "\\.\Tape1", SCSI cmd 00, new handle 944, error 0
</Data>
  </EventData>
</Event>

Log Name:      Application
Source:        Backup Exec
Date:          10/5/2012 12:05:57 AM
Event ID:      33152
Task Category: (1)
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      SvrTape.mcc.local
Description:
[4616] 10/05/12 00:05:57 Adamm Mover Error: DeviceIo: 00:00:00:00 - Retry Logic: Retry logic was engaged on device: HP       Ultrium 5-SCSI 

%2
%3
%4
%5
%6
%7
%8
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="Backup Exec" />
    <EventID Qualifiers="8192">33152</EventID>
    <Level>2</Level>
    <Task>1</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2012-10-05T05:05:57.000000000Z" />
    <EventRecordID>39012</EventRecordID>
    <Channel>Application</Channel>
    <Computer>SvrTape.mcc.local</Computer>
    <Security />
  </System>
  <EventData>
    <Data>[4616] 10/05/12 00:05:57 Adamm Mover Error: DeviceIo: 00:00:00:00 - Retry Logic: Retry logic was engaged on device: HP       Ultrium 5-SCSI 
</Data>
  </EventData>
</Event>

Julie_Barnes
Level 4

They had me switch the tape drives from user-mode drivers to kernel-mode drivers through a registry hack. The backup has run successfully for 3 days now.

Jaydeep_S
Level 6
Employee Accredited Certified

Nice to know that you have working backups now.

Julie_Barnes
Level 4

I spoke too soon. Job failed again today.

Julie_Barnes
Level 4

Addam attached in case anyone out there can help.