StarWind Software

Posted: **Thu Jul 21, 2005 7:46 pm**

I got 2 apparent problems with current latest version of StarWind:

1) It seems to unable to gain access to my SATA drives.
You can add the devices in StarWind but not actually connect with StarPort.
The log says something about the drive being in use OR maximum connections reached when none exist(?).

2) Adding my DVD-Writer (Pioneer DVR109) works OK, but when you actually try the use it one of these 2 problems occurs:
(a) StarPort (and the machine) will hang upon adding the device and never recover. A reboot is required.
(b) The device is connected but very little data is transferred before it stops responding.
Trying to disconnect the device will show a dialog box saying that it is in use. When 'OK' is pressed StarPort will hang the machine and never recover. A reboot is required.

All these problems go away if I fall back to StarWind 2.4.0.
I am using StarPort 2.6.0 as my initiator.

Posted: **Thu Jul 21, 2005 8:29 pm**

1) Can you provide us with the log from the working and non-working StarWind versions?

2) Can you try the same with MS initiator? Would help us to isolate the problem.

Thanks!

Posted: **Thu Jul 21, 2005 8:48 pm**

Oh yeah forgot to say. The MS initiator has similar problems but doesn't hang the system totally.
That why I think it is the StarWind side that is going wrong.

I'll just go and sort out some logs.

Posted: **Thu Jul 21, 2005 9:07 pm**

StarWind 2.4.0 Log, all operations successfull:

Code: Select all

20:48:39:437 (3636) conf: 'LogLevel' = '1'
20:48:39:437 (3636) conf: 'LogMask' = '0x8000ffff'
20:48:39:437 (3636) conf: 'Port' = '3260'
20:48:39:437 (3636) conf: 'Interface' = '0.0.0.0'
20:48:39:437 (3636) conf: 'DefTargetName' = 'iqn.2003-06.com.rocketdivision.starwind:$(host).$(symid)'
20:48:39:437 (3636) conf: 'Login' = 'test'
20:48:39:437 (3636) conf: 'Password' = 'test'
20:48:39:437 (3636) conf: 'Echo' = 'no'
20:48:39:437 (3636) conf: 'MinBufferSize' = '65536'
20:48:39:437 (3636) conf: 'AlignmentMask' = '0x0000'
20:48:39:437 (3636) conf: 'MaxPendingRequests' = '64'
20:48:39:437 (3636) conf: Variable 'LogLevel' is set to '1'.
20:48:39:437 (3636) conf: Variable 'LogMask' is set to '0x8000ffff'.
20:48:39:437 (3636) conf: Variable 'Port' is set to '3260'.
20:48:39:437 (3636) conf: Variable 'Interface' is set to '0.0.0.0'.
20:48:39:437 (3636) conf: Variable 'DefTargetName' is set to 'iqn.2003-06.com.rocketdivision.starwind:$(host).$(symid)'.
20:48:39:437 (3636) conf: Variable 'Login' is set to 'test'.
20:48:39:437 (3636) conf: Variable 'Password' is set to 'test'.
20:48:39:437 (3636) conf: Variable 'Echo' is set to 'no'.
20:48:39:437 (3636) conf: Variable 'MinBufferSize' is set to '65536'.
20:48:39:437 (3636) conf: Variable 'AlignmentMask' is set to '0x0000'.
20:48:39:437 (3636) conf: Variable 'MaxPendingRequests' is set to '64'.
20:48:39:437 (3636) conf: 'RamDisk.dll' loaded successfully.
20:48:39:437 (3636) conf: 'ImageFile.dll' loaded successfully.
20:48:39:437 (3636) conf: 'VirtualDvd.dll' loaded successfully.
20:48:39:437 (3636) Srv: Refreshing device list...
20:48:39:468 (3636) Srv: A new SPTI device '\\.\R:' found.
20:48:39:484 (3636) Srv: A new SPTI device '\\.\V:' found.
20:48:39:500 (3636) Srv: A new SPTI device '\\.\W:' found.
20:48:39:515 (3636) Srv: *ERROR* The device '\\.\Cdrom0' is not allowed by the server.
20:48:39:531 (3636) Srv: *ERROR* The device '\\.\Cdrom1' is not allowed by the server.
20:48:39:562 (3636) Srv: *ERROR* The device '\\.\Cdrom2' is not allowed by the server.
20:48:39:562 (3636) Srv: A new SPTI device '\\.\Physicaldrive0' found.
20:48:39:562 (3636) Srv: A new SPTI device '\\.\Physicaldrive1' found.
ImageFile[e34] *ERROR* List_RefreshVolumes: Cannot open the volume '\\.\D:'.
ImageFile[e34] *ERROR* List_RefreshVolumes: Cannot open the volume '\\.\C:'.
ImageFile[e34] *ERROR* ImageFile_Create: '\\.\R:': cannot get size of the image file (0x00000001).
20:48:40:609 (3636) SCSI: Failed to create 'ImageFile3' device.
20:48:40:609 (3636) Srv: Test for device 'ImageFile3' failed.
20:48:40:609 (3636) Srv: A new device 'ImageFile2' found.
ImageFile[e34] *ERROR* ImageFile_Create: '\\.\W:': cannot get size of the image file (0x00000001).
20:48:40:609 (3636) SCSI: Failed to create 'ImageFile1' device.
20:48:40:609 (3636) Srv: Test for device 'ImageFile1' failed.
ImageFile[e34] *ERROR* ImageFile_Create: '\\?\Volume{10275f45-6d4f-11d9-a1c6-806d6172696f}': cannot get size of the image file (0x00000001).
20:48:40:625 (3636) SCSI: Failed to create 'ImageFile0' device.
20:48:40:625 (3636) Srv: Test for device 'ImageFile0' failed.
20:48:40:625 (3636) Srv: (FREE) Binding to 0.0.0.0:3260 ...
20:48:40:656 (3636) Srv: (FREE) Waiting for a connection at port 3260 ...
20:48:40:656 (2648) conf: Waiting for a control connection at port 3261 ...
20:48:51:734 (2648) conf: Accepted the control connection from 127.0.0.1:1259.
20:49:02:546 (3804) S: Assigned target name: 'planets.earth.sata0', SymId: 'Disk.Physicaldrive0'.
20:49:02:546 (3804) S: the device '\\.\Physicaldrive0' is opened successfully.
20:49:02:546 (3804) S: planets.earth.sata0: 1 session(s) allowed.
20:49:02:546 (3804) conf: Target [0x932e0] has been created. Device '\\.\Physicaldrive0' is accesible as target 'planets.earth.sata0'.
20:49:13:312 (3804) S: Assigned target name: 'planets.earth.dvr109', SymId: 'CDDVD.V'.
20:49:13:343 (3804) S: the device '\\.\V:' is opened successfully.
20:49:13:343 (3804) S: planets.earth.dvr109: 1 session(s) allowed.
20:49:13:343 (3804) conf: Target [0x931d0] has been created. Device '\\.\V:' is accesible as target 'planets.earth.dvr109'.
20:50:17:875 (3636) Srv: Accepted connection from 192.168.0.3:1115. id assigned - 4370
20:50:17:875 (3636) C[0x1112], FREE: Event - CONNECTED.
20:50:17:875 (3636) C[0x1112], XPT_UP: T3.
20:50:17:875 (884) C[0x1112], XPT_UP: Login request: ISID 0x801234567890, TSIH 0x0000.
20:50:17:875 (884) C[0x1112], XPT_UP: Event - LOGIN.
20:50:17:875 (884) C[0x1112], IN_LOGIN: T4.
20:50:17:875 (884) Params: <<< String param 'InitiatorName': received 'planets:pluto', accepted 'planets:pluto'
20:50:17:875 (884) Params: <<< Enum param 'SessionType': received 'Discovery', accepted 'Discovery'
20:50:17:875 (884) Params: <<< Enum param 'AuthMethod': received 'None', accepted 'None'
20:50:17:875 (884) Params: Update OFMarkInt according to the value of OFMarker.
20:50:17:875 (884) Params: Update IFMarkInt according to the value of IFMarker.
20:50:17:875 (884) Params: <<< Enum param 'AuthMethod': received 'None', accepted 'None'
20:50:17:875 (884) T[0x1]: Anonimous connection allowed.
20:50:17:875 (884) Params: >>> AuthMethod=None.
20:50:17:875 (4004) T[0x1]: The end of stage 0, next stage is 1.
20:50:17:875 (884) Params: <<< Numeric param 'ErrorRecoveryLevel': received 0, accepted 0
20:50:17:875 (884) Params: <<< Numeric param 'MaxConnections': received 1, accepted 1
20:50:17:875 (884) Params: <<< Enum param 'HeaderDigest': received 'None', accepted 'None'
20:50:17:875 (884) Params: <<< Enum param 'DataDigest': received 'None', accepted 'None'
20:50:17:875 (884) Params: <<< Boolean param 'OFMarker': received No, accepted 0
20:50:17:875 (884) Params: <<< Boolean param 'IFMarker': received No, accepted 0
20:50:17:875 (884) Params: <<< Boolean param 'InitialR2T': received No, accepted 0
20:50:17:875 (884) Params: <<< Boolean param 'ImmediateData': received Yes, accepted 1
20:50:17:875 (884) Params: <<< Numeric param 'MaxRecvDataSegmentLength': received 65536, accepted 65536
20:50:17:875 (884) Params: <<< Numeric param 'MaxBurstLength': received 262144, accepted 262144
20:50:17:875 (884) Params: <<< Numeric param 'FirstBurstLength': received 65536, accepted 65536
20:50:17:875 (884) Params: <<< Numeric param 'DefaultTime2Wait': received 5, accepted 5
20:50:17:875 (884) Params: <<< Numeric param 'DefaultTime2Retain': received 20, accepted 20
20:50:17:875 (884) Params: <<< Numeric param 'MaxOutstandingR2T': received 1, accepted 1
20:50:17:875 (884) Params: <<< Boolean param 'DataPDUInOrder': received Yes, accepted 1
20:50:17:875 (884) Params: <<< Boolean param 'DataSequenceInOrder': received Yes, accepted 1
20:50:17:875 (884) Params: >>> ErrorRecoveryLevel=0.
20:50:17:875 (884) Params: >>> MaxConnections=1.
20:50:17:875 (884) Params: >>> HeaderDigest=None.
20:50:17:875 (884) Params: >>> DataDigest=None.
20:50:17:875 (884) Params: >>> OFMarker=No.
20:50:17:875 (884) Params: >>> IFMarker=No.
20:50:17:875 (884) Params: >>> InitialR2T=No.
20:50:17:875 (884) Params: >>> ImmediateData=Yes.
20:50:17:875 (884) Params: >>> MaxRecvDataSegmentLength=65536.
20:50:17:875 (884) Params: >>> MaxBurstLength=262144.
20:50:17:875 (884) Params: >>> FirstBurstLength=65536.
20:50:17:875 (884) Params: >>> DefaultTime2Wait=5.
20:50:17:875 (884) Params: >>> DefaultTime2Retain=20.
20:50:17:875 (884) Params: >>> MaxOutstandingR2T=1.
20:50:17:875 (884) Params: >>> DataPDUInOrder=Yes.
20:50:17:875 (884) Params: >>> DataSequenceInOrder=Yes.
20:50:17:875 (4004) T[0x1]: The end of stage 1, next stage is 3.
20:50:17:875 (4004) C[0x1112], IN_LOGIN: Event - LOGIN_ACCEPT.
20:50:17:875 (4004) C[0x1112], LOGGED_IN: T5.
20:50:17:875 (4004) C[0x1112], LOGGED_IN: Event - LOGOUT.
20:50:17:875 (4004) C[0x1112], IN_LOGOUT: T9/10.
20:50:17:875 (4000) C[0x1112], IN_LOGOUT: Event - LOGOUT_ACCEPT.
20:50:17:875 (4000) C[0x1112], FREE: T13.
20:50:21:546 (3636) Srv: Accepted connection from 192.168.0.3:1116. id assigned - 4371
20:50:21:546 (3636) C[0x1113], FREE: Event - CONNECTED.
20:50:21:546 (3636) C[0x1113], XPT_UP: T3.
20:50:21:546 (3944) C[0x1113], XPT_UP: Login request: ISID 0x801234567890, TSIH 0x0000.
20:50:21:546 (3944) C[0x1113], XPT_UP: Event - LOGIN.
20:50:21:546 (3944) C[0x1113], IN_LOGIN: T4.
20:50:21:546 (3944) Params: <<< String param 'InitiatorName': received 'planets:pluto', accepted 'planets:pluto'
20:50:21:546 (3944) Params: <<< String param 'TargetName': received 'planets.earth.sata0', accepted 'planets.earth.sata0'
20:50:21:546 (3944) Params: <<< Enum param 'SessionType': received 'Normal', accepted 'Normal'
20:50:21:546 (3944) Params: <<< Enum param 'AuthMethod': received 'None', accepted 'None'
20:50:21:546 (3944) Params: Update OFMarkInt according to the value of OFMarker.
20:50:21:546 (3944) Params: Update IFMarkInt according to the value of IFMarker.
20:50:21:546 (3944) S: planets.earth.sata0: 1 session(s) are opened, 0 more allowed.
20:50:21:546 (3944) Params: <<< Enum param 'AuthMethod': received 'None', accepted 'None'
20:50:21:546 (3944) T[0x1]: Anonimous connection allowed.
20:50:21:546 (3944) Params: >>> AuthMethod=None.
20:50:21:546 (3944) Params: >>> TargetPortalGroupTag=1.
20:50:21:546 (3968) T[0x1]: The end of stage 0, next stage is 1.
20:50:21:546 (3944) Params: <<< Numeric param 'ErrorRecoveryLevel': received 0, accepted 0
20:50:21:546 (3944) Params: <<< Numeric param 'MaxConnections': received 1, accepted 1
20:50:21:546 (3944) Params: <<< Enum param 'HeaderDigest': received 'None', accepted 'None'
20:50:21:546 (3944) Params: <<< Enum param 'DataDigest': received 'None', accepted 'None'
20:50:21:546 (3944) Params: <<< Boolean param 'OFMarker': received No, accepted 0
20:50:21:546 (3944) Params: <<< Boolean param 'IFMarker': received No, accepted 0
20:50:21:546 (3944) Params: <<< Boolean param 'InitialR2T': received No, accepted 0
20:50:21:546 (3944) Params: <<< Boolean param 'ImmediateData': received Yes, accepted 1
20:50:21:546 (3944) Params: <<< Numeric param 'MaxRecvDataSegmentLength': received 65536, accepted 65536
20:50:21:546 (3944) Params: <<< Numeric param 'MaxBurstLength': received 262144, accepted 262144
20:50:21:546 (3944) Params: <<< Numeric param 'FirstBurstLength': received 65536, accepted 65536
20:50:21:546 (3944) Params: <<< Numeric param 'DefaultTime2Wait': received 5, accepted 5
20:50:21:546 (3944) Params: <<< Numeric param 'DefaultTime2Retain': received 20, accepted 20
20:50:21:546 (3944) Params: <<< Numeric param 'MaxOutstandingR2T': received 1, accepted 1
20:50:21:546 (3944) Params: <<< Boolean param 'DataPDUInOrder': received Yes, accepted 1
20:50:21:546 (3944) Params: <<< Boolean param 'DataSequenceInOrder': received Yes, accepted 1
20:50:21:546 (3944) Params: >>> ErrorRecoveryLevel=0.
20:50:21:546 (3944) Params: >>> MaxConnections=1.
20:50:21:546 (3944) Params: >>> HeaderDigest=None.
20:50:21:546 (3944) Params: >>> DataDigest=None.
20:50:21:546 (3944) Params: >>> OFMarker=No.
20:50:21:546 (3944) Params: >>> IFMarker=No.
20:50:21:546 (3944) Params: >>> InitialR2T=No.
20:50:21:546 (3944) Params: >>> ImmediateData=Yes.
20:50:21:546 (3944) Params: >>> MaxRecvDataSegmentLength=65536.
20:50:21:546 (3944) Params: >>> MaxBurstLength=262144.
20:50:21:546 (3944) Params: >>> FirstBurstLength=65536.
20:50:21:546 (3944) Params: >>> DefaultTime2Wait=5.
20:50:21:546 (3944) Params: >>> DefaultTime2Retain=20.
20:50:21:546 (3944) Params: >>> MaxOutstandingR2T=1.
20:50:21:546 (3944) Params: >>> DataPDUInOrder=Yes.
20:50:21:546 (3944) Params: >>> DataSequenceInOrder=Yes.
20:50:21:546 (3968) T[0x1]: The end of stage 1, next stage is 3.
20:50:21:546 (3968) C[0x1113], IN_LOGIN: Event - LOGIN_ACCEPT.
20:50:21:546 (3968) C[0x1113], LOGGED_IN: T5.
20:50:21:546 (3968) SPTI: '\\.\Physicaldrive0': *ERROR* Wrong LUN 0x100. Only LUN 0 is supported!
20:50:33:562 (3636) Srv: Accepted connection from 192.168.0.3:1117. id assigned - 4372
20:50:33:562 (3636) C[0x1114], FREE: Event - CONNECTED.
20:50:33:562 (3636) C[0x1114], XPT_UP: T3.
20:50:33:578 (3928) C[0x1114], XPT_UP: Login request: ISID 0x801234567890, TSIH 0x0000.
20:50:33:578 (3928) C[0x1114], XPT_UP: Event - LOGIN.
20:50:33:578 (3928) C[0x1114], IN_LOGIN: T4.
20:50:33:578 (3928) Params: <<< String param 'InitiatorName': received 'planets:pluto', accepted 'planets:pluto'
20:50:33:578 (3928) Params: <<< Enum param 'SessionType': received 'Discovery', accepted 'Discovery'
20:50:33:578 (3928) Params: <<< Enum param 'AuthMethod': received 'None', accepted 'None'
20:50:33:578 (3928) Params: Update OFMarkInt according to the value of OFMarker.
20:50:33:578 (3928) Params: Update IFMarkInt according to the value of IFMarker.
20:50:33:578 (3928) Params: <<< Enum param 'AuthMethod': received 'None', accepted 'None'
20:50:33:578 (3928) T[0x1]: Anonimous connection allowed.
20:50:33:578 (3928) Params: >>> AuthMethod=None.
20:50:33:578 (2756) T[0x1]: The end of stage 0, next stage is 1.
20:50:33:578 (3928) Params: <<< Numeric param 'ErrorRecoveryLevel': received 0, accepted 0
20:50:33:578 (3928) Params: <<< Numeric param 'MaxConnections': received 1, accepted 1
20:50:33:578 (3928) Params: <<< Enum param 'HeaderDigest': received 'None', accepted 'None'
20:50:33:578 (3928) Params: <<< Enum param 'DataDigest': received 'None', accepted 'None'
20:50:33:578 (3928) Params: <<< Boolean param 'OFMarker': received No, accepted 0
20:50:33:578 (3928) Params: <<< Boolean param 'IFMarker': received No, accepted 0
20:50:33:578 (3928) Params: <<< Boolean param 'InitialR2T': received No, accepted 0
20:50:33:578 (3928) Params: <<< Boolean param 'ImmediateData': received Yes, accepted 1
20:50:33:578 (3928) Params: <<< Numeric param 'MaxRecvDataSegmentLength': received 65536, accepted 65536
20:50:33:578 (3928) Params: <<< Numeric param 'MaxBurstLength': received 262144, accepted 262144
20:50:33:578 (3928) Params: <<< Numeric param 'FirstBurstLength': received 65536, accepted 65536
20:50:33:578 (3928) Params: <<< Numeric param 'DefaultTime2Wait': received 5, accepted 5
20:50:33:578 (3928) Params: <<< Numeric param 'DefaultTime2Retain': received 20, accepted 20
20:50:33:578 (3928) Params: <<< Numeric param 'MaxOutstandingR2T': received 1, accepted 1
20:50:33:578 (3928) Params: <<< Boolean param 'DataPDUInOrder': received Yes, accepted 1
20:50:33:578 (3928) Params: <<< Boolean param 'DataSequenceInOrder': received Yes, accepted 1
20:50:33:578 (3928) Params: >>> ErrorRecoveryLevel=0.
20:50:33:578 (3928) Params: >>> MaxConnections=1.
20:50:33:578 (3928) Params: >>> HeaderDigest=None.
20:50:33:578 (3928) Params: >>> DataDigest=None.
20:50:33:578 (3928) Params: >>> OFMarker=No.
20:50:33:578 (3928) Params: >>> IFMarker=No.
20:50:33:578 (3928) Params: >>> InitialR2T=No.
20:50:33:578 (3928) Params: >>> ImmediateData=Yes.
20:50:33:578 (3928) Params: >>> MaxRecvDataSegmentLength=65536.
20:50:33:578 (3928) Params: >>> MaxBurstLength=262144.
20:50:33:578 (3928) Params: >>> FirstBurstLength=65536.
20:50:33:578 (3928) Params: >>> DefaultTime2Wait=5.
20:50:33:578 (3928) Params: >>> DefaultTime2Retain=20.
20:50:33:578 (3928) Params: >>> MaxOutstandingR2T=1.
20:50:33:578 (3928) Params: >>> DataPDUInOrder=Yes.
20:50:33:578 (3928) Params: >>> DataSequenceInOrder=Yes.
20:50:33:578 (2756) T[0x1]: The end of stage 1, next stage is 3.
20:50:33:578 (2756) C[0x1114], IN_LOGIN: Event - LOGIN_ACCEPT.
20:50:33:578 (2756) C[0x1114], LOGGED_IN: T5.
20:50:33:578 (2756) C[0x1114], LOGGED_IN: Event - LOGOUT.
20:50:33:578 (2756) C[0x1114], IN_LOGOUT: T9/10.
20:50:33:578 (3864) C[0x1114], IN_LOGOUT: Event - LOGOUT_ACCEPT.
20:50:33:578 (3864) C[0x1114], FREE: T13.
20:50:36:625 (3636) Srv: Accepted connection from 192.168.0.3:1118. id assigned - 4373
20:50:36:625 (3636) C[0x1115], FREE: Event - CONNECTED.
20:50:36:625 (3636) C[0x1115], XPT_UP: T3.
20:50:36:625 (3872) C[0x1115], XPT_UP: Login request: ISID 0x801234567890, TSIH 0x0000.
20:50:36:625 (3872) C[0x1115], XPT_UP: Event - LOGIN.
20:50:36:625 (3872) C[0x1115], IN_LOGIN: T4.
20:50:36:625 (3872) Params: <<< String param 'InitiatorName': received 'planets:pluto', accepted 'planets:pluto'
20:50:36:625 (3872) Params: <<< String param 'TargetName': received 'planets.earth.dvr109', accepted 'planets.earth.dvr109'
20:50:36:625 (3872) Params: <<< Enum param 'SessionType': received 'Normal', accepted 'Normal'
20:50:36:625 (3872) Params: <<< Enum param 'AuthMethod': received 'None', accepted 'None'
20:50:36:625 (3872) Params: Update OFMarkInt according to the value of OFMarker.
20:50:36:625 (3872) Params: Update IFMarkInt according to the value of IFMarker.
20:50:36:625 (3872) S: planets.earth.dvr109: 1 session(s) are opened, 0 more allowed.
20:50:36:625 (3872) Params: <<< Enum param 'AuthMethod': received 'None', accepted 'None'
20:50:36:625 (3872) T[0x1]: Anonimous connection allowed.
20:50:36:625 (3872) Params: >>> AuthMethod=None.
20:50:36:625 (3872) Params: >>> TargetPortalGroupTag=1.
20:50:36:625 (3912) T[0x1]: The end of stage 0, next stage is 1.
20:50:36:625 (3872) Params: <<< Numeric param 'ErrorRecoveryLevel': received 0, accepted 0
20:50:36:625 (3872) Params: <<< Numeric param 'MaxConnections': received 1, accepted 1
20:50:36:625 (3872) Params: <<< Enum param 'HeaderDigest': received 'None', accepted 'None'
20:50:36:625 (3872) Params: <<< Enum param 'DataDigest': received 'None', accepted 'None'
20:50:36:625 (3872) Params: <<< Boolean param 'OFMarker': received No, accepted 0
20:50:36:625 (3872) Params: <<< Boolean param 'IFMarker': received No, accepted 0
20:50:36:625 (3872) Params: <<< Boolean param 'InitialR2T': received No, accepted 0
20:50:36:625 (3872) Params: <<< Boolean param 'ImmediateData': received Yes, accepted 1
20:50:36:625 (3872) Params: <<< Numeric param 'MaxRecvDataSegmentLength': received 65536, accepted 65536
20:50:36:625 (3872) Params: <<< Numeric param 'MaxBurstLength': received 262144, accepted 262144
20:50:36:625 (3872) Params: <<< Numeric param 'FirstBurstLength': received 65536, accepted 65536
20:50:36:625 (3872) Params: <<< Numeric param 'DefaultTime2Wait': received 5, accepted 5
20:50:36:625 (3872) Params: <<< Numeric param 'DefaultTime2Retain': received 20, accepted 20
20:50:36:625 (3872) Params: <<< Numeric param 'MaxOutstandingR2T': received 1, accepted 1
20:50:36:625 (3872) Params: <<< Boolean param 'DataPDUInOrder': received Yes, accepted 1
20:50:36:625 (3872) Params: <<< Boolean param 'DataSequenceInOrder': received Yes, accepted 1
20:50:36:625 (3872) Params: >>> ErrorRecoveryLevel=0.
20:50:36:625 (3872) Params: >>> MaxConnections=1.
20:50:36:625 (3872) Params: >>> HeaderDigest=None.
20:50:36:625 (3872) Params: >>> DataDigest=None.
20:50:36:625 (3872) Params: >>> OFMarker=No.
20:50:36:625 (3872) Params: >>> IFMarker=No.
20:50:36:625 (3872) Params: >>> InitialR2T=No.
20:50:36:625 (3872) Params: >>> ImmediateData=Yes.
20:50:36:625 (3872) Params: >>> MaxRecvDataSegmentLength=65536.
20:50:36:625 (3872) Params: >>> MaxBurstLength=262144.
20:50:36:625 (3872) Params: >>> FirstBurstLength=65536.
20:50:36:625 (3872) Params: >>> DefaultTime2Wait=5.
20:50:36:625 (3872) Params: >>> DefaultTime2Retain=20.
20:50:36:625 (3872) Params: >>> MaxOutstandingR2T=1.
20:50:36:625 (3872) Params: >>> DataPDUInOrder=Yes.
20:50:36:625 (3872) Params: >>> DataSequenceInOrder=Yes.
20:50:36:625 (3912) T[0x1]: The end of stage 1, next stage is 3.
20:50:36:625 (3912) C[0x1115], IN_LOGIN: Event - LOGIN_ACCEPT.
20:50:36:625 (3912) C[0x1115], LOGGED_IN: T5.
20:50:36:640 (3912) SPTI: '\\.\V:': *ERROR* Wrong LUN 0x100. Only LUN 0 is supported!
20:51:21:984 (3968) C[0x1113], LOGGED_IN: Event - LOGOUT.
20:51:21:984 (3968) C[0x1113], IN_LOGOUT: T9/10.
20:51:21:984 (2764) C[0x1113], IN_LOGOUT: Event - LOGOUT_ACCEPT.
20:51:21:984 (2764) C[0x1113], FREE: T13.
20:51:21:984 (3968) S: planets.earth.sata0: 0 session(s) are opened, 1 more allowed.
20:51:25:828 (3912) C[0x1115], LOGGED_IN: Event - LOGOUT.
20:51:25:828 (3912) C[0x1115], IN_LOGOUT: T9/10.
20:51:25:828 (3876) C[0x1115], IN_LOGOUT: Event - LOGOUT_ACCEPT.
20:51:25:828 (3876) C[0x1115], FREE: T13.
20:51:25:828 (3912) S: planets.earth.dvr109: 0 session(s) are opened, 1 more allowed.
20:52:03:843 (3804) S: the device '\\.\V:' is closed.
20:52:06:031 (3804) S: the device '\\.\Physicaldrive0' is closed.
20:52:07:828 (3804) conf: A control connection is closed.

StarWind 2.6.1 Log, failed to access the SATA drive, attempted use of DVR109 has hung the initiator machine.
I'm still waiting for it to shutdown!!!!!!!!!

Code: Select all

20:54:35:312 (834) Srv: StarWind iSCSI Target Version 2.6.1 (Build 0x20050322, Win32)
20:54:35:312 (834) Srv: *** TRIAL VERSION *** [ expires in 12 day(s) ]
20:54:35:312 (834) Srv: Please contact Rocket Division Software at <info@rocketdivision.com> for more details.
20:54:35:312 (834) Srv: Unlimited number of client hosts allowed.
20:54:35:312 (834) Srv: Config file: 'C:\Program Files\RCS\StarWind\starwind.conf'
20:54:35:359 (834) conf: 'LogLevel' = '1'
20:54:35:359 (834) conf: 'LogMask' = '0x8fffffff'
20:54:35:359 (834) conf: 'Port' = '3260'
20:54:35:359 (834) conf: 'Interface' = '0.0.0.0'
20:54:35:359 (834) conf: 'DefTargetName' = 'iqn.2003-06.com.rocketdivision.starwind:$(host).$(symid)'
20:54:35:359 (834) conf: 'Login' = 'test'
20:54:35:359 (834) conf: 'Password' = '##CY9rzUYh03PK3k6DJie09g=='
20:54:35:359 (834) conf: 'Echo' = 'no'
20:54:35:359 (834) conf: 'MinBufferSize' = '65536'
20:54:35:359 (834) conf: 'AlignmentMask' = '0x0000'
20:54:35:359 (834) conf: 'MaxPendingRequests' = '64'
20:54:35:359 (834) conf: Variable 'LogLevel' is set to '1'.
20:54:35:359 (834) conf: Variable 'LogMask' is set to '0x8fffffff'.
20:54:35:359 (834) conf: Variable 'Port' is set to '3260'.
20:54:35:359 (834) conf: Variable 'Interface' is set to '0.0.0.0'.
20:54:35:359 (834) conf: Variable 'DefTargetName' is set to 'iqn.2003-06.com.rocketdivision.starwind:$(host).$(symid)'.
20:54:35:359 (834) conf: Variable 'Login' is set to 'test'.
20:54:35:359 (834) conf: Variable 'Password' is set to '##CY9rzUYh03PK3k6DJie09g=='.
20:54:35:359 (834) conf: Variable 'Echo' is set to 'no'.
20:54:35:359 (834) conf: Variable 'MinBufferSize' is set to '65536'.
20:54:35:359 (834) conf: Variable 'AlignmentMask' is set to '0x0000'.
20:54:35:359 (834) conf: Variable 'MaxPendingRequests' is set to '64'.
20:54:35:375 (834) conf: 'RamDisk.dll' loaded successfully.
ImageFile[834]  SscPort_Init: Parse ImageDir: 'images|cdfv|images|img'
ImageFile[834]  SscPort_Init: 
	Dirname: 'C:\Program Files\RCS\StarWind\images'
	Rights: 0xffffffff
	Alias: 'images'
	Extensions: 'img'
ImageFile[834]  SscPort_Init: 	Comment : ''
20:54:35:437 (834) conf: 'ImageFile.dll' loaded successfully.
VirtualDVD[834]  SscPort_Init: Parse ImageDir: 'images|v|images|mds,iso'
Sw:[834]  Browser_DirCreate: Mask mismatch (ff / ff000000)
Sw:[834]  Browser_DirDelete: Mask mismatch (ff / ff0000)
Sw:[834]  Browser_DirCreateFolder: Mask mismatch (ff / ff00)
VirtualDVD[834]  SscPort_Init: 
	Dirname: 'C:\Program Files\RCS\StarWind\images'
	Rights: 0xff
	Alias: 'images'
	Extensions: 'mds,iso'
VirtualDVD[834]  SscPort_Init: 	Comment : ''
20:54:35:468 (834) conf: 'VirtualDvd.dll' loaded successfully.
20:54:35:468 (834) S: the device 'RamDrive0' is opened successfully.
20:54:35:468 (834) S: Assigned target name: 'iqn.2003-06.com.rocketdivision.starwind:earth.ramdisk.ramdrive0', SymId: 'RAMdisk.RamDrive0'.
20:54:35:468 (834) S: parameter 'size', value '16'.
20:54:35:468 (834) S: parameter 'format', value 'yes'.
20:54:35:468 (834) S: clustered 0.
20:54:35:468 (834) S: iqn.2003-06.com.rocketdivision.starwind:earth.ramdisk.ramdrive0: 1 session(s) allowed.
20:54:35:468 (834) conf: Target [0x95b78] has been created. Device 'RamDrive0' is accesible as target 'iqn.2003-06.com.rocketdivision.starwind:earth.ramdisk.ramdrive0'.
20:54:35:468 (834) Srv: Refreshing device list (complete)...
20:54:37:531 (834) SPTI: '\\.\D:': Cannot open the device: The process cannot access the file because it is being used by another process. (code: 32).
20:54:37:578 (834) Srv: A new SPTI device '\\.\R:' found.
20:54:37:609 (834) Srv: A new SPTI device '\\.\V:' found.
20:54:37:609 (834) Srv: A new SPTI device '\\.\W:' found.
20:54:37:687 (834) Srv: A new SPTI device '\\.\PhysicalDrive0' found.
20:54:37:687 (834) Srv: A new SPTI device '\\.\PhysicalDrive1' found.
20:54:37:750 (834) Srv: (FREE) Binding to 0.0.0.0:3260 ...
20:54:42:562 (834) Srv: Waiting for a connection at port 0.0.0.0:3260 ...
20:54:42:562 (844) conf: Waiting for a control connection at port 3261 ...
20:55:04:109 (844) conf: Accepted the control connection from 127.0.0.1:1261.
20:55:08:546 (8d8) Srv: Refreshing device list (complete)...
20:55:10:500 (8d8) SPTI: '\\.\D:': Cannot open the device: The process cannot access the file because it is being used by another process. (code: 32).
20:55:10:546 (8d8) Srv: A new SPTI device '\\.\R:' found.
20:55:10:562 (8d8) Srv: A new SPTI device '\\.\V:' found.
20:55:10:578 (8d8) Srv: A new SPTI device '\\.\W:' found.
20:55:10:640 (8d8) Srv: A new SPTI device '\\.\PhysicalDrive0' found.
20:55:10:640 (8d8) Srv: A new SPTI device '\\.\PhysicalDrive1' found.
20:55:26:015 (8d8) S: the device '\\.\PhysicalDrive0' is opened successfully.
20:55:26:015 (8d8) S: Assigned target name: 'planets.earth.sata0', SymId: 'SPTI:Disk.PhysicalDrive0'.
20:55:26:015 (8d8) S: parameter 'readonly', value 'no'.
20:55:26:015 (8d8) S: sessions 1.
20:55:26:015 (8d8) S: planets.earth.sata0: 1 session(s) allowed.
20:55:26:015 (8d8) conf: Target [0x965d0] has been created. Device '\\.\PhysicalDrive0' is accesible as target 'planets.earth.sata0'.
20:55:30:500 (8d8) Srv: Removing target 'iqn.2003-06.com.rocketdivision.starwind:earth.ramdisk.ramdrive0'...
20:55:30:500 (8d8) S: the device 'RamDrive0' is closed.
20:55:34:781 (8d8) Srv: Refreshing device list (complete)...
20:55:36:437 (8d8) SPTI: '\\.\D:': Cannot open the device: The process cannot access the file because it is being used by another process. (code: 32).
20:55:36:468 (8d8) Srv: A new SPTI device '\\.\R:' found.
20:55:36:500 (8d8) Srv: A new SPTI device '\\.\V:' found.
20:55:36:500 (8d8) Srv: A new SPTI device '\\.\W:' found.
20:55:36:578 (8d8) Srv: A new SPTI device '\\.\PhysicalDrive1' found.
20:55:46:734 (8d8) S: the device '\\.\V:' is opened successfully.
20:55:46:734 (8d8) S: Assigned target name: 'planets.earth.dvr109', SymId: 'SPTI:CDDVD.V'.
20:55:46:734 (8d8) S: parameter 'readonly', value 'no'.
20:55:46:734 (8d8) S: sessions 1.
20:55:46:734 (8d8) S: planets.earth.dvr109: 1 session(s) allowed.
20:55:46:734 (8d8) conf: Target [0x96348] has been created. Device '\\.\V:' is accesible as target 'planets.earth.dvr109'.
20:56:15:015 (834) Srv: Accepted connection from 192.168.0.3:1119. id assigned - 4370
20:56:15:015 (834) C[0x1112], FREE: Event - CONNECTED.
20:56:15:015 (834) C[0x1112], XPT_UP: T3.
20:56:15:015 (d3c) C[0x1112], XPT_UP: Login request: ISID 0x801234567890, TSIH 0x0000.
20:56:15:015 (d3c) C[0x1112], XPT_UP: Event - LOGIN.
20:56:15:015 (d3c) C[0x1112], IN_LOGIN: T4.
20:56:15:015 (d3c) Params: <<< String param 'InitiatorName': received 'planets:pluto', accepted 'planets:pluto'
20:56:15:015 (d3c) Params: <<< Enum param 'SessionType': received 'Discovery', accepted 'Discovery'
20:56:15:015 (d3c) Params: <<< Enum param 'AuthMethod': received 'None', accepted 'None'
20:56:15:015 (d3c) Params: Update OFMarkInt according to the value of OFMarker.
20:56:15:015 (d3c) Params: Update IFMarkInt according to the value of IFMarker.
20:56:15:015 (d3c) Params: <<< Enum param 'AuthMethod': received 'None', accepted 'None'
20:56:15:015 (d3c) T[0x1]: Anonymous connection allowed.
20:56:15:015 (d3c) Params: >>> AuthMethod=None.
20:56:15:015 (9d4) T[0x1]: The end of stage 0, next stage is 1.
20:56:15:015 (d3c) Params: <<< Numeric param 'ErrorRecoveryLevel': received 0, accepted 0
20:56:15:015 (d3c) Params: <<< Numeric param 'MaxConnections': received 1, accepted 1
20:56:15:015 (d3c) Params: <<< Enum param 'HeaderDigest': received 'None', accepted 'None'
20:56:15:015 (d3c) Params: <<< Enum param 'DataDigest': received 'None', accepted 'None'
20:56:15:015 (d3c) Params: <<< Boolean param 'OFMarker': received No, accepted 0
20:56:15:015 (d3c) Params: <<< Boolean param 'IFMarker': received No, accepted 0
20:56:15:015 (d3c) Params: <<< Boolean param 'InitialR2T': received No, accepted 0
20:56:15:015 (d3c) Params: <<< Boolean param 'ImmediateData': received Yes, accepted 1
20:56:15:015 (d3c) Params: <<< Numeric param 'MaxRecvDataSegmentLength': received 65536, accepted 65536
20:56:15:015 (d3c) Params: <<< Numeric param 'MaxBurstLength': received 262144, accepted 262144
20:56:15:031 (d3c) Params: <<< Numeric param 'FirstBurstLength': received 65536, accepted 65536
20:56:15:031 (d3c) Params: <<< Numeric param 'DefaultTime2Wait': received 5, accepted 5
20:56:15:031 (d3c) Params: <<< Numeric param 'DefaultTime2Retain': received 20, accepted 20
20:56:15:031 (d3c) Params: <<< Numeric param 'MaxOutstandingR2T': received 1, accepted 1
20:56:15:031 (d3c) Params: <<< Boolean param 'DataPDUInOrder': received Yes, accepted 1
20:56:15:031 (d3c) Params: <<< Boolean param 'DataSequenceInOrder': received Yes, accepted 1
20:56:15:031 (d3c) Params: >>> ErrorRecoveryLevel=0.
20:56:15:031 (d3c) Params: >>> MaxConnections=1.
20:56:15:031 (d3c) Params: >>> HeaderDigest=None.
20:56:15:031 (d3c) Params: >>> DataDigest=None.
20:56:15:031 (d3c) Params: >>> OFMarker=No.
20:56:15:031 (d3c) Params: >>> IFMarker=No.
20:56:15:031 (d3c) Params: >>> InitialR2T=No.
20:56:15:031 (d3c) Params: >>> ImmediateData=Yes.
20:56:15:031 (d3c) Params: >>> MaxRecvDataSegmentLength=65536.
20:56:15:031 (d3c) Params: >>> MaxBurstLength=262144.
20:56:15:031 (d3c) Params: >>> FirstBurstLength=65536.
20:56:15:031 (d3c) Params: >>> DefaultTime2Wait=5.
20:56:15:031 (d3c) Params: >>> DefaultTime2Retain=20.
20:56:15:031 (d3c) Params: >>> MaxOutstandingR2T=1.
20:56:15:031 (d3c) Params: >>> DataPDUInOrder=Yes.
20:56:15:031 (d3c) Params: >>> DataSequenceInOrder=Yes.
20:56:15:031 (9d4) T[0x1]: The end of stage 1, next stage is 3.
20:56:15:031 (9d4) C[0x1112], IN_LOGIN: Event - LOGIN_ACCEPT.
20:56:15:031 (9d4) C[0x1112], LOGGED_IN: T5.
20:56:15:031 (9d4) C[0x1112], LOGGED_IN: Event - LOGOUT.
20:56:15:031 (9d4) C[0x1112], IN_LOGOUT: T9/10.
20:56:15:031 (9d0) C[0x1112], IN_LOGOUT: Event - LOGOUT_ACCEPT.
20:56:15:031 (9d0) C[0x1112], FREE: T13.
20:56:18:421 (834) Srv: Accepted connection from 192.168.0.3:1120. id assigned - 4371
20:56:18:421 (834) C[0x1113], FREE: Event - CONNECTED.
20:56:18:421 (834) C[0x1113], XPT_UP: T3.
20:56:18:421 (9e8) C[0x1113], XPT_UP: Login request: ISID 0x801234567890, TSIH 0x0000.
20:56:18:421 (9e8) C[0x1113], XPT_UP: Event - LOGIN.
20:56:18:421 (9e8) C[0x1113], IN_LOGIN: T4.
20:56:18:421 (9e8) Params: <<< String param 'InitiatorName': received 'planets:pluto', accepted 'planets:pluto'
20:56:18:421 (9e8) Params: <<< String param 'TargetName': received 'planets.earth.sata0', accepted 'planets.earth.sata0'
20:56:18:421 (9e8) Params: <<< Enum param 'SessionType': received 'Normal', accepted 'Normal'
20:56:18:421 (9e8) Params: <<< Enum param 'AuthMethod': received 'None', accepted 'None'
20:56:18:421 (9e8) Params: Update OFMarkInt according to the value of OFMarker.
20:56:18:421 (9e8) Params: Update IFMarkInt according to the value of IFMarker.
20:56:18:421 (9e8) S: planets.earth.sata0: 1 session(s) are opened, 0 more allowed.
20:56:18:421 (9e8) SPTI: '\\.\PhysicalDrive0': sessions: 1.
20:56:18:421 (9e8) SPTI: '\\.\PhysicalDrive0': '\\?\Volume{588827b9-6d48-11d9-b6f9-806d6172696f}' uses Disk (0)
20:56:20:953 (9e8) SPTI: '\\.\PhysicalDrive0': *** Can't be Locked (error 5)!
20:56:20:953 (9e8) SPTI: '\\.\PhysicalDrive0': Error returned (-10). The drive can't be locked!
20:56:20:953 (9e8) SPTI: '\\.\PhysicalDrive0': Can't lock the drive's volumes. Free locked list...
20:56:20:953 (9e8) SPTI: '\\.\PhysicalDrive0': Can't lock volumes for PhysicalDrive0!
20:56:20:953 (9e8) S[0x2223]: *ERROR* can't register Session. The device '\\.\PhysicalDrive0' may be owned by a local process!
20:56:20:953 (9e8) T[0x1]: *ERROR* Login request: failed while opening the device.
20:56:20:953 (9d8) C[0x1113], IN_LOGIN: Event - LOGIN_REJECT.
20:56:20:953 (9d8) C[0x1113], FREE: T7.
20:57:35:281 (834) Srv: Accepted connection from 192.168.0.3:1121. id assigned - 4372
20:57:35:281 (834) C[0x1114], FREE: Event - CONNECTED.
20:57:35:281 (834) C[0x1114], XPT_UP: T3.
20:57:35:281 (89c) C[0x1114], XPT_UP: Login request: ISID 0x801234567890, TSIH 0x0000.
20:57:35:281 (89c) C[0x1114], XPT_UP: Event - LOGIN.
20:57:35:281 (89c) C[0x1114], IN_LOGIN: T4.
20:57:35:281 (89c) Params: <<< String param 'InitiatorName': received 'planets:pluto', accepted 'planets:pluto'
20:57:35:281 (89c) Params: <<< Enum param 'SessionType': received 'Discovery', accepted 'Discovery'
20:57:35:281 (89c) Params: <<< Enum param 'AuthMethod': received 'None', accepted 'None'
20:57:35:281 (89c) Params: Update OFMarkInt according to the value of OFMarker.
20:57:35:281 (89c) Params: Update IFMarkInt according to the value of IFMarker.
20:57:35:281 (89c) Params: <<< Enum param 'AuthMethod': received 'None', accepted 'None'
20:57:35:281 (89c) T[0x1]: Anonymous connection allowed.
20:57:35:281 (89c) Params: >>> AuthMethod=None.
20:57:35:281 (8b0) T[0x1]: The end of stage 0, next stage is 1.
20:57:35:281 (89c) Params: <<< Numeric param 'ErrorRecoveryLevel': received 0, accepted 0
20:57:35:281 (89c) Params: <<< Numeric param 'MaxConnections': received 1, accepted 1
20:57:35:281 (89c) Params: <<< Enum param 'HeaderDigest': received 'None', accepted 'None'
20:57:35:281 (89c) Params: <<< Enum param 'DataDigest': received 'None', accepted 'None'
20:57:35:281 (89c) Params: <<< Boolean param 'OFMarker': received No, accepted 0
20:57:35:281 (89c) Params: <<< Boolean param 'IFMarker': received No, accepted 0
20:57:35:281 (89c) Params: <<< Boolean param 'InitialR2T': received No, accepted 0
20:57:35:281 (89c) Params: <<< Boolean param 'ImmediateData': received Yes, accepted 1
20:57:35:281 (89c) Params: <<< Numeric param 'MaxRecvDataSegmentLength': received 65536, accepted 65536
20:57:35:281 (89c) Params: <<< Numeric param 'MaxBurstLength': received 262144, accepted 262144
20:57:35:281 (89c) Params: <<< Numeric param 'FirstBurstLength': received 65536, accepted 65536
20:57:35:281 (89c) Params: <<< Numeric param 'DefaultTime2Wait': received 5, accepted 5
20:57:35:281 (89c) Params: <<< Numeric param 'DefaultTime2Retain': received 20, accepted 20
20:57:35:281 (89c) Params: <<< Numeric param 'MaxOutstandingR2T': received 1, accepted 1
20:57:35:281 (89c) Params: <<< Boolean param 'DataPDUInOrder': received Yes, accepted 1
20:57:35:281 (89c) Params: <<< Boolean param 'DataSequenceInOrder': received Yes, accepted 1
20:57:35:281 (89c) Params: >>> ErrorRecoveryLevel=0.
20:57:35:281 (89c) Params: >>> MaxConnections=1.
20:57:35:281 (89c) Params: >>> HeaderDigest=None.
20:57:35:281 (89c) Params: >>> DataDigest=None.
20:57:35:281 (89c) Params: >>> OFMarker=No.
20:57:35:281 (89c) Params: >>> IFMarker=No.
20:57:35:281 (89c) Params: >>> InitialR2T=No.
20:57:35:281 (89c) Params: >>> ImmediateData=Yes.
20:57:35:281 (89c) Params: >>> MaxRecvDataSegmentLength=65536.
20:57:35:281 (89c) Params: >>> MaxBurstLength=262144.
20:57:35:281 (89c) Params: >>> FirstBurstLength=65536.
20:57:35:281 (89c) Params: >>> DefaultTime2Wait=5.
20:57:35:281 (89c) Params: >>> DefaultTime2Retain=20.
20:57:35:281 (89c) Params: >>> MaxOutstandingR2T=1.
20:57:35:281 (89c) Params: >>> DataPDUInOrder=Yes.
20:57:35:281 (89c) Params: >>> DataSequenceInOrder=Yes.
20:57:35:281 (8b0) T[0x1]: The end of stage 1, next stage is 3.
20:57:35:281 (8b0) C[0x1114], IN_LOGIN: Event - LOGIN_ACCEPT.
20:57:35:281 (8b0) C[0x1114], LOGGED_IN: T5.
20:57:35:281 (8b0) C[0x1114], LOGGED_IN: Event - LOGOUT.
20:57:35:281 (8b0) C[0x1114], IN_LOGOUT: T9/10.
20:57:35:281 (8d0) C[0x1114], IN_LOGOUT: Event - LOGOUT_ACCEPT.
20:57:35:281 (8d0) C[0x1114], FREE: T13.
20:57:37:546 (834) Srv: Accepted connection from 192.168.0.3:1122. id assigned - 4373
20:57:37:546 (834) C[0x1115], FREE: Event - CONNECTED.
20:57:37:546 (834) C[0x1115], XPT_UP: T3.
20:57:37:546 (6f0) C[0x1115], XPT_UP: Login request: ISID 0x801234567890, TSIH 0x0000.
20:57:37:546 (6f0) C[0x1115], XPT_UP: Event - LOGIN.
20:57:37:546 (6f0) C[0x1115], IN_LOGIN: T4.
20:57:37:546 (6f0) Params: <<< String param 'InitiatorName': received 'planets:pluto', accepted 'planets:pluto'
20:57:37:546 (6f0) Params: <<< String param 'TargetName': received 'planets.earth.dvr109', accepted 'planets.earth.dvr109'
20:57:37:546 (6f0) Params: <<< Enum param 'SessionType': received 'Normal', accepted 'Normal'
20:57:37:546 (6f0) Params: <<< Enum param 'AuthMethod': received 'None', accepted 'None'
20:57:37:562 (6f0) Params: Update OFMarkInt according to the value of OFMarker.
20:57:37:562 (6f0) Params: Update IFMarkInt according to the value of IFMarker.
20:57:37:562 (6f0) S: planets.earth.dvr109: 1 session(s) are opened, 0 more allowed.
20:57:37:593 (6f0) SPTI: '\\.\V:': sessions: 1.
20:57:37:593 (6f0) T[0x1]: iSCSI parameters set according to the device's MaxTransferLength (131072)
20:57:37:593 (6f0) Params: <<< Enum param 'AuthMethod': received 'None', accepted 'None'
20:57:37:593 (6f0) T[0x1]: Anonymous connection allowed.
20:57:37:593 (6f0) Params: >>> AuthMethod=None.
20:57:37:593 (6f0) Params: >>> TargetPortalGroupTag=1.
20:57:37:593 (894) T[0x1]: The end of stage 0, next stage is 1.
20:57:37:593 (6f0) Params: <<< Numeric param 'ErrorRecoveryLevel': received 0, accepted 0
20:57:37:593 (6f0) Params: <<< Numeric param 'MaxConnections': received 1, accepted 1
20:57:37:593 (6f0) Params: <<< Enum param 'HeaderDigest': received 'None', accepted 'None'
20:57:37:593 (6f0) Params: <<< Enum param 'DataDigest': received 'None', accepted 'None'
20:57:37:593 (6f0) Params: <<< Boolean param 'OFMarker': received No, accepted 0
20:57:37:593 (6f0) Params: <<< Boolean param 'IFMarker': received No, accepted 0
20:57:37:593 (6f0) Params: <<< Boolean param 'InitialR2T': received No, accepted 0
20:57:37:593 (6f0) Params: <<< Boolean param 'ImmediateData': received Yes, accepted 1
20:57:37:593 (6f0) Params: <<< Numeric param 'MaxRecvDataSegmentLength': received 65536, accepted 65536
20:57:37:593 (6f0) Params: <<< Numeric param 'MaxBurstLength': received 262144, accepted 131072
20:57:37:593 (6f0) Params: <<< Numeric param 'FirstBurstLength': received 65536, accepted 65536
20:57:37:593 (6f0) Params: <<< Numeric param 'DefaultTime2Wait': received 5, accepted 5
20:57:37:593 (6f0) Params: <<< Numeric param 'DefaultTime2Retain': received 20, accepted 20
20:57:37:593 (6f0) Params: <<< Numeric param 'MaxOutstandingR2T': received 1, accepted 1
20:57:37:593 (6f0) Params: <<< Boolean param 'DataPDUInOrder': received Yes, accepted 1
20:57:37:593 (6f0) Params: <<< Boolean param 'DataSequenceInOrder': received Yes, accepted 1
20:57:37:593 (6f0) Params: >>> ErrorRecoveryLevel=0.
20:57:37:593 (6f0) Params: >>> MaxConnections=1.
20:57:37:593 (6f0) Params: >>> HeaderDigest=None.
20:57:37:593 (6f0) Params: >>> DataDigest=None.
20:57:37:593 (6f0) Params: >>> OFMarker=No.
20:57:37:593 (6f0) Params: >>> IFMarker=No.
20:57:37:593 (6f0) Params: >>> InitialR2T=No.
20:57:37:593 (6f0) Params: >>> ImmediateData=Yes.
20:57:37:593 (6f0) Params: >>> MaxRecvDataSegmentLength=131072.
20:57:37:593 (6f0) Params: >>> MaxBurstLength=131072.
20:57:37:593 (6f0) Params: >>> FirstBurstLength=65536.
20:57:37:593 (6f0) Params: >>> DefaultTime2Wait=5.
20:57:37:593 (6f0) Params: >>> DefaultTime2Retain=20.
20:57:37:593 (6f0) Params: >>> MaxOutstandingR2T=1.
20:57:37:593 (6f0) Params: >>> DataPDUInOrder=Yes.
20:57:37:593 (6f0) Params: >>> DataSequenceInOrder=Yes.
20:57:37:593 (894) T[0x1]: The end of stage 1, next stage is 3.
20:57:37:593 (894) C[0x1115], IN_LOGIN: Event - LOGIN_ACCEPT.
20:57:37:593 (894) C[0x1115], LOGGED_IN: T5.
20:59:11:875 (8d8) Srv: Removing target 'planets.earth.sata0'...
20:59:11:875 (8d8) S: the device '\\.\PhysicalDrive0' is closed.
20:59:15:140 (8d8) Srv: Remove: Target 'planets.earth.dvr109' is busy and can't be removed now.
20:59:30:453 (8d8) conf: A control connection is closed.

I'll post the StarPort logs when I get the hung machine back up!

Posted: **Thu Jul 21, 2005 9:29 pm**

StarPort 2.6.0 Log, connecting to StarWind 2.4.0, no problems:

Code: Select all

20:53:36 - Entering func: CLanguager::LoadLanguage(language=0x409)
20:53:36 - Exiting  func: CLanguager::LoadLanguage(language=0x409)
20:53:36 - CStarPortApp::CheckLicense: Licensed to: 'FREE', 'NOT COMERCIAL', (#1, 0).
20:53:36 - Entering func: CStarPortAPI::CStarPortAPI()
20:53:36 - Entering func: CStarPortAPI::DriverOpen()
20:53:36 - Exiting  func: CStarPortAPI::DriverOpen()
20:53:36 - Entering func: CStarPortAPI::DriverVersion(...)
20:53:36 - CStarPortAPI::DriverVersion: Calling STARPORT_IOCTL_GET_VERSION
20:53:36 - CStarPortAPI::DriverVersion: Input buffer:
20:53:36 - CStarPortAPI::DriverVersion: Signature = 72417453:
20:53:36 - CStarPortAPI::DriverVersion: ApiVersion = 20002:
20:53:36 - CStarPortAPI::DriverVersion: Calling DeviceIoControl(...)
20:53:36 - CStarPortAPI::DriverVersion: DeviceIoControl(...) called successfully
20:53:36 - CStarPortAPI::DriverVersion: Output buffer:
20:53:36 - CStarPortAPI::DriverVersion: Signature = 52615473
20:53:36 - CStarPortAPI::DriverVersion: Version = 20050310
20:53:36 - CStarPortAPI::DriverVersion: ApiVersion = 20002
20:53:36 - CStarPortAPI::DriverVersion: Flags = 0
20:53:36 - Exiting  func: CStarPortAPI::DriverVersion(...)
20:53:36 - CStarPortAPI::CStarPortAPI: StarPort version: 20050310; StarPort driver: API v20002, Build 0x20050310
20:53:36 - Exiting  func: CStarPortAPI::CStarPortAPI()
20:53:36 - Entering func: CDriveLetterMap::CDriveLetterMap()
20:53:36 - Entering func: CDriveLetterMap::Refresh()
20:53:36 - Exiting  func: CDriveLetterMap::Refresh()
20:53:36 - Exiting  func: CDriveLetterMap::CDriveLetterMap()
20:53:36 - Entering func: CStarPortDoc::CStarPortDoc()
20:53:36 - Exiting  func: CStarPortDoc::CStarPortDoc()
20:53:36 - CMainFrame::OnCreate: Minimizing application to tray.
20:53:36 - Entering func: CStarPortView::OnInitialUpdate()
20:53:36 - Entering func: CStarPortDoc::ResyncRegistryAndDriverContents(bAutomountDevices=1)
20:53:36 - Entering func: CDriveLetterMap::Refresh()
20:53:36 - Exiting  func: CDriveLetterMap::Refresh()
20:53:36 - CStarPortDoc::ResyncRegistryAndDriverContents: Resyncronizing contents...
20:53:36 - Entering func: CStarPortAPI::GetDevices(...)
20:53:36 - CStarPortAPI::GetDevices: Calling STARPORT_IOCTL_TARGET_LIST
20:53:36 - CStarPortAPI::GetDevices: Input buffer:
20:53:36 - CStarPortAPI::GetDevices: Signature = 72417453
20:53:36 - CStarPortAPI::GetDevices: Calling DeviceIoControl(...)
20:53:36 - CStarPortAPI::GetDevices: DeviceIoControl(...) called successfully
20:53:36 - CStarPortAPI::GetDevices: Output buffer:
20:53:36 - CStarPortAPI::GetDevices: Signature = 52615473
20:53:36 - CStarPortAPI::GetDevices: NumberOfTargets = 0
20:53:36 - Exiting  func: CStarPortAPI::GetDevices(...)
20:53:36 - Exiting  func: CStarPortDoc::ResyncRegistryAndDriverContents(bAutomountDevices=1)
20:53:36 - Exiting  func: CStarPortView::OnInitialUpdate()
20:53:39 - CMainFrame::OnTrayStartManagement: Maximizing from tray.
20:53:40 - Entering func: CStarPortView::OnRButtonDown(...)
20:53:40 - CStarPortView::OnRButtonDown: Calling OnContextMenu.
20:53:40 - Entering func: CStarPortView::OnContextMenu(...)
20:53:41 - Exiting  func: CStarPortView::OnContextMenu(...)
20:53:41 - Exiting  func: CStarPortView::OnRButtonDown(...)
20:53:44 - Entering func: CStarPortDoc::SaveConfiguration()
20:53:44 - Exiting  func: CStarPortDoc::SaveConfiguration()
20:53:47 - Entering func: CStarPortDoc::SaveConfiguration()
20:53:47 - Exiting  func: CStarPortDoc::SaveConfiguration()
20:53:51 - Entering func: CStarPortAPI::GetTargets(dwIPAddress=0xC0A80002, DWORD dwPort=3260, listTargets=...)
20:53:51 - CStarPortAPI::GetTargets: Calling STARPORT_IOCTL_GET_TARGETS
20:53:51 - CStarPortAPI::GetTargets: Input buffer:
20:53:51 - CStarPortAPI::GetTargets: Signature = 72417453
20:53:51 - CStarPortAPI::GetTargets: ServerAddress = 192.168.0.2:3260
20:53:51 - CStarPortAPI::GetTargets: Parameter[0] = InitiatorName=planets:pluto
20:53:51 - CStarPortAPI::GetTargets: Calling DeviceIoControl(...)
20:53:51 - CStarPortAPI::GetTargets: DeviceIoControl(...) called successfully
20:53:51 - CStarPortAPI::GetTargets: Output buffer:
20:53:51 - CStarPortAPI::GetTargets: Signature = 52615473
20:53:51 - CStarPortAPI::GetTargets: TargetsInfo[0] = TargetName=planets.earth.dvr109
20:53:51 - CStarPortAPI::GetTargets: TargetsInfo[1] = TargetName=planets.earth.sata0
20:53:51 - Entering func: CStarPortAPI::AddTargetToList(target=..., listTargets=...)
20:53:51 - CStarPortAPI::AddTargetToList: Target addresses list is empty, adding default IP/Port pair.
20:53:51 - Exiting  func: CStarPortAPI::AddTargetToList(target=..., listTargets=...)
20:53:51 - Entering func: CStarPortAPI::AddTargetToList(target=..., listTargets=...)
20:53:51 - CStarPortAPI::AddTargetToList: Target addresses list is empty, adding default IP/Port pair.
20:53:51 - Exiting  func: CStarPortAPI::AddTargetToList(target=..., listTargets=...)
20:53:51 - CStarPortAPI::GetTargets: Server at IP:0xC0A80002, Port:3260 returned the following targets:
20:53:51 - CStarPortAPI::GetTargets: 	TargetName:planets.earth.dvr109
20:53:51 - CStarPortAPI::GetTargets: 		TargetAddress: IP:0xC0A80002, Port:3260
20:53:51 - CStarPortAPI::GetTargets: 	TargetName:planets.earth.sata0
20:53:51 - CStarPortAPI::GetTargets: 		TargetAddress: IP:0xC0A80002, Port:3260
20:53:51 - Exiting  func: CStarPortAPI::GetTargets(dwIPAddress=0xC0A80002, DWORD dwPort=3260, listTargets=...)
20:53:54 - CWPPiSCSITargetSelection::CreateDevice: Trying to add an iSCSI device using TargetName=planets.earth.sata0, IP:0xC0A80002, Port:3260
20:53:54 - Entering func: CStarPortDoc::CreateiSCSIDevice(IP=0xC0A80002, Port=3260, TargetName=planets.earth.sata0, bAutomount=0)
20:53:54 - Entering func: CStarPortAPI::InsertiSCSIDevice(dwIPAddress=0xC0A80002, dwPort=3260, szInitiaotrName=planets:pluto, szTargetName=planets.earth.sata0, szAdditionalParameter=, nTargetID=...)
20:53:54 - CStarPortAPI::InsertiSCSIDevice: Calling STARPORT_IOCTL_TARGET_MOUNT
20:53:54 - CStarPortAPI::InsertiSCSIDevice: Input buffer:
20:53:54 - CStarPortAPI::InsertiSCSIDevice: Signature = 72417453
20:53:54 - CStarPortAPI::InsertiSCSIDevice: Flags = 0
20:53:54 - CStarPortAPI::InsertiSCSIDevice: ServerAddress = 192.168.0.2:3260
20:53:54 - CStarPortAPI::InsertiSCSIDevice: Parameter[0] = InitiatorName=planets:pluto
20:53:54 - CStarPortAPI::InsertiSCSIDevice: Parameter[1] = TargetName=planets.earth.sata0
20:53:54 - CStarPortAPI::InsertiSCSIDevice: Calling DeviceIoControl(...)
20:53:54 - CStarPortAPI::InsertiSCSIDevice: DeviceIoControl(...) called successfully
20:53:54 - CStarPortAPI::InsertiSCSIDevice: Output buffer:
20:53:54 - CStarPortAPI::InsertiSCSIDevice: Signature = 52615473
20:53:54 - CStarPortAPI::InsertiSCSIDevice: TargetId = 3
20:53:54 - CStarPortAPI::InsertiSCSIDevice: NumberOfUnits = 1
20:53:54 - Exiting  func: CStarPortAPI::InsertiSCSIDevice(dwIPAddress=0xC0A80002, dwPort=3260, szInitiaotrName=planets:pluto, szTargetName=planets.earth.sata0, szAdditionalParameter=, nTargetID=...)
20:53:54 - Entering func: CStarPortDoc::SaveConfiguration()
20:53:54 - Exiting  func: CStarPortDoc::SaveConfiguration()
20:53:55 - Exiting  func: CStarPortDoc::CreateiSCSIDevice(IP=0xC0A80002, Port=3260, TargetName=planets.earth.sata0, bAutomount=0)
20:53:55 - Entering func: CStarPortDoc::ResyncRegistryAndDriverContents(bAutomountDevices=0)
20:53:55 - Entering func: CDriveLetterMap::Refresh()
20:53:55 - Exiting  func: CDriveLetterMap::Refresh()
20:53:55 - CStarPortDoc::ResyncRegistryAndDriverContents: Resyncronizing contents...
20:53:55 - Entering func: CStarPortAPI::GetDevices(...)
20:53:55 - CStarPortAPI::GetDevices: Calling STARPORT_IOCTL_TARGET_LIST
20:53:55 - CStarPortAPI::GetDevices: Input buffer:
20:53:55 - CStarPortAPI::GetDevices: Signature = 72417453
20:53:55 - CStarPortAPI::GetDevices: Calling DeviceIoControl(...)
20:53:55 - CStarPortAPI::GetDevices: DeviceIoControl(...) called successfully
20:53:55 - CStarPortAPI::GetDevices: Output buffer:
20:53:55 - CStarPortAPI::GetDevices: Signature = 52615473
20:53:55 - CStarPortAPI::GetDevices: NumberOfTargets = 1
20:53:55 - CStarPortAPI::GetDevices: TargetID[0] = 3
20:53:55 - CStarPortAPI::GetDevices: Calling STARPORT_IOCTL_TARGET_INFO
20:53:55 - CStarPortAPI::GetDevices: Input buffer:
20:53:55 - CStarPortAPI::GetDevices: Signature = 72417453
20:53:55 - CStarPortAPI::GetDevices: TargetId = 3
20:53:55 - CStarPortAPI::GetDevices: Calling DeviceIoControl(...)
20:53:55 - CStarPortAPI::GetDevices: DeviceIoControl(...) called successfully
20:53:55 - CStarPortAPI::GetDevices: Output buffer:
20:53:55 - CStarPortAPI::GetDevices: Signature = 52615473
20:53:55 - CStarPortAPI::GetDevices: TargetId = 0
20:53:55 - CStarPortAPI::GetDevices: ServerAddress = 192.168.0.2:3260
20:53:55 - CStarPortAPI::GetDevices: TargetDescriptionLength = 59
20:53:55 - CStarPortAPI::GetDevices: TargetDescription[0] = InitiatorName=planets:pluto
20:53:55 - CStarPortAPI::GetDevices: TargetDescription[1] = TargetName=planets.earth.sata0
20:53:55 - CStarPortAPI::GetDevices: NumberOfUnits = 1
20:53:55 - CStarPortAPI::GetDevices: LunInfo[0] = 0
20:53:55 - Exiting  func: CStarPortAPI::GetDevices(...)
20:53:55 - CStarPortAPI::CheckConnectionStatus: TargetId = 3
20:53:55 - CStarPortAPI::CheckConnectionStatus: DeviceIoControl(...) called successfully, Target device status = 2
20:53:55 - Entering func: CStarPortDoc::SaveConfiguration()
20:53:55 - Exiting  func: CStarPortDoc::SaveConfiguration()
20:53:55 - Exiting  func: CStarPortDoc::ResyncRegistryAndDriverContents(bAutomountDevices=0)
20:53:55 - Entering func: CStarPortDoc::SaveConfiguration()
20:53:55 - Exiting  func: CStarPortDoc::SaveConfiguration()
20:53:55 - CMainFrame::WindowProc: WM_DEVICECHANGE message received: wParam=0x7, lParam=0x0.
20:53:55 - CMainFrame::WindowProc: WM_DEVICECHANGE message received: wParam=0x7, lParam=0x0.
20:53:55 - CMainFrame::WindowProc: WM_DEVICECHANGE message received: wParam=0x7, lParam=0x0.
20:53:56 - CMainFrame::WindowProc: WM_DEVICECHANGE message received: wParam=0x8000, lParam=0x12FE20.
20:53:56 - CMainFrame::WindowProc: WM_DEVICECHANGE message received: wParam=0x7, lParam=0x0.
20:54:06 - Entering func: CStarPortAPI::GetTargets(dwIPAddress=0xC0A80002, DWORD dwPort=3260, listTargets=...)
20:54:06 - CStarPortAPI::GetTargets: Calling STARPORT_IOCTL_GET_TARGETS
20:54:06 - CStarPortAPI::GetTargets: Input buffer:
20:54:06 - CStarPortAPI::GetTargets: Signature = 72417453
20:54:06 - CStarPortAPI::GetTargets: ServerAddress = 192.168.0.2:3260
20:54:06 - CStarPortAPI::GetTargets: Parameter[0] = InitiatorName=planets:pluto
20:54:06 - CStarPortAPI::GetTargets: Calling DeviceIoControl(...)
20:54:06 - CStarPortAPI::GetTargets: DeviceIoControl(...) called successfully
20:54:06 - CStarPortAPI::GetTargets: Output buffer:
20:54:06 - CStarPortAPI::GetTargets: Signature = 52615473
20:54:06 - CStarPortAPI::GetTargets: TargetsInfo[0] = TargetName=planets.earth.dvr109
20:54:06 - CStarPortAPI::GetTargets: TargetsInfo[1] = TargetName=planets.earth.sata0
20:54:06 - Entering func: CStarPortAPI::AddTargetToList(target=..., listTargets=...)
20:54:06 - CStarPortAPI::AddTargetToList: Target addresses list is empty, adding default IP/Port pair.
20:54:06 - Exiting  func: CStarPortAPI::AddTargetToList(target=..., listTargets=...)
20:54:06 - Entering func: CStarPortAPI::AddTargetToList(target=..., listTargets=...)
20:54:06 - CStarPortAPI::AddTargetToList: Target addresses list is empty, adding default IP/Port pair.
20:54:06 - Exiting  func: CStarPortAPI::AddTargetToList(target=..., listTargets=...)
20:54:06 - CStarPortAPI::GetTargets: Server at IP:0xC0A80002, Port:3260 returned the following targets:
20:54:06 - CStarPortAPI::GetTargets: 	TargetName:planets.earth.dvr109
20:54:06 - CStarPortAPI::GetTargets: 		TargetAddress: IP:0xC0A80002, Port:3260
20:54:06 - CStarPortAPI::GetTargets: 	TargetName:planets.earth.sata0
20:54:06 - CStarPortAPI::GetTargets: 		TargetAddress: IP:0xC0A80002, Port:3260
20:54:06 - Exiting  func: CStarPortAPI::GetTargets(dwIPAddress=0xC0A80002, DWORD dwPort=3260, listTargets=...)
20:54:10 - CWPPiSCSITargetSelection::CreateDevice: Trying to add an iSCSI device using TargetName=planets.earth.dvr109, IP:0xC0A80002, Port:3260
20:54:10 - Entering func: CStarPortDoc::CreateiSCSIDevice(IP=0xC0A80002, Port=3260, TargetName=planets.earth.dvr109, bAutomount=1)
20:54:10 - Entering func: CStarPortAPI::InsertiSCSIDevice(dwIPAddress=0xC0A80002, dwPort=3260, szInitiaotrName=planets:pluto, szTargetName=planets.earth.dvr109, szAdditionalParameter=, nTargetID=...)
20:54:10 - CStarPortAPI::InsertiSCSIDevice: Calling STARPORT_IOCTL_TARGET_MOUNT
20:54:10 - CStarPortAPI::InsertiSCSIDevice: Input buffer:
20:54:10 - CStarPortAPI::InsertiSCSIDevice: Signature = 72417453
20:54:10 - CStarPortAPI::InsertiSCSIDevice: Flags = 0
20:54:10 - CStarPortAPI::InsertiSCSIDevice: ServerAddress = 192.168.0.2:3260
20:54:10 - CStarPortAPI::InsertiSCSIDevice: Parameter[0] = InitiatorName=planets:pluto
20:54:10 - CStarPortAPI::InsertiSCSIDevice: Parameter[1] = TargetName=planets.earth.dvr109
20:54:10 - CStarPortAPI::InsertiSCSIDevice: Calling DeviceIoControl(...)
20:54:10 - CStarPortAPI::InsertiSCSIDevice: DeviceIoControl(...) called successfully
20:54:10 - CStarPortAPI::InsertiSCSIDevice: Output buffer:
20:54:10 - CStarPortAPI::InsertiSCSIDevice: Signature = 52615473
20:54:10 - CStarPortAPI::InsertiSCSIDevice: TargetId = 4
20:54:10 - CStarPortAPI::InsertiSCSIDevice: NumberOfUnits = 1
20:54:10 - Exiting  func: CStarPortAPI::InsertiSCSIDevice(dwIPAddress=0xC0A80002, dwPort=3260, szInitiaotrName=planets:pluto, szTargetName=planets.earth.dvr109, szAdditionalParameter=, nTargetID=...)
20:54:10 - Entering func: CStarPortDoc::SaveConfiguration()
20:54:10 - Exiting  func: CStarPortDoc::SaveConfiguration()
20:54:10 - Exiting  func: CStarPortDoc::CreateiSCSIDevice(IP=0xC0A80002, Port=3260, TargetName=planets.earth.dvr109, bAutomount=1)
20:54:10 - Entering func: CStarPortDoc::ResyncRegistryAndDriverContents(bAutomountDevices=0)
20:54:10 - Entering func: CDriveLetterMap::Refresh()
20:54:10 - CDriveLetterMap::Refresh: Device(E:): TargetId: 3
20:54:12 - CDriveLetterMap::Refresh: Device(F:): TargetId: 4
20:54:12 - Exiting  func: CDriveLetterMap::Refresh()
20:54:12 - CStarPortDoc::ResyncRegistryAndDriverContents: Resyncronizing contents...
20:54:12 - Entering func: CStarPortAPI::GetDevices(...)
20:54:12 - CStarPortAPI::GetDevices: Calling STARPORT_IOCTL_TARGET_LIST
20:54:12 - CStarPortAPI::GetDevices: Input buffer:
20:54:12 - CStarPortAPI::GetDevices: Signature = 72417453
20:54:12 - CStarPortAPI::GetDevices: Calling DeviceIoControl(...)
20:54:12 - CStarPortAPI::GetDevices: DeviceIoControl(...) called successfully
20:54:12 - CStarPortAPI::GetDevices: Output buffer:
20:54:12 - CStarPortAPI::GetDevices: Signature = 52615473
20:54:12 - CStarPortAPI::GetDevices: NumberOfTargets = 2
20:54:12 - CStarPortAPI::GetDevices: TargetID[0] = 3
20:54:12 - CStarPortAPI::GetDevices: TargetID[1] = 4
20:54:12 - CStarPortAPI::GetDevices: Calling STARPORT_IOCTL_TARGET_INFO
20:54:12 - CStarPortAPI::GetDevices: Input buffer:
20:54:12 - CStarPortAPI::GetDevices: Signature = 72417453
20:54:12 - CStarPortAPI::GetDevices: TargetId = 3
20:54:12 - CStarPortAPI::GetDevices: Calling DeviceIoControl(...)
20:54:12 - CStarPortAPI::GetDevices: DeviceIoControl(...) called successfully
20:54:12 - CStarPortAPI::GetDevices: Output buffer:
20:54:12 - CStarPortAPI::GetDevices: Signature = 52615473
20:54:12 - CStarPortAPI::GetDevices: TargetId = 0
20:54:12 - CStarPortAPI::GetDevices: ServerAddress = 192.168.0.2:3260
20:54:12 - CStarPortAPI::GetDevices: TargetDescriptionLength = 59
20:54:12 - CStarPortAPI::GetDevices: TargetDescription[0] = InitiatorName=planets:pluto
20:54:12 - CStarPortAPI::GetDevices: TargetDescription[1] = TargetName=planets.earth.sata0
20:54:12 - CStarPortAPI::GetDevices: NumberOfUnits = 1
20:54:12 - CStarPortAPI::GetDevices: LunInfo[0] = 0
20:54:12 - CStarPortAPI::GetDevices: Calling STARPORT_IOCTL_TARGET_INFO
20:54:12 - CStarPortAPI::GetDevices: Input buffer:
20:54:12 - CStarPortAPI::GetDevices: Signature = 72417453
20:54:12 - CStarPortAPI::GetDevices: TargetId = 4
20:54:12 - CStarPortAPI::GetDevices: Calling DeviceIoControl(...)
20:54:12 - CStarPortAPI::GetDevices: DeviceIoControl(...) called successfully
20:54:12 - CStarPortAPI::GetDevices: Output buffer:
20:54:12 - CStarPortAPI::GetDevices: Signature = 52615473
20:54:12 - CStarPortAPI::GetDevices: TargetId = 0
20:54:12 - CStarPortAPI::GetDevices: ServerAddress = 192.168.0.2:3260
20:54:12 - CStarPortAPI::GetDevices: TargetDescriptionLength = 60
20:54:12 - CStarPortAPI::GetDevices: TargetDescription[0] = InitiatorName=planets:pluto
20:54:12 - CStarPortAPI::GetDevices: TargetDescription[1] = TargetName=planets.earth.dvr109
20:54:12 - CStarPortAPI::GetDevices: NumberOfUnits = 1
20:54:12 - CStarPortAPI::GetDevices: LunInfo[0] = 0
20:54:12 - Exiting  func: CStarPortAPI::GetDevices(...)
20:54:12 - CStarPortAPI::CheckConnectionStatus: TargetId = 4
20:54:12 - CStarPortAPI::CheckConnectionStatus: DeviceIoControl(...) called successfully, Target device status = 2
20:54:12 - CStarPortAPI::CheckConnectionStatus: TargetId = 3
20:54:12 - CStarPortAPI::CheckConnectionStatus: DeviceIoControl(...) called successfully, Target device status = 2
20:54:12 - Entering func: CStarPortDoc::SaveConfiguration()
20:54:12 - Exiting  func: CStarPortDoc::SaveConfiguration()
20:54:12 - Exiting  func: CStarPortDoc::ResyncRegistryAndDriverContents(bAutomountDevices=0)
20:54:12 - Entering func: CStarPortDoc::SaveConfiguration()
20:54:12 - Exiting  func: CStarPortDoc::SaveConfiguration()
20:54:12 - CMainFrame::WindowProc: WM_DEVICECHANGE message received: wParam=0x8000, lParam=0x12E9D0.
20:54:12 - CMainFrame::WindowProc: WM_DEVICECHANGE message received: wParam=0x7, lParam=0x0.
20:54:12 - CMainFrame::WindowProc: WM_DEVICECHANGE message received: wParam=0x7, lParam=0x0.
20:54:22 - CMainFrame::OnTimer: Refreshing view, received REFRESH_TIMER_ID...
20:54:22 - Entering func: CStarPortDoc::ResyncRegistryAndDriverContents(bAutomountDevices=0)
20:54:22 - Entering func: CDriveLetterMap::Refresh()
20:54:22 - CDriveLetterMap::Refresh: Device(E:): TargetId: 3
20:54:22 - CDriveLetterMap::Refresh: Device(F:): TargetId: 4
20:54:22 - Exiting  func: CDriveLetterMap::Refresh()
20:54:22 - CStarPortDoc::ResyncRegistryAndDriverContents: Resyncronizing contents...
20:54:22 - Entering func: CStarPortAPI::GetDevices(...)
20:54:22 - CStarPortAPI::GetDevices: Calling STARPORT_IOCTL_TARGET_LIST
20:54:22 - CStarPortAPI::GetDevices: Input buffer:
20:54:22 - CStarPortAPI::GetDevices: Signature = 72417453
20:54:22 - CStarPortAPI::GetDevices: Calling DeviceIoControl(...)
20:54:22 - CStarPortAPI::GetDevices: DeviceIoControl(...) called successfully
20:54:22 - CStarPortAPI::GetDevices: Output buffer:
20:54:22 - CStarPortAPI::GetDevices: Signature = 52615473
20:54:22 - CStarPortAPI::GetDevices: NumberOfTargets = 2
20:54:22 - CStarPortAPI::GetDevices: TargetID[0] = 3
20:54:22 - CStarPortAPI::GetDevices: TargetID[1] = 4
20:54:22 - CStarPortAPI::GetDevices: Calling STARPORT_IOCTL_TARGET_INFO
20:54:22 - CStarPortAPI::GetDevices: Input buffer:
20:54:22 - CStarPortAPI::GetDevices: Signature = 72417453
20:54:22 - CStarPortAPI::GetDevices: TargetId = 3
20:54:22 - CStarPortAPI::GetDevices: Calling DeviceIoControl(...)
20:54:22 - CStarPortAPI::GetDevices: DeviceIoControl(...) called successfully
20:54:22 - CStarPortAPI::GetDevices: Output buffer:
20:54:22 - CStarPortAPI::GetDevices: Signature = 52615473
20:54:22 - CStarPortAPI::GetDevices: TargetId = 0
20:54:22 - CStarPortAPI::GetDevices: ServerAddress = 192.168.0.2:3260
20:54:22 - CStarPortAPI::GetDevices: TargetDescriptionLength = 59
20:54:22 - CStarPortAPI::GetDevices: TargetDescription[0] = InitiatorName=planets:pluto
20:54:22 - CStarPortAPI::GetDevices: TargetDescription[1] = TargetName=planets.earth.sata0
20:54:22 - CStarPortAPI::GetDevices: NumberOfUnits = 1
20:54:22 - CStarPortAPI::GetDevices: LunInfo[0] = 0
20:54:22 - CStarPortAPI::GetDevices: Calling STARPORT_IOCTL_TARGET_INFO
20:54:22 - CStarPortAPI::GetDevices: Input buffer:
20:54:22 - CStarPortAPI::GetDevices: Signature = 72417453
20:54:22 - CStarPortAPI::GetDevices: TargetId = 4
20:54:22 - CStarPortAPI::GetDevices: Calling DeviceIoControl(...)
20:54:22 - CStarPortAPI::GetDevices: DeviceIoControl(...) called successfully
20:54:22 - CStarPortAPI::GetDevices: Output buffer:
20:54:22 - CStarPortAPI::GetDevices: Signature = 52615473
20:54:22 - CStarPortAPI::GetDevices: TargetId = 0
20:54:22 - CStarPortAPI::GetDevices: ServerAddress = 192.168.0.2:3260
20:54:22 - CStarPortAPI::GetDevices: TargetDescriptionLength = 60
20:54:22 - CStarPortAPI::GetDevices: TargetDescription[0] = InitiatorName=planets:pluto
20:54:22 - CStarPortAPI::GetDevices: TargetDescription[1] = TargetName=planets.earth.dvr109
20:54:22 - CStarPortAPI::GetDevices: NumberOfUnits = 1
20:54:22 - CStarPortAPI::GetDevices: LunInfo[0] = 0
20:54:22 - Exiting  func: CStarPortAPI::GetDevices(...)
20:54:22 - CStarPortAPI::CheckConnectionStatus: TargetId = 4
20:54:22 - CStarPortAPI::CheckConnectionStatus: DeviceIoControl(...) called successfully, Target device status = 2
20:54:22 - CStarPortAPI::CheckConnectionStatus: TargetId = 3
20:54:22 - CStarPortAPI::CheckConnectionStatus: DeviceIoControl(...) called successfully, Target device status = 2
20:54:22 - Entering func: CStarPortDoc::SaveConfiguration()
20:54:22 - Exiting  func: CStarPortDoc::SaveConfiguration()
20:54:22 - Exiting  func: CStarPortDoc::ResyncRegistryAndDriverContents(bAutomountDevices=0)
20:54:32 - CMainFrame::OnTimer: Refreshing view, received REFRESH_TIMER_ID...
20:54:32 - Entering func: CStarPortDoc::ResyncRegistryAndDriverContents(bAutomountDevices=0)
20:54:32 - Entering func: CDriveLetterMap::Refresh()
20:54:33 - CDriveLetterMap::Refresh: Device(E:): TargetId: 3
20:54:33 - CDriveLetterMap::Refresh: Device(F:): TargetId: 4
20:54:33 - Exiting  func: CDriveLetterMap::Refresh()
20:54:33 - CStarPortDoc::ResyncRegistryAndDriverContents: Resyncronizing contents...
20:54:33 - Entering func: CStarPortAPI::GetDevices(...)
20:54:33 - CStarPortAPI::GetDevices: Calling STARPORT_IOCTL_TARGET_LIST
20:54:33 - CStarPortAPI::GetDevices: Input buffer:
20:54:33 - CStarPortAPI::GetDevices: Signature = 72417453
20:54:33 - CStarPortAPI::GetDevices: Calling DeviceIoControl(...)
20:54:33 - CStarPortAPI::GetDevices: DeviceIoControl(...) called successfully
20:54:33 - CStarPortAPI::GetDevices: Output buffer:
20:54:33 - CStarPortAPI::GetDevices: Signature = 52615473
20:54:33 - CStarPortAPI::GetDevices: NumberOfTargets = 2
20:54:33 - CStarPortAPI::GetDevices: TargetID[0] = 3
20:54:33 - CStarPortAPI::GetDevices: TargetID[1] = 4
20:54:33 - CStarPortAPI::GetDevices: Calling STARPORT_IOCTL_TARGET_INFO
20:54:33 - CStarPortAPI::GetDevices: Input buffer:
20:54:33 - CStarPortAPI::GetDevices: Signature = 72417453
20:54:33 - CStarPortAPI::GetDevices: TargetId = 3
20:54:33 - CStarPortAPI::GetDevices: Calling DeviceIoControl(...)
20:54:33 - CStarPortAPI::GetDevices: DeviceIoControl(...) called successfully
20:54:33 - CStarPortAPI::GetDevices: Output buffer:
20:54:33 - CStarPortAPI::GetDevices: Signature = 52615473
20:54:33 - CStarPortAPI::GetDevices: TargetId = 0
20:54:33 - CStarPortAPI::GetDevices: ServerAddress = 192.168.0.2:3260
20:54:33 - CStarPortAPI::GetDevices: TargetDescriptionLength = 59
20:54:33 - CStarPortAPI::GetDevices: TargetDescription[0] = InitiatorName=planets:pluto
20:54:33 - CStarPortAPI::GetDevices: TargetDescription[1] = TargetName=planets.earth.sata0
20:54:33 - CStarPortAPI::GetDevices: NumberOfUnits = 1
20:54:33 - CStarPortAPI::GetDevices: LunInfo[0] = 0
20:54:33 - CStarPortAPI::GetDevices: Calling STARPORT_IOCTL_TARGET_INFO
20:54:33 - CStarPortAPI::GetDevices: Input buffer:
20:54:33 - CStarPortAPI::GetDevices: Signature = 72417453
20:54:33 - CStarPortAPI::GetDevices: TargetId = 4
20:54:33 - CStarPortAPI::GetDevices: Calling DeviceIoControl(...)
20:54:33 - CStarPortAPI::GetDevices: DeviceIoControl(...) called successfully
20:54:33 - CStarPortAPI::GetDevices: Output buffer:
20:54:33 - CStarPortAPI::GetDevices: Signature = 52615473
20:54:33 - CStarPortAPI::GetDevices: TargetId = 0
20:54:33 - CStarPortAPI::GetDevices: ServerAddress = 192.168.0.2:3260
20:54:33 - CStarPortAPI::GetDevices: TargetDescriptionLength = 60
20:54:33 - CStarPortAPI::GetDevices: TargetDescription[0] = InitiatorName=planets:pluto
20:54:33 - CStarPortAPI::GetDevices: TargetDescription[1] = TargetName=planets.earth.dvr109
20:54:33 - CStarPortAPI::GetDevices: NumberOfUnits = 1
20:54:33 - CStarPortAPI::GetDevices: LunInfo[0] = 0
20:54:33 - Exiting  func: CStarPortAPI::GetDevices(...)
20:54:33 - CStarPortAPI::CheckConnectionStatus: TargetId = 4
20:54:33 - CStarPortAPI::CheckConnectionStatus: DeviceIoControl(...) called successfully, Target device status = 2
20:54:33 - CStarPortAPI::CheckConnectionStatus: TargetId = 3
20:54:33 - CStarPortAPI::CheckConnectionStatus: DeviceIoControl(...) called successfully, Target device status = 2
20:54:33 - Entering func: CStarPortDoc::SaveConfiguration()
20:54:33 - Exiting  func: CStarPortDoc::SaveConfiguration()
20:54:33 - Exiting  func: CStarPortDoc::ResyncRegistryAndDriverContents(bAutomountDevices=0)
20:54:43 - CMainFrame::OnTimer: Refreshing view, received REFRESH_TIMER_ID...
20:54:43 - Entering func: CStarPortDoc::ResyncRegistryAndDriverContents(bAutomountDevices=0)
20:54:43 - Entering func: CDriveLetterMap::Refresh()
20:54:43 - CDriveLetterMap::Refresh: Device(E:): TargetId: 3
20:54:43 - CDriveLetterMap::Refresh: Device(F:): TargetId: 4
20:54:43 - Exiting  func: CDriveLetterMap::Refresh()
20:54:43 - CStarPortDoc::ResyncRegistryAndDriverContents: Resyncronizing contents...
20:54:43 - Entering func: CStarPortAPI::GetDevices(...)
20:54:43 - CStarPortAPI::GetDevices: Calling STARPORT_IOCTL_TARGET_LIST
20:54:43 - CStarPortAPI::GetDevices: Input buffer:
20:54:43 - CStarPortAPI::GetDevices: Signature = 72417453
20:54:43 - CStarPortAPI::GetDevices: Calling DeviceIoControl(...)
20:54:43 - CStarPortAPI::GetDevices: DeviceIoControl(...) called successfully
20:54:43 - CStarPortAPI::GetDevices: Output buffer:
20:54:43 - CStarPortAPI::GetDevices: Signature = 52615473
20:54:43 - CStarPortAPI::GetDevices: NumberOfTargets = 2
20:54:43 - CStarPortAPI::GetDevices: TargetID[0] = 3
20:54:43 - CStarPortAPI::GetDevices: TargetID[1] = 4
20:54:43 - CStarPortAPI::GetDevices: Calling STARPORT_IOCTL_TARGET_INFO
20:54:43 - CStarPortAPI::GetDevices: Input buffer:
20:54:43 - CStarPortAPI::GetDevices: Signature = 72417453
20:54:43 - CStarPortAPI::GetDevices: TargetId = 3
20:54:43 - CStarPortAPI::GetDevices: Calling DeviceIoControl(...)
20:54:43 - CStarPortAPI::GetDevices: DeviceIoControl(...) called successfully
20:54:43 - CStarPortAPI::GetDevices: Output buffer:
20:54:43 - CStarPortAPI::GetDevices: Signature = 52615473
20:54:43 - CStarPortAPI::GetDevices: TargetId = 0
20:54:43 - CStarPortAPI::GetDevices: ServerAddress = 192.168.0.2:3260
20:54:43 - CStarPortAPI::GetDevices: TargetDescriptionLength = 59
20:54:43 - CStarPortAPI::GetDevices: TargetDescription[0] = InitiatorName=planets:pluto
20:54:43 - CStarPortAPI::GetDevices: TargetDescription[1] = TargetName=planets.earth.sata0
20:54:43 - CStarPortAPI::GetDevices: NumberOfUnits = 1
20:54:43 - CStarPortAPI::GetDevices: LunInfo[0] = 0
20:54:43 - CStarPortAPI::GetDevices: Calling STARPORT_IOCTL_TARGET_INFO
20:54:43 - CStarPortAPI::GetDevices: Input buffer:
20:54:43 - CStarPortAPI::GetDevices: Signature = 72417453
20:54:43 - CStarPortAPI::GetDevices: TargetId = 4
20:54:43 - CStarPortAPI::GetDevices: Calling DeviceIoControl(...)
20:54:43 - CStarPortAPI::GetDevices: DeviceIoControl(...) called successfully
20:54:43 - CStarPortAPI::GetDevices: Output buffer:
20:54:43 - CStarPortAPI::GetDevices: Signature = 52615473
20:54:43 - CStarPortAPI::GetDevices: TargetId = 0
20:54:43 - CStarPortAPI::GetDevices: ServerAddress = 192.168.0.2:3260
20:54:43 - CStarPortAPI::GetDevices: TargetDescriptionLength = 60
20:54:43 - CStarPortAPI::GetDevices: TargetDescription[0] = InitiatorName=planets:pluto
20:54:43 - CStarPortAPI::GetDevices: TargetDescription[1] = TargetName=planets.earth.dvr109
20:54:43 - CStarPortAPI::GetDevices: NumberOfUnits = 1
20:54:43 - CStarPortAPI::GetDevices: LunInfo[0] = 0
20:54:43 - Exiting  func: CStarPortAPI::GetDevices(...)
20:54:43 - CStarPortAPI::CheckConnectionStatus: TargetId = 4
20:54:43 - CStarPortAPI::CheckConnectionStatus: DeviceIoControl(...) called successfully, Target device status = 2
20:54:43 - CStarPortAPI::CheckConnectionStatus: TargetId = 3
20:54:43 - CStarPortAPI::CheckConnectionStatus: DeviceIoControl(...) called successfully, Target device status = 2
20:54:43 - Entering func: CStarPortDoc::SaveConfiguration()
20:54:43 - Exiting  func: CStarPortDoc::SaveConfiguration()
20:54:43 - Exiting  func: CStarPortDoc::ResyncRegistryAndDriverContents(bAutomountDevices=0)
20:54:52 - Entering func: CStarPortView::OnRButtonDown(...)
20:54:52 - CStarPortView::OnRButtonDown: Calling OnContextMenu.
20:54:52 - Entering func: CStarPortView::OnContextMenu(...)
20:54:53 - CMainFrame::OnTimer: Refreshing view, received REFRESH_TIMER_ID...
20:54:53 - Entering func: CStarPortDoc::ResyncRegistryAndDriverContents(bAutomountDevices=0)
20:54:53 - Entering func: CDriveLetterMap::Refresh()
20:54:53 - CDriveLetterMap::Refresh: Device(E:): TargetId: 3
20:54:53 - CDriveLetterMap::Refresh: Device(F:): TargetId: 4
20:54:53 - Exiting  func: CDriveLetterMap::Refresh()
20:54:53 - CStarPortDoc::ResyncRegistryAndDriverContents: Resyncronizing contents...
20:54:53 - Entering func: CStarPortAPI::GetDevices(...)
20:54:53 - CStarPortAPI::GetDevices: Calling STARPORT_IOCTL_TARGET_LIST
20:54:53 - CStarPortAPI::GetDevices: Input buffer:
20:54:53 - CStarPortAPI::GetDevices: Signature = 72417453
20:54:53 - CStarPortAPI::GetDevices: Calling DeviceIoControl(...)
20:54:53 - CStarPortAPI::GetDevices: DeviceIoControl(...) called successfully
20:54:53 - CStarPortAPI::GetDevices: Output buffer:
20:54:53 - CStarPortAPI::GetDevices: Signature = 52615473
20:54:53 - CStarPortAPI::GetDevices: NumberOfTargets = 2
20:54:53 - CStarPortAPI::GetDevices: TargetID[0] = 3
20:54:53 - CStarPortAPI::GetDevices: TargetID[1] = 4
20:54:53 - CStarPortAPI::GetDevices: Calling STARPORT_IOCTL_TARGET_INFO
20:54:53 - CStarPortAPI::GetDevices: Input buffer:
20:54:53 - CStarPortAPI::GetDevices: Signature = 72417453
20:54:53 - CStarPortAPI::GetDevices: TargetId = 3
20:54:53 - CStarPortAPI::GetDevices: Calling DeviceIoControl(...)
20:54:53 - CStarPortAPI::GetDevices: DeviceIoControl(...) called successfully
20:54:53 - CStarPortAPI::GetDevices: Output buffer:
20:54:53 - CStarPortAPI::GetDevices: Signature = 52615473
20:54:53 - CStarPortAPI::GetDevices: TargetId = 0
20:54:53 - CStarPortAPI::GetDevices: ServerAddress = 192.168.0.2:3260
20:54:53 - CStarPortAPI::GetDevices: TargetDescriptionLength = 59
20:54:53 - CStarPortAPI::GetDevices: TargetDescription[0] = InitiatorName=planets:pluto
20:54:53 - CStarPortAPI::GetDevices: TargetDescription[1] = TargetName=planets.earth.sata0
20:54:53 - CStarPortAPI::GetDevices: NumberOfUnits = 1
20:54:53 - CStarPortAPI::GetDevices: LunInfo[0] = 0
20:54:53 - CStarPortAPI::GetDevices: Calling STARPORT_IOCTL_TARGET_INFO
20:54:53 - CStarPortAPI::GetDevices: Input buffer:
20:54:53 - CStarPortAPI::GetDevices: Signature = 72417453
20:54:53 - CStarPortAPI::GetDevices: TargetId = 4
20:54:53 - CStarPortAPI::GetDevices: Calling DeviceIoControl(...)
20:54:53 - CStarPortAPI::GetDevices: DeviceIoControl(...) called successfully
20:54:53 - CStarPortAPI::GetDevices: Output buffer:
20:54:53 - CStarPortAPI::GetDevices: Signature = 52615473
20:54:53 - CStarPortAPI::GetDevices: TargetId = 0
20:54:53 - CStarPortAPI::GetDevices: ServerAddress = 192.168.0.2:3260
20:54:53 - CStarPortAPI::GetDevices: TargetDescriptionLength = 60
20:54:53 - CStarPortAPI::GetDevices: TargetDescription[0] = InitiatorName=planets:pluto
20:54:53 - CStarPortAPI::GetDevices: TargetDescription[1] = TargetName=planets.earth.dvr109
20:54:53 - CStarPortAPI::GetDevices: NumberOfUnits = 1
20:54:53 - CStarPortAPI::GetDevices: LunInfo[0] = 0
20:54:53 - Exiting  func: CStarPortAPI::GetDevices(...)
20:54:53 - CStarPortAPI::CheckConnectionStatus: TargetId = 4
20:54:53 - CStarPortAPI::CheckConnectionStatus: DeviceIoControl(...) called successfully, Target device status = 2
20:54:53 - CStarPortAPI::CheckConnectionStatus: TargetId = 3
20:54:53 - CStarPortAPI::CheckConnectionStatus: DeviceIoControl(...) called successfully, Target device status = 2
20:54:53 - Entering func: CStarPortDoc::SaveConfiguration()
20:54:53 - Exiting  func: CStarPortDoc::SaveConfiguration()
20:54:53 - Exiting  func: CStarPortDoc::ResyncRegistryAndDriverContents(bAutomountDevices=0)
20:54:54 - Exiting  func: CStarPortView::OnContextMenu(...)
20:54:54 - Exiting  func: CStarPortView::OnRButtonDown(...)
20:54:55 - CStarPortDoc::DeleteiSCSIDevice: Found a specified for deletion device.
20:54:55 - Entering func: CTreeDevice::Unmount()
20:54:55 - Entering func: CStarPortAPI::EjectDevice(nTargetID=3)
20:54:55 - CStarPortAPI::FlushDismount: Calling DeviceIoControl(...)
20:54:55 - CStarPortAPI::FlushDismount: Calling DeviceIoControl(...)
20:54:55 - CStarPortAPI::FlushDismount: Calling DeviceIoControl(...)
20:54:55 - CStarPortAPI::FlushDismount: Calling DeviceIoControl(...)
20:54:55 - CStarPortAPI::FlushDismount: STARPORT_IOCTL_QUERY failed, status == 0x1!
20:54:55 - CStarPortAPI::FlushDismount: Calling DeviceIoControl(...)
20:54:55 - CStarPortAPI::FlushDismount: STARPORT_IOCTL_QUERY failed, status == 0x1!
20:54:55 - CStarPortAPI::FlushDismount: Calling DeviceIoControl(...)
20:54:55 - CStarPortAPI::FlushDismount: STARPORT_IOCTL_QUERY failed, status == 0x1!
20:54:55 - CStarPortAPI::FlushDismount: Calling DeviceIoControl(...)
20:54:55 - CStarPortAPI::FlushDismount: STARPORT_IOCTL_QUERY failed, status == 0x1!
20:54:55 - CStarPortAPI::FlushDismount: Calling DeviceIoControl(...)
20:54:55 - CStarPortAPI::FlushDismount: STARPORT_IOCTL_QUERY failed, status == 0x1!
20:54:55 - CStarPortAPI::EjectDevice: Calling STARPORT_IOCTL_TARGET_UNMOUNT
20:54:55 - CStarPortAPI::EjectDevice: Input buffer:
20:54:55 - CStarPortAPI::EjectDevice: Signature = 72417453
20:54:55 - CStarPortAPI::EjectDevice: TargetId = 3
20:54:55 - CStarPortAPI::EjectDevice: bEmergency = 0
20:54:55 - CStarPortAPI::EjectDevice: Calling DeviceIoControl(...)
20:54:55 - CStarPortAPI::EjectDevice: DeviceIoControl(...) called successfully
20:54:55 - CStarPortAPI::EjectDevice: Output buffer:
20:54:55 - CStarPortAPI::EjectDevice: Signature = 52615473
20:54:55 - CStarPortAPI::EjectDevice: Status = 3
20:54:55 - Exiting  func: CStarPortAPI::EjectDevice(nTargetID=3)
20:54:55 - CMainFrame::WindowProc: WM_DEVICECHANGE message received: wParam=0x7, lParam=0x0.
20:54:55 - CMainFrame::WindowProc: WM_DEVICECHANGE message received: wParam=0x7, lParam=0x0.
20:54:55 - CMainFrame::WindowProc: WM_DEVICECHANGE message received: wParam=0x8004, lParam=0x12F100.
20:54:55 - CMainFrame::WindowProc: WM_DEVICECHANGE message received: wParam=0x7, lParam=0x0.
20:54:55 - CMainFrame::WindowProc: WM_DEVICECHANGE message received: wParam=0x7, lParam=0x0.
20:54:55 - CMainFrame::WindowProc: WM_DEVICECHANGE message received: wParam=0x7, lParam=0x0.
20:54:55 - CMainFrame::WindowProc: WM_DEVICECHANGE message received: wParam=0x7, lParam=0x0.
20:54:56 - WaitDlgThreadProc: Sending WM_CLOSE message.
20:54:56 - Entering func: CWaitDlg::OnCancel()
20:54:56 - Exiting  func: CWaitDlg::OnCancel()
20:54:56 - Entering func: CDriveLetterMap::Refresh()
20:54:56 - CDriveLetterMap::Refresh: Device(F:): TargetId: 4
20:54:56 - Exiting  func: CDriveLetterMap::Refresh()
20:54:56 - Entering func: CDriveLetterMap::GetDriveLetter(ulTargetId=3 cLetter=...)
20:54:56 - Exiting  func: CDriveLetterMap::GetDriveLetter(ulTargetId=3 cLetter=...)
20:54:56 - Exiting  func: CTreeDevice::Unmount()
20:54:56 - Entering func: CStarPortDoc::SaveConfiguration()
20:54:56 - Exiting  func: CStarPortDoc::SaveConfiguration()
20:54:57 - Entering func: CStarPortView::OnRButtonDown(...)
20:54:57 - CStarPortView::OnRButtonDown: Calling OnContextMenu.
20:54:57 - Entering func: CStarPortView::OnContextMenu(...)
20:54:58 - Exiting  func: CStarPortView::OnContextMenu(...)
20:54:58 - Exiting  func: CStarPortView::OnRButtonDown(...)
20:54:58 - CStarPortDoc::DeleteiSCSIDevice: Found a specified for deletion device.
20:54:58 - Entering func: CTreeDevice::Unmount()
20:54:58 - Entering func: CStarPortAPI::EjectDevice(nTargetID=4)
20:54:58 - CStarPortAPI::FlushDismount: Calling DeviceIoControl(...)
20:54:58 - CStarPortAPI::FlushDismount: Calling DeviceIoControl(...)
20:54:59 - CStarPortAPI::FlushDismount: Calling DeviceIoControl(...)
20:54:59 - CStarPortAPI::FlushDismount: STARPORT_IOCTL_QUERY failed, status == 0x1!
20:54:59 - CStarPortAPI::FlushDismount: Calling DeviceIoControl(...)
20:54:59 - CStarPortAPI::FlushDismount: STARPORT_IOCTL_QUERY failed, status == 0x1!
20:54:59 - CStarPortAPI::FlushDismount: Calling DeviceIoControl(...)
20:54:59 - CStarPortAPI::FlushDismount: STARPORT_IOCTL_QUERY failed, status == 0x1!
20:54:59 - CStarPortAPI::FlushDismount: Calling DeviceIoControl(...)
20:54:59 - CStarPortAPI::FlushDismount: STARPORT_IOCTL_QUERY failed, status == 0x1!
20:54:59 - CStarPortAPI::FlushDismount: Calling DeviceIoControl(...)
20:54:59 - CStarPortAPI::FlushDismount: STARPORT_IOCTL_QUERY failed, status == 0x1!
20:54:59 - CStarPortAPI::EjectDevice: Calling STARPORT_IOCTL_TARGET_UNMOUNT
20:54:59 - CStarPortAPI::EjectDevice: Input buffer:
20:54:59 - CStarPortAPI::EjectDevice: Signature = 72417453
20:54:59 - CStarPortAPI::EjectDevice: TargetId = 4
20:54:59 - CStarPortAPI::EjectDevice: bEmergency = 0
20:54:59 - CStarPortAPI::EjectDevice: Calling DeviceIoControl(...)
20:54:59 - CStarPortAPI::EjectDevice: DeviceIoControl(...) called successfully
20:54:59 - CStarPortAPI::EjectDevice: Output buffer:
20:54:59 - CStarPortAPI::EjectDevice: Signature = 52615473
20:54:59 - CStarPortAPI::EjectDevice: Status = 4
20:54:59 - CMainFrame::WindowProc: WM_DEVICECHANGE message received: wParam=0x7, lParam=0x0.
20:54:59 - CMainFrame::WindowProc: WM_DEVICECHANGE message received: wParam=0x8004, lParam=0x12F100.
20:54:59 - Exiting  func: CStarPortAPI::EjectDevice(nTargetID=4)
20:54:59 - CMainFrame::WindowProc: WM_DEVICECHANGE message received: wParam=0x7, lParam=0x0.
20:54:59 - CMainFrame::WindowProc: WM_DEVICECHANGE message received: wParam=0x7, lParam=0x0.
20:55:00 - WaitDlgThreadProc: Sending WM_CLOSE message.
20:55:00 - Entering func: CWaitDlg::OnCancel()
20:55:00 - Exiting  func: CWaitDlg::OnCancel()
20:55:00 - Entering func: CDriveLetterMap::Refresh()
20:55:00 - Exiting  func: CDriveLetterMap::Refresh()
20:55:00 - Entering func: CDriveLetterMap::GetDriveLetter(ulTargetId=4 cLetter=...)
20:55:00 - Exiting  func: CDriveLetterMap::GetDriveLetter(ulTargetId=4 cLetter=...)
20:55:00 - Exiting  func: CTreeDevice::Unmount()
20:55:00 - Entering func: CStarPortDoc::SaveConfiguration()
20:55:00 - Exiting  func: CStarPortDoc::SaveConfiguration()
20:55:03 - CMainFrame::OnTimer: Refreshing view, received REFRESH_TIMER_ID...
20:55:03 - Entering func: CStarPortDoc::ResyncRegistryAndDriverContents(bAutomountDevices=0)
20:55:03 - Entering func: CDriveLetterMap::Refresh()
20:55:03 - Exiting  func: CDriveLetterMap::Refresh()
20:55:03 - CStarPortDoc::ResyncRegistryAndDriverContents: Resyncronizing contents...
20:55:03 - Entering func: CStarPortAPI::GetDevices(...)
20:55:03 - CStarPortAPI::GetDevices: Calling STARPORT_IOCTL_TARGET_LIST
20:55:03 - CStarPortAPI::GetDevices: Input buffer:
20:55:03 - CStarPortAPI::GetDevices: Signature = 72417453
20:55:03 - CStarPortAPI::GetDevices: Calling DeviceIoControl(...)
20:55:03 - CStarPortAPI::GetDevices: DeviceIoControl(...) called successfully
20:55:03 - CStarPortAPI::GetDevices: Output buffer:
20:55:03 - CStarPortAPI::GetDevices: Signature = 52615473
20:55:03 - CStarPortAPI::GetDevices: NumberOfTargets = 0
20:55:03 - Exiting  func: CStarPortAPI::GetDevices(...)
20:55:03 - Exiting  func: CStarPortDoc::ResyncRegistryAndDriverContents(bAutomountDevices=0)
20:55:07 - Found language dll: language id: 0x0409 (English (United States)).

Posted: **Thu Jul 21, 2005 9:35 pm**

StarPort 2.6.0 Log, connecting to StarWind 2.6.1, machine hang:

Code: Select all

20:59:38 - Entering func: CLanguager::LoadLanguage(language=0x409)
20:59:38 - Exiting  func: CLanguager::LoadLanguage(language=0x409)
20:59:38 - CStarPortApp::CheckLicense: Licensed to: 'FREE', 'NOT COMERCIAL', (#1, 0).
20:59:38 - Entering func: CStarPortAPI::CStarPortAPI()
20:59:38 - Entering func: CStarPortAPI::DriverOpen()
20:59:38 - Exiting  func: CStarPortAPI::DriverOpen()
20:59:38 - Entering func: CStarPortAPI::DriverVersion(...)
20:59:38 - CStarPortAPI::DriverVersion: Calling STARPORT_IOCTL_GET_VERSION
20:59:38 - CStarPortAPI::DriverVersion: Input buffer:
20:59:38 - CStarPortAPI::DriverVersion: Signature = 72417453:
20:59:38 - CStarPortAPI::DriverVersion: ApiVersion = 20002:
20:59:38 - CStarPortAPI::DriverVersion: Calling DeviceIoControl(...)
20:59:38 - CStarPortAPI::DriverVersion: DeviceIoControl(...) called successfully
20:59:38 - CStarPortAPI::DriverVersion: Output buffer:
20:59:38 - CStarPortAPI::DriverVersion: Signature = 52615473
20:59:38 - CStarPortAPI::DriverVersion: Version = 20050310
20:59:38 - CStarPortAPI::DriverVersion: ApiVersion = 20002
20:59:38 - CStarPortAPI::DriverVersion: Flags = 0
20:59:38 - Exiting  func: CStarPortAPI::DriverVersion(...)
20:59:38 - CStarPortAPI::CStarPortAPI: StarPort version: 20050310; StarPort driver: API v20002, Build 0x20050310
20:59:38 - Exiting  func: CStarPortAPI::CStarPortAPI()
20:59:38 - Entering func: CDriveLetterMap::CDriveLetterMap()
20:59:38 - Entering func: CDriveLetterMap::Refresh()
20:59:38 - Exiting  func: CDriveLetterMap::Refresh()
20:59:38 - Exiting  func: CDriveLetterMap::CDriveLetterMap()
20:59:38 - Entering func: CStarPortDoc::CStarPortDoc()
20:59:38 - Exiting  func: CStarPortDoc::CStarPortDoc()
20:59:38 - CMainFrame::OnCreate: Minimizing application to tray.
20:59:38 - Entering func: CStarPortView::OnInitialUpdate()
20:59:38 - Entering func: CStarPortDoc::ResyncRegistryAndDriverContents(bAutomountDevices=1)
20:59:38 - Entering func: CDriveLetterMap::Refresh()
20:59:38 - Exiting  func: CDriveLetterMap::Refresh()
20:59:38 - CStarPortDoc::ResyncRegistryAndDriverContents: Resyncronizing contents...
20:59:38 - Entering func: CStarPortAPI::GetDevices(...)
20:59:38 - CStarPortAPI::GetDevices: Calling STARPORT_IOCTL_TARGET_LIST
20:59:38 - CStarPortAPI::GetDevices: Input buffer:
20:59:38 - CStarPortAPI::GetDevices: Signature = 72417453
20:59:38 - CStarPortAPI::GetDevices: Calling DeviceIoControl(...)
20:59:38 - CStarPortAPI::GetDevices: DeviceIoControl(...) called successfully
20:59:38 - CStarPortAPI::GetDevices: Output buffer:
20:59:38 - CStarPortAPI::GetDevices: Signature = 52615473
20:59:38 - CStarPortAPI::GetDevices: NumberOfTargets = 0
20:59:38 - Exiting  func: CStarPortAPI::GetDevices(...)
20:59:38 - Exiting  func: CStarPortDoc::ResyncRegistryAndDriverContents(bAutomountDevices=1)
20:59:38 - Exiting  func: CStarPortView::OnInitialUpdate()
20:59:40 - CMainFrame::OnTrayStartManagement: Maximizing from tray.
20:59:42 - Entering func: CStarPortView::OnRButtonDown(...)
20:59:42 - CStarPortView::OnRButtonDown: Calling OnContextMenu.
20:59:42 - Entering func: CStarPortView::OnContextMenu(...)
20:59:42 - Exiting  func: CStarPortView::OnContextMenu(...)
20:59:42 - Exiting  func: CStarPortView::OnRButtonDown(...)
20:59:48 - Entering func: CStarPortAPI::GetTargets(dwIPAddress=0xC0A80002, DWORD dwPort=3260, listTargets=...)
20:59:48 - CStarPortAPI::GetTargets: Calling STARPORT_IOCTL_GET_TARGETS
20:59:48 - CStarPortAPI::GetTargets: Input buffer:
20:59:48 - CStarPortAPI::GetTargets: Signature = 72417453
20:59:48 - CStarPortAPI::GetTargets: ServerAddress = 192.168.0.2:3260
20:59:48 - CStarPortAPI::GetTargets: Parameter[0] = InitiatorName=planets:pluto
20:59:48 - CStarPortAPI::GetTargets: Calling DeviceIoControl(...)
20:59:48 - CStarPortAPI::GetTargets: DeviceIoControl(...) called successfully
20:59:48 - CStarPortAPI::GetTargets: Output buffer:
20:59:48 - CStarPortAPI::GetTargets: Signature = 52615473
20:59:48 - CStarPortAPI::GetTargets: TargetsInfo[0] = TargetName=planets.earth.sata0
20:59:48 - CStarPortAPI::GetTargets: TargetsInfo[1] = TargetName=planets.earth.dvr109
20:59:48 - Entering func: CStarPortAPI::AddTargetToList(target=..., listTargets=...)
20:59:48 - CStarPortAPI::AddTargetToList: Target addresses list is empty, adding default IP/Port pair.
20:59:48 - Exiting  func: CStarPortAPI::AddTargetToList(target=..., listTargets=...)
20:59:48 - Entering func: CStarPortAPI::AddTargetToList(target=..., listTargets=...)
20:59:48 - CStarPortAPI::AddTargetToList: Target addresses list is empty, adding default IP/Port pair.
20:59:48 - Exiting  func: CStarPortAPI::AddTargetToList(target=..., listTargets=...)
20:59:48 - CStarPortAPI::GetTargets: Server at IP:0xC0A80002, Port:3260 returned the following targets:
20:59:48 - CStarPortAPI::GetTargets: 	TargetName:planets.earth.dvr109
20:59:48 - CStarPortAPI::GetTargets: 		TargetAddress: IP:0xC0A80002, Port:3260
20:59:48 - CStarPortAPI::GetTargets: 	TargetName:planets.earth.sata0
20:59:48 - CStarPortAPI::GetTargets: 		TargetAddress: IP:0xC0A80002, Port:3260
20:59:48 - Exiting  func: CStarPortAPI::GetTargets(dwIPAddress=0xC0A80002, DWORD dwPort=3260, listTargets=...)
20:59:51 - CWPPiSCSITargetSelection::CreateDevice: Trying to add an iSCSI device using TargetName=planets.earth.sata0, IP:0xC0A80002, Port:3260
20:59:51 - Entering func: CStarPortDoc::CreateiSCSIDevice(IP=0xC0A80002, Port=3260, TargetName=planets.earth.sata0, bAutomount=0)
20:59:51 - Entering func: CStarPortAPI::InsertiSCSIDevice(dwIPAddress=0xC0A80002, dwPort=3260, szInitiaotrName=planets:pluto, szTargetName=planets.earth.sata0, szAdditionalParameter=, nTargetID=...)
20:59:51 - CStarPortAPI::InsertiSCSIDevice: Calling STARPORT_IOCTL_TARGET_MOUNT
20:59:51 - CStarPortAPI::InsertiSCSIDevice: Input buffer:
20:59:51 - CStarPortAPI::InsertiSCSIDevice: Signature = 72417453
20:59:51 - CStarPortAPI::InsertiSCSIDevice: Flags = 0
20:59:51 - CStarPortAPI::InsertiSCSIDevice: ServerAddress = 192.168.0.2:3260
20:59:51 - CStarPortAPI::InsertiSCSIDevice: Parameter[0] = InitiatorName=planets:pluto
20:59:51 - CStarPortAPI::InsertiSCSIDevice: Parameter[1] = TargetName=planets.earth.sata0
20:59:51 - CStarPortAPI::InsertiSCSIDevice: Calling DeviceIoControl(...)
20:59:54 - CStarPortAPI::InsertiSCSIDevice: Session failed, status == 1326 !
20:59:54 - Exiting  func: CStarPortAPI::InsertiSCSIDevice(dwIPAddress=0xC0A80002, dwPort=3260, szInitiaotrName=planets:pluto, szTargetName=planets.earth.sata0, szAdditionalParameter=, nTargetID=...)
20:59:54 - Exiting  func: CStarPortDoc::CreateiSCSIDevice(IP=0xC0A80002, Port=3260, TargetName=planets.earth.sata0, bAutomount=0)
20:59:54 - CWPPiSCSITargetSelection::CreateDevice: Exception caught: Logon to the server failed.
20:59:54 - CWPPiSCSITargetSelection::CreateDevice: Failed to connect to create iSCSI device using TargetName=planets.earth.sata0, IP:0xC0A80002, Port:3260
20:59:54 - CWPPiSCSITargetSelection::CreateDevice: Creation of the iSCSI device failed with all the addresses supplied by the server.
20:59:54 - CWPPiSCSITargetSelection::CreateDevice: Exception caught: Creation of the iSCSI device failed with all the addresses
supplied by the server.
20:59:58 - CMainFrame::OnTimer: Refreshing view, received REFRESH_TIMER_ID...
20:59:58 - Entering func: CStarPortDoc::ResyncRegistryAndDriverContents(bAutomountDevices=0)
20:59:58 - Entering func: CDriveLetterMap::Refresh()
20:59:58 - Exiting  func: CDriveLetterMap::Refresh()
20:59:58 - CStarPortDoc::ResyncRegistryAndDriverContents: Resyncronizing contents...
20:59:58 - Entering func: CStarPortAPI::GetDevices(...)
20:59:58 - CStarPortAPI::GetDevices: Calling STARPORT_IOCTL_TARGET_LIST
20:59:58 - CStarPortAPI::GetDevices: Input buffer:
20:59:58 - CStarPortAPI::GetDevices: Signature = 72417453
20:59:58 - CStarPortAPI::GetDevices: Calling DeviceIoControl(...)
20:59:58 - CStarPortAPI::GetDevices: DeviceIoControl(...) called successfully
20:59:58 - CStarPortAPI::GetDevices: Output buffer:
20:59:58 - CStarPortAPI::GetDevices: Signature = 52615473
20:59:58 - CStarPortAPI::GetDevices: NumberOfTargets = 0
20:59:58 - Exiting  func: CStarPortAPI::GetDevices(...)
20:59:58 - Exiting  func: CStarPortDoc::ResyncRegistryAndDriverContents(bAutomountDevices=0)
21:00:00 - CMainFrame::WindowProc: WM_DEVICECHANGE message received: wParam=0x7, lParam=0x0.
21:00:00 - CMainFrame::WindowProc: WM_DEVICECHANGE message received: wParam=0x7, lParam=0x0.
21:00:00 - CMainFrame::WindowProc: WM_DEVICECHANGE message received: wParam=0x7, lParam=0x0.
21:00:02 - Found language dll: language id: 0x0409 (English (United States)).
21:01:08 - Entering func: CStarPortAPI::GetTargets(dwIPAddress=0xC0A80002, DWORD dwPort=3260, listTargets=...)
21:01:08 - CStarPortAPI::GetTargets: Calling STARPORT_IOCTL_GET_TARGETS
21:01:08 - CStarPortAPI::GetTargets: Input buffer:
21:01:08 - CStarPortAPI::GetTargets: Signature = 72417453
21:01:08 - CStarPortAPI::GetTargets: ServerAddress = 192.168.0.2:3260
21:01:08 - CStarPortAPI::GetTargets: Parameter[0] = InitiatorName=planets:pluto
21:01:08 - CStarPortAPI::GetTargets: Calling DeviceIoControl(...)
21:01:08 - CStarPortAPI::GetTargets: DeviceIoControl(...) called successfully
21:01:08 - CStarPortAPI::GetTargets: Output buffer:
21:01:08 - CStarPortAPI::GetTargets: Signature = 52615473
21:01:08 - CStarPortAPI::GetTargets: TargetsInfo[0] = TargetName=planets.earth.sata0
21:01:08 - CStarPortAPI::GetTargets: TargetsInfo[1] = TargetName=planets.earth.dvr109
21:01:08 - Entering func: CStarPortAPI::AddTargetToList(target=..., listTargets=...)
21:01:08 - CStarPortAPI::AddTargetToList: Target addresses list is empty, adding default IP/Port pair.
21:01:08 - Exiting  func: CStarPortAPI::AddTargetToList(target=..., listTargets=...)
21:01:08 - Entering func: CStarPortAPI::AddTargetToList(target=..., listTargets=...)
21:01:08 - CStarPortAPI::AddTargetToList: Target addresses list is empty, adding default IP/Port pair.
21:01:08 - Exiting  func: CStarPortAPI::AddTargetToList(target=..., listTargets=...)
21:01:08 - CStarPortAPI::GetTargets: Server at IP:0xC0A80002, Port:3260 returned the following targets:
21:01:08 - CStarPortAPI::GetTargets: 	TargetName:planets.earth.dvr109
21:01:08 - CStarPortAPI::GetTargets: 		TargetAddress: IP:0xC0A80002, Port:3260
21:01:08 - CStarPortAPI::GetTargets: 	TargetName:planets.earth.sata0
21:01:08 - CStarPortAPI::GetTargets: 		TargetAddress: IP:0xC0A80002, Port:3260
21:01:08 - Exiting  func: CStarPortAPI::GetTargets(dwIPAddress=0xC0A80002, DWORD dwPort=3260, listTargets=...)
21:01:10 - CWPPiSCSITargetSelection::CreateDevice: Trying to add an iSCSI device using TargetName=planets.earth.dvr109, IP:0xC0A80002, Port:3260
21:01:10 - Entering func: CStarPortDoc::CreateiSCSIDevice(IP=0xC0A80002, Port=3260, TargetName=planets.earth.dvr109, bAutomount=0)
21:01:10 - Entering func: CStarPortAPI::InsertiSCSIDevice(dwIPAddress=0xC0A80002, dwPort=3260, szInitiaotrName=planets:pluto, szTargetName=planets.earth.dvr109, szAdditionalParameter=, nTargetID=...)
21:01:10 - CStarPortAPI::InsertiSCSIDevice: Calling STARPORT_IOCTL_TARGET_MOUNT
21:01:10 - CStarPortAPI::InsertiSCSIDevice: Input buffer:
21:01:10 - CStarPortAPI::InsertiSCSIDevice: Signature = 72417453
21:01:10 - CStarPortAPI::InsertiSCSIDevice: Flags = 0
21:01:10 - CStarPortAPI::InsertiSCSIDevice: ServerAddress = 192.168.0.2:3260
21:01:10 - CStarPortAPI::InsertiSCSIDevice: Parameter[0] = InitiatorName=planets:pluto
21:01:10 - CStarPortAPI::InsertiSCSIDevice: Parameter[1] = TargetName=planets.earth.dvr109
21:01:10 - CStarPortAPI::InsertiSCSIDevice: Calling DeviceIoControl(...)
21:01:11 - CStarPortAPI::InsertiSCSIDevice: DeviceIoControl(...) called successfully
21:01:11 - CStarPortAPI::InsertiSCSIDevice: Output buffer:
21:01:11 - CStarPortAPI::InsertiSCSIDevice: Signature = 52615473
21:01:11 - CStarPortAPI::InsertiSCSIDevice: TargetId = 5
21:01:11 - CStarPortAPI::InsertiSCSIDevice: NumberOfUnits = 1
21:01:11 - Exiting  func: CStarPortAPI::InsertiSCSIDevice(dwIPAddress=0xC0A80002, dwPort=3260, szInitiaotrName=planets:pluto, szTargetName=planets.earth.dvr109, szAdditionalParameter=, nTargetID=...)
21:01:11 - Entering func: CStarPortDoc::SaveConfiguration()
21:01:11 - Exiting  func: CStarPortDoc::SaveConfiguration()
21:01:11 - Exiting  func: CStarPortDoc::CreateiSCSIDevice(IP=0xC0A80002, Port=3260, TargetName=planets.earth.dvr109, bAutomount=0)
21:01:11 - Entering func: CStarPortDoc::ResyncRegistryAndDriverContents(bAutomountDevices=0)
21:01:11 - Entering func: CDriveLetterMap::Refresh()
21:01:13 - CDriveLetterMap::Refresh: Device(E:): TargetId: 5
21:01:13 - Exiting  func: CDriveLetterMap::Refresh()
21:01:13 - CStarPortDoc::ResyncRegistryAndDriverContents: Resyncronizing contents...
21:01:13 - Entering func: CStarPortAPI::GetDevices(...)
21:01:13 - CStarPortAPI::GetDevices: Calling STARPORT_IOCTL_TARGET_LIST
21:01:13 - CStarPortAPI::GetDevices: Input buffer:
21:01:13 - CStarPortAPI::GetDevices: Signature = 72417453
21:01:13 - CStarPortAPI::GetDevices: Calling DeviceIoControl(...)
21:01:13 - CStarPortAPI::GetDevices: DeviceIoControl(...) called successfully
21:01:13 - CStarPortAPI::GetDevices: Output buffer:
21:01:13 - CStarPortAPI::GetDevices: Signature = 52615473
21:01:13 - CStarPortAPI::GetDevices: NumberOfTargets = 1
21:01:13 - CStarPortAPI::GetDevices: TargetID[0] = 5
21:01:13 - CStarPortAPI::GetDevices: Calling STARPORT_IOCTL_TARGET_INFO
21:01:13 - CStarPortAPI::GetDevices: Input buffer:
21:01:13 - CStarPortAPI::GetDevices: Signature = 72417453
21:01:13 - CStarPortAPI::GetDevices: TargetId = 5
21:01:13 - CStarPortAPI::GetDevices: Calling DeviceIoControl(...)
21:01:13 - CStarPortAPI::GetDevices: DeviceIoControl(...) called successfully
21:01:13 - CStarPortAPI::GetDevices: Output buffer:
21:01:13 - CStarPortAPI::GetDevices: Signature = 52615473
21:01:13 - CStarPortAPI::GetDevices: TargetId = 0
21:01:13 - CStarPortAPI::GetDevices: ServerAddress = 192.168.0.2:3260
21:01:13 - CStarPortAPI::GetDevices: TargetDescriptionLength = 60
21:01:13 - CStarPortAPI::GetDevices: TargetDescription[0] = InitiatorName=planets:pluto
21:01:13 - CStarPortAPI::GetDevices: TargetDescription[1] = TargetName=planets.earth.dvr109
21:01:13 - CStarPortAPI::GetDevices: NumberOfUnits = 1
21:01:13 - CStarPortAPI::GetDevices: LunInfo[0] = 0
21:01:13 - Exiting  func: CStarPortAPI::GetDevices(...)
21:01:13 - CStarPortAPI::CheckConnectionStatus: TargetId = 5
21:01:13 - CStarPortAPI::CheckConnectionStatus: DeviceIoControl(...) called successfully, Target device status = 2
21:01:13 - Entering func: CStarPortDoc::SaveConfiguration()
21:01:13 - Exiting  func: CStarPortDoc::SaveConfiguration()
21:01:13 - Exiting  func: CStarPortDoc::ResyncRegistryAndDriverContents(bAutomountDevices=0)
21:01:13 - Entering func: CStarPortDoc::SaveConfiguration()
21:01:13 - Exiting  func: CStarPortDoc::SaveConfiguration()
21:01:13 - CMainFrame::WindowProc: WM_DEVICECHANGE message received: wParam=0x8000, lParam=0x12E9A0.
21:01:13 - CMainFrame::WindowProc: WM_DEVICECHANGE message received: wParam=0x7, lParam=0x0.
21:01:13 - CMainFrame::WindowProc: WM_DEVICECHANGE message received: wParam=0x7, lParam=0x0.
21:01:13 - CMainFrame::WindowProc: WM_DEVICECHANGE message received: wParam=0x7, lParam=0x0.
21:01:13 - CMainFrame::WindowProc: WM_DEVICECHANGE message received: wParam=0x8004, lParam=0x12FE20.
21:01:13 - CMainFrame::WindowProc: WM_DEVICECHANGE message received: wParam=0x7, lParam=0x0.
21:01:13 - CMainFrame::WindowProc: WM_DEVICECHANGE message received: wParam=0x8000, lParam=0x12FE20.
21:01:13 - CMainFrame::WindowProc: WM_DEVICECHANGE message received: wParam=0x7, lParam=0x0.
21:01:23 - CMainFrame::OnTimer: Refreshing view, received REFRESH_TIMER_ID...
21:01:23 - Entering func: CStarPortDoc::ResyncRegistryAndDriverContents(bAutomountDevices=0)
21:01:23 - Entering func: CDriveLetterMap::Refresh()

Posted: **Thu Jul 21, 2005 11:29 pm**

Tim,

It seems there are some problems in your scenario. We'll try to find the issue and fix it.

But I saw from the logs that you tried to share the system hard drive as a SPTI device. This is impossible in StarWind 2.6.* because it tries to lock all volumes on the hard drive before allowing access to it from an initiator.
StarWind 2.4.0 has no such a logic and allows to access any hard drive in R/W mode, that could damage the drive's filesystems.

I'd suggest you trying the ImageFile plug-in instead of the SPTI mode to create virtual file based iSCSI targets.

Posted: **Fri Jul 22, 2005 6:31 pm**

Ok, I set 'Read-Only' for the SATA drive and it works fine.
I'm after high-speed access to the contents so this is fine for me.

Hope you workout the DVD-Writer hang problem soon.

Thanks

Posted: **Fri Jul 22, 2005 9:27 pm**

Good! OK

1) SATA issue - went away.

2) Sharing DVD writer - would check this out and return to you ASAP.

Thanks!

Tim wrote:Ok, I set 'Read-Only' for the SATA drive and it works fine.
I'm after high-speed access to the contents so this is fine for me.

Hope you workout the DVD-Writer hang problem soon.

Thanks

Posted: **Fri Jul 22, 2005 11:44 pm**

1) SATA issue - went away.

Yes, sorry about that.

Just me not understanding what's going on.
Good point about the sharing causing file system damage!

Posted: **Fri Jul 22, 2005 11:46 pm**

No problem

Tim wrote:
1) SATA issue - went away.
Yes, sorry about that. Just me not understanding what's going on.
Good point about the sharing causing file system damage!

Posted: **Wed Jul 27, 2005 8:04 pm**

2) Sharing DVD writer - would check this out and return to you ASAP.

Let me know if I can help in any way. More testing or more logs perhaps?

Posted: **Wed Jul 27, 2005 9:06 pm**

Actually our QA team has been successful in reproducing the problem so we'd try to solve the issue w/o your additional help

Would keep you updated about fixed version out. Thank you very much for cooperation!

Tim wrote:
2) Sharing DVD writer - would check this out and return to you ASAP.
Let me know if I can help in any way. More testing or more logs perhaps?

Posted: **Mon Sep 05, 2005 10:14 am**

Tim wrote:Let me know if I can help in any way. More testing or more logs perhaps?
:)

Hi Tim,

Could you try the recent StarWind version 2.6.4 build 20050901 whether it solves the problem with SPTI?

The version is available to download from our site:
http://www.starwindsoftware.com/download-free-trial

Thank you in advance.

Posted: **Mon Sep 05, 2005 12:59 pm**

Already on it!

All looks good so far, not had any problems with my testing.

StarWind Software

Some problems with StarWind 2.6.1

Some problems with StarWind 2.6.1