Target shown often as offline

[pgehle]

Hi there,

I don't if I'm correct here.
I'm using the free Starwind Initiator and Taperedirector together with Backup Exec 12.5.
The Tandberg LTO2 Tape drive is connected to an Windows 2003 SP2 Server and get'S redirected via Taperedirector to an Windows 2008 R2 Server.
On the Windows 2008 R2 Server I using the Starwind Initiator.
Backup Exec says often that the Tape drive is offline, I can put it online without any problems in Backup Exec.
Someone can give me an advice what I can I do to solve the problem??

Thanks Peter

[anton (staff)]

1) Try using MS iSCSI on the client side.

2) Grab the log from StarWind side and send it back to us. So we'd see is this target, network or other connectivity issue.

[pgehle]

I tried the MS Initiator before with the samer error

[anton (staff)]

Logs?

I tried the MS Initiator before with the samer error

[pgehle]

Currently the Drive is offline, this is the log from the Target:

Code: Select all

5/10 20:01:11.653 684 Tgt: iqn.2008-08.com.starwindsoftware:bosche-svr.bosche-netz.de-tandberglto2: LUN 0 * UNIT ATTENTION (0x28, 0x0)
5/11 11:11:31.556 c98 conf: Control connection closed.
5/11 11:18:14.202 1b4c conf: Accepted control connection from 127.0.0.1:4899.
5/11 11:32:12.237 684 Tgt: iqn.2008-08.com.starwindsoftware:bosche-svr.bosche-netz.de-tandberglto2: LUN 0 * UNIT ATTENTION (0x28, 0x0)
5/12 3:17:37.961 18f0 C[2], LIN: recvData returned 10054
5/12 3:17:37.961 18f0 C[2], LIN: *** 'recv' thread: recv failed 10058.
5/12 3:17:37.961 684 error: assertion failed: c:\_starwind\_v5\starwind\service\common\fn_common.cpp:28 (isEmpty())
5/12 3:17:37.961 684 Tgt: close 'iqn.2008-08.com.starwindsoftware:bosche-svr.bosche-netz.de-tandberglto2': 0 session(s) opened, 1 more allowed.
5/12 3:19:12.630 17f0 Srv: Accepted iSCSI connection from 192.168.102.230:6008 to 192.168.102.254:33268. (Id = 0x3)
5/12 3:19:12.630 17f0 C[3], FREE: Event - CONNECTED.
5/12 3:19:12.630 17f0 C[3], XPT_UP: T3.
5/12 3:19:12.630 1b44 C[3], XPT_UP: Login request: ISID 0x801234567890, TSIH 0x0000.
5/12 3:19:12.630 1b44 C[3], XPT_UP: Event - LOGIN.
5/12 3:19:12.630 1b44 C[3], IN_LOGIN: T4.
5/12 3:19:12.630 1b44 Params: <<< String param 'InitiatorName': received 'iqn.2003-06.com.starwindsoftware.starport:bosche-srv', accepted 'iqn.2003-06.com.starwindsoftware.starport:bosche-srv'
5/12 3:19:12.630 1b44 Params: <<< String param 'TargetName': received 'iqn.2008-08.com.starwindsoftware:bosche-svr.bosche-netz.de-tandberglto2', accepted 'iqn.2008-08.com.starwindsoftware:bosche-svr.bosche-netz.de-tandberglto2'
5/12 3:19:12.630 1b44 Params: <<< Enum param 'SessionType': received 'Normal', accepted 'Normal'
5/12 3:19:12.630 1b44 Params: <<< Enum param 'AuthMethod': received 'None', accepted 'None'
5/12 3:19:12.630 1b44 SPTI: '\\?\scsi#sequential&ven_tandberg&prod_ts400&rev_0468#5&50cb971&0&020#{53f5630b-b6bf-11d0-94f2-00a0c91efb8b}': share: 0 ('').
5/12 3:19:12.630 1b44 SPTI: '\\?\scsi#sequential&ven_tandberg&prod_ts400&rev_0468#5&50cb971&0&020#{53f5630b-b6bf-11d0-94f2-00a0c91efb8b}': 'TANDBERG TS400            0468': adapter 3, bus 0, target 2, LUN 0; maxTransferLength 16777215, alignmentMask 0x0
5/12 3:19:12.630 1b44 PR: Reusing old session 0x2 (new 0x3) from iqn.2003-06.com.starwindsoftware.starport:bosche-srv,801234567890 
5/12 3:19:12.630 1b44 Tgt: open 'iqn.2008-08.com.starwindsoftware:bosche-svr.bosche-netz.de-tandberglto2': 1 session(s) opened, 0 more allowed.
5/12 3:19:12.630 1b44 Params: <<< Enum param 'AuthMethod': received 'None', accepted 'None'
5/12 3:19:12.630 1b44 Params: >>> AuthMethod=None.
5/12 3:19:12.630 1b44 Params: >>> TargetAlias=Tandberg LTO2.
5/12 3:19:12.630 1b44 Params: >>> TargetPortalGroupTag=1.
5/12 3:19:12.630 1428 T[3,1]: session 0x3, connection 0x3 : end of stage 0, next stage 1.
5/12 3:19:12.630 1b44 Params: <<< Numeric param 'ErrorRecoveryLevel': received 0, accepted 0
5/12 3:19:12.630 1b44 Params: <<< Numeric param 'MaxConnections': received 1, accepted 1
5/12 3:19:12.630 1b44 Params: <<< Enum param 'HeaderDigest': received 'None', accepted 'None'
5/12 3:19:12.630 1b44 Params: <<< Enum param 'DataDigest': received 'None', accepted 'None'
5/12 3:19:12.630 1b44 Params: <<< Boolean param 'OFMarker': received No, accepted 0
5/12 3:19:12.630 1b44 Params: <<< Boolean param 'IFMarker': received No, accepted 0
5/12 3:19:12.646 1b44 Params: <<< Boolean param 'InitialR2T': received No, accepted 0
5/12 3:19:12.646 1b44 Params: <<< Boolean param 'ImmediateData': received Yes, accepted 1
5/12 3:19:12.646 1b44 Params: <<< Numeric param 'MaxRecvDataSegmentLength': received 65536, accepted 65536
5/12 3:19:12.646 1b44 Params: <<< Numeric param 'MaxBurstLength': received 262144, accepted 262144
5/12 3:19:12.646 1b44 Params: <<< Numeric param 'FirstBurstLength': received 65536, accepted 65536
5/12 3:19:12.646 1b44 Params: <<< Numeric param 'DefaultTime2Wait': received 5, accepted 5
5/12 3:19:12.646 1b44 Params: <<< Numeric param 'DefaultTime2Retain': received 20, accepted 20
5/12 3:19:12.646 1b44 Params: <<< Numeric param 'MaxOutstandingR2T': received 1, accepted 1
5/12 3:19:12.646 1b44 Params: <<< Boolean param 'DataPDUInOrder': received Yes, accepted 1
5/12 3:19:12.646 1b44 Params: <<< Boolean param 'DataSequenceInOrder': received Yes, accepted 1
5/12 3:19:12.646 1b44 Params: >>> ErrorRecoveryLevel=0.
5/12 3:19:12.646 1b44 Params: >>> MaxConnections=1.
5/12 3:19:12.646 1b44 Params: >>> HeaderDigest=None.
5/12 3:19:12.646 1b44 Params: >>> DataDigest=None.
5/12 3:19:12.646 1b44 Params: >>> OFMarker=No.
5/12 3:19:12.646 1b44 Params: >>> IFMarker=No.
5/12 3:19:12.646 1b44 Params: >>> InitialR2T=No.
5/12 3:19:12.646 1b44 Params: >>> ImmediateData=Yes.
5/12 3:19:12.646 1b44 Params: >>> MaxRecvDataSegmentLength=262144.
5/12 3:19:12.646 1b44 Params: >>> MaxBurstLength=262144.
5/12 3:19:12.646 1b44 Params: >>> FirstBurstLength=65536.
5/12 3:19:12.646 1b44 Params: >>> DefaultTime2Wait=5.
5/12 3:19:12.646 1b44 Params: >>> DefaultTime2Retain=20.
5/12 3:19:12.646 1b44 Params: >>> MaxOutstandingR2T=1.
5/12 3:19:12.646 1b44 Params: >>> DataPDUInOrder=Yes.
5/12 3:19:12.646 1b44 Params: >>> DataSequenceInOrder=Yes.
5/12 3:19:12.646 1428 T[3,1]: session 0x3, connection 0x3 : end of stage 1, next stage 3.
5/12 3:19:12.646 1428 C[3], IN_LOGIN: Event - LOGIN_ACCEPT.
5/12 3:19:12.646 1428 C[3], LIN: T5.
5/12 20:01:26.476 1428 Tgt: iqn.2008-08.com.starwindsoftware:bosche-svr.bosche-netz.de-tandberglto2: LUN 0 * UNIT ATTENTION (0x28, 0x0)

[Anatoly (staff)]

Can we still ask you to send complete log to support@starwindsoftware.com?

[Anatoly (staff)]

Is it possible for you to connect to this drive locally (exclude iSCSI in this way) and to see if the issue will reproduce?

Thank you

[pgehle]

No I can't, it's an internal SCSI tape drive on an older HP Server and the new Server has just SAS

[pgehle]

It is possible there is a problem between the Platforms of the old Windows 2003 (32 bit) Server and the new Windows 2008 (64 Bit) Server.

[Anatoly (staff)]

Possible, but not guarantied.

We have suspicion that probably it is normal behavior for this device with Backup Exec.

[guideclothing]

Hi,

i am having the same problem

i have a Dell R710 as my Win 2008 R2 Hyper-V Server

on it i am running a Win 2008 R2 VM that has Backup Exec 2012

i used to have Beckup Exec installed on the Dell R710 and it worked flawlessly.

Now i am using Tape Redirector to redirect the Tape Drive to the VM.

when there are periods of inactivity the tape drive goes offline in Backup Exec

this never happened before.

the tape drive shows that it online until a job starts and i need to bring the tape drive back online manually in Backup Exec

can you think of any thing that can prevent the tape drive going offline.

thanks

jack

[Anatoly (staff)]

Hi,

May I ask you if you have tried anything that was described in this topic?

[guideclothing]

i am using the MS iScsi Initiator on the VM that is connecting to the tape drive

i am not sure what else there was i should try.

I did not have this problem when the Backup Exec was installed on the host.

have i missed anything else that i should try?

its a really great product

thanks

jack

[guideclothing]

to clarify - this only happens whena tape is ejected and a new tape is put in

i have seen this in the log on the server:

11/20 6:00:08.861 1a30 Tgt: iqn.2008-08.com.starwindsoftware:hypserver1.guideclothing.local-lto5: LUN 0 * UNIT ATTENTION (0x28, 0x0)

does it mean anything to you

[anton (staff)]

Media changes status. I'll talk to guys about handles becoming invalid. Hold on...

to clarify - this only happens whena tape is ejected and a new tape is put in

i have seen this in the log on the server:

11/20 6:00:08.861 1a30 Tgt: iqn.2008-08.com.starwindsoftware:hypserver1.guideclothing.local-lto5: LUN 0 * UNIT ATTENTION (0x28, 0x0)

does it mean anything to you