The log file name: 'logs\starwind-20121031-151513.log'
10/31 15:15:13.767 e14 Srv: StarWind iSCSI SAN Software v6.0.0 (Build 20120828, [SwSAN], Win64)
10/31 15:15:13.767 e14 Srv: Built Aug 28 2012 14:01:15
10/31 15:15:13.767 e14 Srv: Windows Server 2008 Unknown Edition Service Pack 2 (Build 6002)
10/31 15:15:13.767 e14 Srv: System CPU count: 4
10/31 15:15:13.767 e14 Srv: CPU affinity mask 0xf from 0xf.
10/31 15:15:13.767 e14 Srv: Licensed to: 'Oliver Richter', 'AlphaSoft Computer Security GmbH', (#2, 0, 80200000, 0).
10/31 15:15:13.767 e14 Srv: Config file: 'StarWind.cfg'
10/31 15:15:13.782 e14 conf: Variable 'LogLevel' is set to '1'.
10/31 15:15:13.782 e14 conf: Variable 'LogMask' is set to '0x8fffffff'.
10/31 15:15:13.798 e14 conf: Variable 'LogRotateSize' is set to '100'.
10/31 15:15:13.876 e14 conf: Variable 'LogRotateKeepLastFiles' is set to '5'.
10/31 15:15:13.954 e14 conf: Variable 'UpdatePeriod' is set to '7'.
10/31 15:15:14.032 e14 conf: Variable 'UpdateHost' is set to 'www.starwindsoftware.com'.
10/31 15:15:14.110 e14 conf: Variable 'UpdatePage' is set to '/updatetracker/index.php'.
10/31 15:15:14.188 e14 conf: Variable 'UpdatePort' is set to '80'.
10/31 15:15:14.266 e14 conf: Variable 'UpdateCopyId' is set to '4A9E5B3F-CDFF-4D4A-8CFD326EDB238A2C'.
10/31 15:15:14.968 e14 conf: Variable 'UpdateLastRequest' is set to '20121027'.
10/31 15:15:15.670 e14 conf: Variable 'Port' is set to '3260'.
10/31 15:15:16.372 e14 conf: Variable 'Interface' is set to '0.0.0.0'.
10/31 15:15:17.074 e14 conf: Variable 'BCastEnable' is set to 'yes'.
10/31 15:15:17.776 e14 conf: Variable 'BCastInterface' is set to '0.0.0.0'.
10/31 15:15:18.197 e14 conf: Variable 'BCastPort' is set to '3261'.
10/31 15:15:18.338 e14 conf: Variable 'nolisten' is set to '192.168.100.7:3260'.
10/31 15:15:18.416 e14 conf: Variable 'Login' is set to 'root'.
10/31 15:15:18.494 e14 conf: Variable 'Password' is set to '##evVRsIJtRmAEEd2sCslZDg=='.
10/31 15:15:18.572 e14 conf: Variable 'MinBufferSize' is set to '65536'.
10/31 15:15:18.650 e14 conf: Variable 'AlignmentMask' is set to '0x0000'.
10/31 15:15:18.728 e14 conf: Variable 'MaxPendingRequests' is set to '64'.
10/31 15:15:18.806 e14 conf: Variable 'iScsiPingPeriod' is set to '0'.
10/31 15:15:18.884 e14 conf: Variable 'LocalizationDir' is set to 'Localizations'.
10/31 15:15:18.962 e14 conf: Variable 'DataBaseRoot' is set to '.\NotifyDB'.
10/31 15:15:19.040 e14 conf: Invalid variable 'DBRotationDays'.
10/31 15:15:19.118 e14 conf: Variable 'DBFileSizeDays' is set to '1'.
10/31 15:15:19.196 e14 conf: Variable 'PerformanceMonitorEnabled' is set to 'yes'.
10/31 15:15:19.274 e14 conf: Variable 'PerformanceRoot' is set to '.\PerformanceDB'.
10/31 15:15:19.352 e14 conf: Variable 'FSMThresholdPercent' is set to '30'.
10/31 15:15:19.430 e14 conf: Variable 'FSMCheckPeriodSeconds' is set to '30'.
10/31 15:15:19.508 e14 conf: Variable 'FSMEnabled' is set to 'yes'.
10/31 15:15:19.586 e14 EventDB: wsRootDir = .\NotifyDB
10/31 15:15:19.664 e14 EventDB: wsRootDir = .\NotifyDB
10/31 15:15:19.789 e14 FileBrowser: Directory loaded: *|cdmfv|Event Logs|txt,log
10/31 15:15:19.867 e14 FileBrowser: Directory loaded: *|cdmfv|Headers|swdsk
10/31 15:15:19.945 e14 FileBrowser: Directory loaded: *|v|My Computer|*
10/31 15:15:20.023 e14 FileBrowser: Directory loaded: *|v|Image Files|img,dat
10/31 15:15:20.147 e14 Sw: DllMain: Initialize CDDS task descriptor...
10/31 15:15:20.303 e14 Sw: DllMain: CDDS task has has been reset: IsTaskScheduled: 0, SPStatus: 0 
10/31 15:15:20.459 e14 Sw: DllMain: CDDS task descriptor has been initialized!
10/31 15:15:20.615 e14 Sw -> Browser_InitDirInfo: >>
10/31 15:15:20.771 e14 Sw: Browser_InitDirInfo: Parse ImageDir: '*|cmdfv|My Computer|spbitmap'
10/31 15:15:20.927 e14 Sw: *Browser_InitDirInfo: 
	Dirname: '*'
	Rights: 0x1f
	Alias: 'My Computer'
	Extensions: 'spbitmap'
10/31 15:15:21.083 e14 Sw <- Browser_InitDirInfo: return (0x1)
10/31 15:15:21.239 e14 Sw -> Browser_InitDirInfo: >>
10/31 15:15:21.395 e14 Sw: Browser_InitDirInfo: Parse ImageDir: '*|cmdfv|Metadata|spmetadata'
10/31 15:15:21.473 e14 Sw: *Browser_InitDirInfo: 
	Dirname: '*'
	Rights: 0x1f
	Alias: 'Metadata'
	Extensions: 'spmetadata'
10/31 15:15:21.629 e14 Sw <- Browser_InitDirInfo: return (0x1)
10/31 15:15:21.785 e14 Sw -> Browser_InitDirInfo: >>
10/31 15:15:21.941 e14 Sw: Browser_InitDirInfo: Parse ImageDir: '*|cmdfv|Data|spdata'
10/31 15:15:22.097 e14 Sw: *Browser_InitDirInfo: 
	Dirname: '*'
	Rights: 0x1f
	Alias: 'Data'
	Extensions: 'spdata'
10/31 15:15:22.253 e14 Sw <- Browser_InitDirInfo: return (0x1)
10/31 15:15:22.409 e14 Sw: SscPort_Init: (build 20120828, built Aug 28 2012 14:01:38)
	VendorId  = '        '
	ProductId = '                '
	Revision  = '0001'
10/31 15:15:22.565 e14 conf: 'DDDisk.dll' loaded successfully.
10/31 15:15:22.675 e14 Sw: DllMain: Initialize CDDS task descriptor...
10/31 15:15:22.831 e14 Sw: DllMain: CDDS task has has been reset: IsTaskScheduled: 0, SPStatus: 0 
10/31 15:15:22.987 e14 Sw: DllMain: CDDS task descriptor has been initialized!
10/31 15:15:23.143 e14 Sw -> Browser_InitDirInfo: >>
10/31 15:15:23.299 e14 Sw: Browser_InitDirInfo: Parse ImageDir: '*|cmdfv|My Computer|spdata'
10/31 15:15:23.455 e14 Sw: *Browser_InitDirInfo: 
	Dirname: '*'
	Rights: 0x1f
	Alias: 'My Computer'
	Extensions: 'spdata'
10/31 15:15:23.611 e14 Sw <- Browser_InitDirInfo: return (0x1)
10/31 15:15:23.767 e14 Sw -> Browser_InitDirInfo: >>
10/31 15:15:23.923 e14 Sw: Browser_InitDirInfo: Parse ImageDir: '*|cmdfv|Metadata|spmetadata'
10/31 15:15:24.079 e14 Sw: *Browser_InitDirInfo: 
	Dirname: '*'
	Rights: 0x1f
	Alias: 'Metadata'
	Extensions: 'spmetadata'
10/31 15:15:24.235 e14 Sw <- Browser_InitDirInfo: return (0x1)
10/31 15:15:24.391 e14 Sw: SscPort_Init: (build 20120828, built Aug 28 2012 14:01:38)
	VendorId  = '        '
	ProductId = '                '
	Revision  = '0001'
10/31 15:15:24.547 e14 conf: 'DDDiskEx.dll' loaded successfully.
10/31 15:15:24.625 e14 conf: Failed to load 'DDDiskLFS.dll' (error 126).
10/31 15:15:24.718 e14 RAM: SscPort_Init: (build 20120828, built Aug 28 2012 14:00:50)
	VendorId  = '        '
	ProductId = '                '
	Revision  = '0001'
10/31 15:15:24.874 e14 conf: 'RamDisk.dll' loaded successfully.
10/31 15:15:24.968 e14 Sw -> Browser_InitDirInfo: >>
10/31 15:15:25.124 e14 Sw: Browser_InitDirInfo: Parse ImageDir: '*|cmdfv|My Computer|img'
10/31 15:15:25.280 e14 Sw: *Browser_InitDirInfo: 
	Dirname: '*'
	Rights: 0x1f
	Alias: 'My Computer'
	Extensions: 'img'
10/31 15:15:25.436 e14 Sw <- Browser_InitDirInfo: return (0x1)
10/31 15:15:25.592 e14 IMG: SscPort_Init: (build 20120828, built Aug 28 2012 14:00:51)
	VendorId  = '        '
	ProductId = '                '
	Revision  = '0001'
	Volumes   = 0
10/31 15:15:25.748 e14 conf: 'ImageFile.dll' loaded successfully.
10/31 15:15:25.826 e14 Sw: *Browser_InitDirInfo: 
	Dirname: '*'
	Rights: 0x18
	Alias: 'My Computer'
	Extensions: 'mds,iso'
10/31 15:15:25.982 e14 conf: 'VirtualDvd.dll' loaded successfully.
10/31 15:15:26.091 e14 IBV: *SscPort_Init: Unused parameter: 'module'
10/31 15:15:26.247 e14 IBV: *SscPort_Init: Unused parameter: 'type'
10/31 15:15:26.403 e14 Sw: *Browser_InitDirInfo: 
	Dirname: '*'
	Rights: 0x1f
	Alias: 'My Computer'
	Extensions: 'ibv'
10/31 15:15:26.621 e14 Sw: *Browser_InitDirInfo: 
	Dirname: '*'
	Rights: 0x1e
	Alias: 'Snapshots'
	Extensions: 'ibvss'
10/31 15:15:26.777 e14 Sw: *Browser_InitDirInfo: 
	Dirname: '*'
	Rights: 0x8
	Alias: 'Database'
	Extensions: 'ibvdb'
10/31 15:15:26.933 e14 Sw: *Browser_InitDirInfo: 
	Dirname: '*'
	Rights: 0x9
	Alias: 'Image Files'
	Extensions: 'img,dat'
10/31 15:15:27.089 e14 IBV: SscPort_Init: (build 20120828, built Aug 28 2012 14:00:55)
	VendorId  = '        '
	ProductId = '                '
	Revision  = '0001'
	ImageDir  = '*\'
	ExeDir    = 'C:\Program Files\StarWind Software\StarWind\'
10/31 15:15:27.245 e14 conf: 'IBVolume.dll' loaded successfully.
10/31 15:15:27.339 e14 Sw: *Browser_InitDirInfo: 
	Dirname: '*'
	Rights: 0x1f
	Alias: 'Mirror Volumes'
	Extensions: 'mir'
10/31 15:15:27.495 e14 Sw: *Browser_InitDirInfo: 
	Dirname: '*'
	Rights: 0x1f
	Alias: 'Image Files'
	Extensions: 'img,dat'
10/31 15:15:27.573 e14 conf: 'Mirror.dll' loaded successfully.
10/31 15:15:27.667 e14 DSKBR: SscPort_Init: (built Aug 28 2012 14:00:53)
	VendorId  = '        '
	ProductId = '                '
	Revision  = '0001'
	ExeDir    = 'C:\Program Files\StarWind Software\StarWind\'
10/31 15:15:27.823 e14 conf: 'DiskBridge.dll' loaded successfully.
10/31 15:15:27.916 e14 VTAPE: SscPort_Init: Parse ImageDir: '*|cmdfv|My Computer|vtl'
10/31 15:15:28.072 e14 VTAPE: *SscPort_Init: 
	Dirname: '*'
	Rights: 0x1f
	Alias: 'My Computer'
	Extensions: 'vtl'
10/31 15:15:28.228 e14 VTAPE: SscPort_Init: 	Comment : ''
10/31 15:15:28.447 e14 VTAPE: *** SscPort_Init: Logging level is set to 1.
10/31 15:15:28.603 e14 VTAPE: *** SscPort_Init: DBG_ERROR   statements are ON.
10/31 15:15:28.759 e14 VTAPE: SscPort_Init: (built Sep  9 2010 11:29:15)
	VendorId  = '        '
	ProductId = '                '
	Revision  = '    '
	DefImageDir  = '*\'
	Volumes   = 0
	ExeDir    = 'C:\Program Files\StarWind Software\StarWind\'
10/31 15:15:28.915 e14 VTAPE: *** TapeEmulCtrlApiStart: StarWind VTL License Type is 3
10/31 15:15:29.071 e14 VTAPE: *** TapeEmulCtrlApiStart: This Enterprise Edition supports a maximum of 64 devices, each up to 2097152 MB in length.
10/31 15:15:29.227 e14 conf: 'VirtualTape.dll' loaded successfully.
10/31 15:15:29.336 e14 HA: *SscPort_InitEx: Unused parameter: 'module'
10/31 15:15:29.492 e14 HA: *SscPort_InitEx: Unused parameter: 'type'
10/31 15:15:29.648 e14 Sw -> Browser_InitDirInfo: >>
10/31 15:15:29.804 e14 Sw: Browser_InitDirInfo: Parse ImageDir: '*|cmdfv|My Computer|img'
10/31 15:15:29.960 e14 Sw: *Browser_InitDirInfo: 
	Dirname: '*'
	Rights: 0x1f
	Alias: 'My Computer'
	Extensions: 'img'
10/31 15:15:30.116 e14 Sw <- Browser_InitDirInfo: return (0x1)
10/31 15:15:30.272 e14 HA: SscPort_InitEx: OS major version more then 5, then will be used internal transport.10/31 15:15:30.490 e14 Sw -> Browser_InitDirInfo: >>
10/31 15:15:30.646 e14 Sw: Browser_InitDirInfo: Parse ImageDir: '*|cdmfv|Headers|swdsk'
10/31 15:15:30.802 e14 Sw: *Browser_InitDirInfo: 
	Dirname: '*'
	Rights: 0x1f
	Alias: 'Headers'
	Extensions: 'swdsk'
10/31 15:15:30.958 e14 Sw <- Browser_InitDirInfo: return (0x1)
10/31 15:15:31.114 e14 Sw -> Browser_InitDirInfo: >>
10/31 15:15:31.270 e14 Sw: Browser_InitDirInfo: Parse ImageDir: 'Device Headers|cdmfv|DefaultHeaderPath|swdsk'
10/31 15:15:31.489 e14 Sw: *Browser_InitDirInfo: 
	Dirname: 'C:\Program Files\StarWind Software\StarWind\Device Headers'
	Rights: 0x1f
	Alias: 'DefaultHeaderPath'
	Extensions: 'swdsk'
10/31 15:15:31.645 e14 Sw <- Browser_InitDirInfo: return (0x1)
10/31 15:15:31.801 e14 HA: SscPort_InitEx: (build 20120828, built Aug 28 2012 14:00:52)
	VendorId  = '        '
	ProductId = '                '
	Revision  = '0001'
	DefImageDir  = '*\'
	Volumes   = 0
	ExeDir    = 'C:\Program Files\StarWind Software\StarWind\'
10/31 15:15:31.957 e14 HA: CHADevice::InitializeModule: Params(p_hCxxLogger = 0x00000000002937E0, p_lDbgLevel = 1, p_pCallback = 0x00000000002017F0, p_hPluginHandle = 0x0000000001B937E0, p_ScsiTransportType = 3) ENTERed
10/31 15:15:32.050 e14 conf: 'HAImage.dll' loaded successfully.
10/31 15:15:32.144 e14 Tgt: : parameter 'file', value 'My Computer\D\ELG\ELG-DC1-LWC.img'.
10/31 15:15:32.222 e14 Tgt: : parameter 'asyncmode', value 'yes'.
10/31 15:15:32.300 e14 Tgt: : parameter 'readonly', value 'no'.
10/31 15:15:32.378 e14 Tgt: : parameter 'CacheMode', value 'none'.
10/31 15:15:32.518 e14 IMG: SscPort_Create: Opening device 'ImageFile2', image file 'My Computer\D\ELG\ELG-DC1-LWC.img', buffering=0, async=1, readonly=0.
10/31 15:15:32.674 e14 IMG: ImageFile_Create: 'D:\ELG\ELG-DC1-LWC.img': type 0, geometry: sct 16, trks 32, cyl 282624, TotalSectors: 144703488
10/31 15:15:32.830 e14 Ssc: *** SscScsi_GetVolumeSectorSize: '\\.\D:' IOCTL_STORAGE_QUERY_PROPERTY(StorageAccessAlignmentProperty) failed (error 1)
10/31 15:15:32.986 e14 IMG: ImageFile_Create: VendorId 'ROCKET  ', ProductId 'IMAGEFILE       ', Revision '0001', Serial '5B80D6A57CB6B0B1'
10/31 15:15:33.142 e14 conf: Device [0x0000000001BB0FA0] 'ImageFile2' has been created.
10/31 15:15:33.220 e14 Tgt: : parameter 'file', value 'My Computer\D\ELG\ELG-DC1-DriveU.img'.
10/31 15:15:33.298 e14 Tgt: : parameter 'asyncmode', value 'yes'.
10/31 15:15:33.376 e14 Tgt: : parameter 'readonly', value 'no'.
10/31 15:15:33.517 e14 Tgt: : parameter 'CacheMode', value 'none'.
10/31 15:15:33.595 e14 IMG: SscPort_Create: Opening device 'ImageFile3', image file 'My Computer\D\ELG\ELG-DC1-DriveU.img', buffering=0, async=1, readonly=0.
10/31 15:15:33.751 e14 IMG: ImageFile_Create: 'D:\ELG\ELG-DC1-DriveU.img': type 0, geometry: sct 16, trks 32, cyl 819200, TotalSectors: 419430400
10/31 15:15:33.907 e14 Ssc: *** SscScsi_GetVolumeSectorSize: '\\.\D:' IOCTL_STORAGE_QUERY_PROPERTY(StorageAccessAlignmentProperty) failed (error 1)
10/31 15:15:34.063 e14 IMG: ImageFile_Create: VendorId 'ROCKET  ', ProductId 'IMAGEFILE       ', Revision '0001', Serial '6E95693DFED8A255'
10/31 15:15:34.219 e14 conf: Device [0x0000000001BB1DE0] 'ImageFile3' has been created.
10/31 15:15:34.297 e14 Tgt: : parameter 'file', value 'My Computer\D\ELG\SQL01-SRV-LWD.img'.
10/31 15:15:34.375 e14 Tgt: : parameter 'asyncmode', value 'yes'.
10/31 15:15:34.515 e14 Tgt: : parameter 'readonly', value 'no'.
10/31 15:15:34.593 e14 Tgt: : parameter 'CacheMode', value 'wb'.
10/31 15:15:34.671 e14 Tgt: : parameter 'CacheSizeMB', value '1024'.
10/31 15:15:34.749 e14 Tgt: : parameter 'CacheBlockExpiryPeriodMS', value '5000'.
10/31 15:15:34.827 e14 IMG: SscPort_Create: Opening device 'ImageFile4', image file 'My Computer\D\ELG\SQL01-SRV-LWD.img', buffering=0, async=1, readonly=0.
10/31 15:15:34.983 e14 IMG: ImageFile_Create: 'D:\ELG\SQL01-SRV-LWD.img': type 0, geometry: sct 16, trks 32, cyl 819200, TotalSectors: 419430400
10/31 15:15:35.139 e14 Ssc: *** SscScsi_GetVolumeSectorSize: '\\.\D:' IOCTL_STORAGE_QUERY_PROPERTY(StorageAccessAlignmentProperty) failed (error 1)
10/31 15:15:35.295 e14 IMG: ImageFile_Create: VendorId 'ROCKET  ', ProductId 'IMAGEFILE       ', Revision '0001', Serial 'C2EB97D839CB1C32'
10/31 15:15:35.451 e14 CACHE: *** SWCache_Create: Cache parameters: Mode = 1, Flags = 0, Size = 1024 MB, SectorSize = 512, BlockExpiryPeriod = 5000, DiskSizeInSectors = 419430400
10/31 15:15:35.997 e14 conf: Device [0x0000000001BB3250] 'ImageFile4' has been created.
10/31 15:15:36.075 e14 Tgt: : parameter 'file', value 'My Computer\D\ELG\SQL01-SRV.img'.
10/31 15:15:36.153 e14 Tgt: : parameter 'asyncmode', value 'yes'.
10/31 15:15:36.231 e14 Tgt: : parameter 'readonly', value 'no'.
10/31 15:15:36.309 e14 Tgt: : parameter 'CacheMode', value 'wb'.
10/31 15:15:36.387 e14 Tgt: : parameter 'CacheSizeMB', value '1024'.
10/31 15:15:36.465 e14 Tgt: : parameter 'CacheBlockExpiryPeriodMS', value '5000'.
10/31 15:15:36.543 e14 IMG: SscPort_Create: Opening device 'ImageFile5', image file 'My Computer\D\ELG\SQL01-SRV.img', buffering=0, async=1, readonly=0.
10/31 15:15:36.699 e14 IMG: ImageFile_Create: 'D:\ELG\SQL01-SRV.img': type 0, geometry: sct 16, trks 32, cyl 716800, TotalSectors: 367001600
10/31 15:15:36.855 e14 Ssc: *** SscScsi_GetVolumeSectorSize: '\\.\D:' IOCTL_STORAGE_QUERY_PROPERTY(StorageAccessAlignmentProperty) failed (error 1)
10/31 15:15:37.011 e14 IMG: ImageFile_Create: VendorId 'ROCKET  ', ProductId 'IMAGEFILE       ', Revision '0001', Serial 'A447C1C3C56DBA0B'
10/31 15:15:37.167 e14 CACHE: *** SWCache_Create: Cache parameters: Mode = 1, Flags = 0, Size = 1024 MB, SectorSize = 512, BlockExpiryPeriod = 5000, DiskSizeInSectors = 367001600
10/31 15:15:37.651 e14 conf: Device [0x0000000001BB46A0] 'ImageFile5' has been created.
10/31 15:15:37.729 e14 Tgt: : parameter 'file', value 'My Computer\D\ELG\VID01-SRV.img'.
10/31 15:15:37.807 e14 Tgt: : parameter 'asyncmode', value 'yes'.
10/31 15:15:37.885 e14 Tgt: : parameter 'readonly', value 'no'.
10/31 15:15:37.963 e14 Tgt: : parameter 'CacheMode', value 'wt'.
10/31 15:15:38.041 e14 Tgt: : parameter 'CacheSizeMB', value '512'.
10/31 15:15:38.119 e14 Tgt: : parameter 'CacheBlockExpiryPeriodMS', value '5000'.
10/31 15:15:38.119 e14 IMG: SscPort_Create: Opening device 'ImageFile6', image file 'My Computer\D\ELG\VID01-SRV.img', buffering=0, async=1, readonly=0.
10/31 15:15:38.275 e14 IMG: ImageFile_Create: 'D:\ELG\VID01-SRV.img': type 0, geometry: sct 16, trks 32, cyl 307208, TotalSectors: 157290496
10/31 15:15:38.431 e14 Ssc: *** SscScsi_GetVolumeSectorSize: '\\.\D:' IOCTL_STORAGE_QUERY_PROPERTY(StorageAccessAlignmentProperty) failed (error 1)
10/31 15:15:38.587 e14 IMG: ImageFile_Create: VendorId 'ROCKET  ', ProductId 'IMAGEFILE       ', Revision '0001', Serial '838FD190A57BEEBD'
10/31 15:15:38.743 e14 CACHE: *** SWCache_Create: Cache parameters: Mode = 3, Flags = 0, Size = 512 MB, SectorSize = 512, BlockExpiryPeriod = 5000, DiskSizeInSectors = 157290496
10/31 15:15:39.133 e14 conf: Device [0x0000000001BB50C0] 'ImageFile6' has been created.
10/31 15:15:39.211 e14 Tgt: : parameter 'file', value 'My Computer\D\ELG\VID01-SRV-DATA.img'.
10/31 15:15:39.289 e14 Tgt: : parameter 'asyncmode', value 'yes'.
10/31 15:15:39.367 e14 Tgt: : parameter 'readonly', value 'no'.
10/31 15:15:39.445 e14 Tgt: : parameter 'CacheMode', value 'wt'.
10/31 15:15:39.523 e14 Tgt: : parameter 'CacheSizeMB', value '512'.
10/31 15:15:39.601 e14 Tgt: : parameter 'CacheBlockExpiryPeriodMS', value '5000'.
10/31 15:15:39.679 e14 IMG: SscPort_Create: Opening device 'ImageFile7', image file 'My Computer\D\ELG\VID01-SRV-DATA.img', buffering=0, async=1, readonly=0.
10/31 15:15:39.835 e14 IMG: ImageFile_Create: 'D:\ELG\VID01-SRV-DATA.img': type 0, geometry: sct 16, trks 32, cyl 819200, TotalSectors: 419430400
10/31 15:15:39.991 e14 Ssc: *** SscScsi_GetVolumeSectorSize: '\\.\D:' IOCTL_STORAGE_QUERY_PROPERTY(StorageAccessAlignmentProperty) failed (error 1)
10/31 15:15:40.147 e14 IMG: ImageFile_Create: VendorId 'ROCKET  ', ProductId 'IMAGEFILE       ', Revision '0001', Serial '67AFA7C8326A7657'
10/31 15:15:40.303 e14 CACHE: *** SWCache_Create: Cache parameters: Mode = 3, Flags = 0, Size = 512 MB, SectorSize = 512, BlockExpiryPeriod = 5000, DiskSizeInSectors = 419430400
10/31 15:15:40.677 e14 conf: Device [0x0000000001BB83B0] 'ImageFile7' has been created.
10/31 15:15:40.755 e14 Tgt: : parameter 'file', value 'My Computer\D\Windows 7\BUHA01-PC1.img'.
10/31 15:15:40.833 e14 Tgt: : parameter 'asyncmode', value 'yes'.
10/31 15:15:40.911 e14 Tgt: : parameter 'readonly', value 'no'.
10/31 15:15:40.989 e14 Tgt: : parameter 'CacheMode', value 'wt'.
10/31 15:15:41.067 e14 Tgt: : parameter 'CacheSizeMB', value '512'.
10/31 15:15:41.145 e14 Tgt: : parameter 'CacheBlockExpiryPeriodMS', value '5000'.
10/31 15:15:41.223 e14 IMG: SscPort_Create: Opening device 'ImageFile8', image file 'My Computer\D\Windows 7\BUHA01-PC1.img', buffering=0, async=1, readonly=0.
10/31 15:15:41.379 e14 IMG: ImageFile_Create: 'D:\Windows 7\BUHA01-PC1.img': type 0, geometry: sct 16, trks 32, cyl 266656, TotalSectors: 136527872
10/31 15:15:41.535 e14 Ssc: *** SscScsi_GetVolumeSectorSize: '\\.\D:' IOCTL_STORAGE_QUERY_PROPERTY(StorageAccessAlignmentProperty) failed (error 1)
10/31 15:15:41.691 e14 IMG: ImageFile_Create: VendorId 'ROCKET  ', ProductId 'IMAGEFILE       ', Revision '0001', Serial '38ABBAC914D33EB8'
10/31 15:15:41.847 e14 CACHE: *** SWCache_Create: Cache parameters: Mode = 3, Flags = 0, Size = 512 MB, SectorSize = 512, BlockExpiryPeriod = 5000, DiskSizeInSectors = 136527872
10/31 15:15:42.206 e14 conf: Device [0x0000000001BB9E00] 'ImageFile8' has been created.
10/31 15:15:42.284 e14 Srv: Creating target 'iqn.2008-08.com.starwindsoftware:san01-hyp01-srv', device list 'ImageFile2,ImageFile3,ImageFile4,ImageFile5,ImageFile6,ImageFile7,ImageFile8'...
10/31 15:15:42.377 e14 Tgt: : parameter 'header', value '0'.
10/31 15:15:42.455 e14 Tgt: : parameter 'file', value 'My Computer\D\ELG\ELG-DC1-LWC.img'.
10/31 15:15:42.533 e14 Tgt: : parameter 'buffering', value 'no'.
10/31 15:15:42.611 e14 Tgt: : parameter 'asyncmode', value 'yes'.
10/31 15:15:42.689 e14 Tgt: : parameter 'ImageSizeLow', value '1073741824'.
10/31 15:15:42.767 e14 Tgt: : parameter 'ImageSizeHigh', value '17'.
10/31 15:15:42.845 e14 Tgt: : parameter 'readonly', value 'no'.
10/31 15:15:42.923 e14 Tgt: : parameter 'readonly', value 'no'.
10/31 15:15:43.001 e14 Tgt: : parameter 'DeviceState', value '1'.
10/31 15:15:43.079 e14 Tgt: : parameter 'CacheMode', value 'none'.
10/31 15:15:43.157 e14 Tgt: : parameter 'CacheSizeMB', value '0'.
10/31 15:15:43.235 e14 Tgt: : parameter 'CacheBlockExpiryPeriodMS', value '0'.
10/31 15:15:43.313 e14 Tgt: : parameter '#_TargetName_#', value 'iqn.2008-08.com.starwindsoftware:san01-hyp01-srv'.
10/31 15:15:43.391 e48 IMG: *** ImageFile_ScsiExec: COMPARE_AND_WRITE (0x89) is not supported.
10/31 15:15:43.391 e14 SCSI: SCSIOP_COMPARE_AND_WRITE test failed for LUN. We will emulate the SCSIOP.
10/31 15:15:43.469 e48 Ssc: *** SscScsi_InquiryHandler: INQUIRY VPD page 0xb0 is not supported!
10/31 15:15:43.469 e14 SCSI: SCSIOP_WRITE_SAME test failed for LUN. We will emulate the SCSIOP.
10/31 15:15:43.547 e14 Tgt: iqn.2008-08.com.starwindsoftware:san01-hyp01-srv: device ImageFile2: new LUN 0 mapped to target LUN 0.
10/31 15:15:43.625 e14 Tgt: iqn.2008-08.com.starwindsoftware:san01-hyp01-srv: attached device ImageFile2 (found 1 LUNs).
10/31 15:15:43.703 e14 Tgt: : parameter 'header', value '0'.
10/31 15:15:43.781 e14 Tgt: : parameter 'file', value 'My Computer\D\ELG\ELG-DC1-DriveU.img'.
10/31 15:15:43.859 e14 Tgt: : parameter 'buffering', value 'no'.
10/31 15:15:43.937 e14 Tgt: : parameter 'asyncmode', value 'yes'.
10/31 15:15:44.015 e14 Tgt: : parameter 'ImageSizeLow', value '0'.
10/31 15:15:44.093 e14 Tgt: : parameter 'ImageSizeHigh', value '50'.
10/31 15:15:44.171 e14 Tgt: : parameter 'readonly', value 'no'.
10/31 15:15:44.249 e14 Tgt: : parameter 'readonly', value 'no'.
10/31 15:15:44.327 e14 Tgt: : parameter 'DeviceState', value '1'.
10/31 15:15:44.405 e14 Tgt: : parameter 'CacheMode', value 'none'.
10/31 15:15:44.483 e14 Tgt: : parameter 'CacheSizeMB', value '0'.
10/31 15:15:44.561 e14 Tgt: : parameter 'CacheBlockExpiryPeriodMS', value '0'.
10/31 15:15:44.702 e14 Tgt: : parameter '#_TargetName_#', value 'iqn.2008-08.com.starwindsoftware:san01-hyp01-srv'.
10/31 15:15:44.780 e4c IMG: *** ImageFile_ScsiExec: COMPARE_AND_WRITE (0x89) is not supported.
10/31 15:15:44.780 e14 SCSI: SCSIOP_COMPARE_AND_WRITE test failed for LUN. We will emulate the SCSIOP.
10/31 15:15:44.858 e4c Ssc: *** SscScsi_InquiryHandler: INQUIRY VPD page 0xb0 is not supported!
10/31 15:15:44.858 e14 SCSI: SCSIOP_WRITE_SAME test failed for LUN. We will emulate the SCSIOP.
10/31 15:15:44.936 e14 Tgt: iqn.2008-08.com.starwindsoftware:san01-hyp01-srv: device ImageFile3: new LUN 0 mapped to target LUN 1.
10/31 15:15:45.014 e14 Tgt: iqn.2008-08.com.starwindsoftware:san01-hyp01-srv: attached device ImageFile3 (found 1 LUNs).
10/31 15:15:45.170 e14 Tgt: : parameter 'header', value '0'.
10/31 15:15:45.248 e14 Tgt: : parameter 'file', value 'My Computer\D\ELG\SQL01-SRV-LWD.img'.
10/31 15:15:45.326 e14 Tgt: : parameter 'buffering', value 'no'.
10/31 15:15:45.404 e14 Tgt: : parameter 'asyncmode', value 'yes'.
10/31 15:15:45.482 e14 Tgt: : parameter 'ImageSizeLow', value '0'.
10/31 15:15:45.560 e14 Tgt: : parameter 'ImageSizeHigh', value '50'.
10/31 15:15:45.638 e14 Tgt: : parameter 'readonly', value 'no'.
10/31 15:15:45.716 e14 Tgt: : parameter 'readonly', value 'no'.
10/31 15:15:45.794 e14 Tgt: : parameter 'DeviceState', value '1'.
10/31 15:15:45.872 e14 Tgt: : parameter 'CacheMode', value 'wb'.
10/31 15:15:45.950 e14 Tgt: : parameter 'CacheSizeMB', value '1024'.
10/31 15:15:46.028 e14 Tgt: : parameter 'CacheBlockExpiryPeriodMS', value '5000'.
10/31 15:15:46.106 e14 Tgt: : parameter '#_TargetName_#', value 'iqn.2008-08.com.starwindsoftware:san01-hyp01-srv'.
10/31 15:15:46.184 e54 IMG: *** ImageFile_ScsiExec: COMPARE_AND_WRITE (0x89) is not supported.
10/31 15:15:46.184 e14 SCSI: SCSIOP_COMPARE_AND_WRITE test failed for LUN. We will emulate the SCSIOP.
10/31 15:15:46.262 e54 Ssc: *** SscScsi_InquiryHandler: INQUIRY VPD page 0xb0 is not supported!
10/31 15:15:46.262 e14 SCSI: SCSIOP_WRITE_SAME test failed for LUN. We will emulate the SCSIOP.
10/31 15:15:46.340 e14 Tgt: iqn.2008-08.com.starwindsoftware:san01-hyp01-srv: device ImageFile4: new LUN 0 mapped to target LUN 2.
10/31 15:15:46.418 e14 Tgt: iqn.2008-08.com.starwindsoftware:san01-hyp01-srv: attached device ImageFile4 (found 1 LUNs).
10/31 15:15:46.511 e14 Tgt: : parameter 'header', value '0'.
10/31 15:15:46.589 e14 Tgt: : parameter 'file', value 'My Computer\D\ELG\SQL01-SRV.img'.
10/31 15:15:46.730 e14 Tgt: : parameter 'buffering', value 'no'.
10/31 15:15:46.808 e14 Tgt: : parameter 'asyncmode', value 'yes'.
10/31 15:15:46.886 e14 Tgt: : parameter 'ImageSizeLow', value '3221225472'.
10/31 15:15:46.964 e14 Tgt: : parameter 'ImageSizeHigh', value '43'.
10/31 15:15:47.042 e14 Tgt: : parameter 'readonly', value 'no'.
10/31 15:15:47.120 e14 Tgt: : parameter 'readonly', value 'no'.
10/31 15:15:47.198 e14 Tgt: : parameter 'DeviceState', value '1'.
10/31 15:15:47.276 e14 Tgt: : parameter 'CacheMode', value 'wb'.
10/31 15:15:47.354 e14 Tgt: : parameter 'CacheSizeMB', value '1024'.
10/31 15:15:47.432 e14 Tgt: : parameter 'CacheBlockExpiryPeriodMS', value '5000'.
10/31 15:15:47.510 e14 Tgt: : parameter '#_TargetName_#', value 'iqn.2008-08.com.starwindsoftware:san01-hyp01-srv'.
10/31 15:15:47.588 e64 IMG: *** ImageFile_ScsiExec: COMPARE_AND_WRITE (0x89) is not supported.
10/31 15:15:47.588 e14 SCSI: SCSIOP_COMPARE_AND_WRITE test failed for LUN. We will emulate the SCSIOP.
10/31 15:15:47.728 e64 Ssc: *** SscScsi_InquiryHandler: INQUIRY VPD page 0xb0 is not supported!
10/31 15:15:47.728 e14 SCSI: SCSIOP_WRITE_SAME test failed for LUN. We will emulate the SCSIOP.
10/31 15:15:47.806 e14 Tgt: iqn.2008-08.com.starwindsoftware:san01-hyp01-srv: device ImageFile5: new LUN 0 mapped to target LUN 3.
10/31 15:15:47.884 e14 Tgt: iqn.2008-08.com.starwindsoftware:san01-hyp01-srv: attached device ImageFile5 (found 1 LUNs).
10/31 15:15:47.962 e14 Tgt: : parameter 'header', value '0'.
10/31 15:15:48.040 e14 Tgt: : parameter 'file', value 'My Computer\D\ELG\VID01-SRV.img'.
10/31 15:15:48.118 e14 Tgt: : parameter 'buffering', value 'no'.
10/31 15:15:48.196 e14 Tgt: : parameter 'asyncmode', value 'yes'.
10/31 15:15:48.274 e14 Tgt: : parameter 'ImageSizeLow', value '3223322624'.
10/31 15:15:48.352 e14 Tgt: : parameter 'ImageSizeHigh', value '18'.
10/31 15:15:48.430 e14 Tgt: : parameter 'readonly', value 'no'.
10/31 15:15:48.508 e14 Tgt: : parameter 'readonly', value 'no'.
10/31 15:15:48.586 e14 Tgt: : parameter 'DeviceState', value '1'.
10/31 15:15:48.727 e14 Tgt: : parameter 'CacheMode', value 'wt'.
10/31 15:15:48.805 e14 Tgt: : parameter 'CacheSizeMB', value '512'.
10/31 15:15:48.883 e14 Tgt: : parameter 'CacheBlockExpiryPeriodMS', value '5000'.
10/31 15:15:48.961 e14 Tgt: : parameter '#_TargetName_#', value 'iqn.2008-08.com.starwindsoftware:san01-hyp01-srv'.
10/31 15:15:49.039 e74 IMG: *** ImageFile_ScsiExec: COMPARE_AND_WRITE (0x89) is not supported.
10/31 15:15:49.039 e14 SCSI: SCSIOP_COMPARE_AND_WRITE test failed for LUN. We will emulate the SCSIOP.
10/31 15:15:49.117 e74 Ssc: *** SscScsi_InquiryHandler: INQUIRY VPD page 0xb0 is not supported!
10/31 15:15:49.117 e14 SCSI: SCSIOP_WRITE_SAME test failed for LUN. We will emulate the SCSIOP.
10/31 15:15:49.195 e14 Tgt: iqn.2008-08.com.starwindsoftware:san01-hyp01-srv: device ImageFile6: new LUN 0 mapped to target LUN 4.
10/31 15:15:49.273 e14 Tgt: iqn.2008-08.com.starwindsoftware:san01-hyp01-srv: attached device ImageFile6 (found 1 LUNs).
10/31 15:15:49.351 e14 Tgt: : parameter 'header', value '0'.
10/31 15:15:49.429 e14 Tgt: : parameter 'file', value 'My Computer\D\ELG\VID01-SRV-DATA.img'.
10/31 15:15:49.507 e14 Tgt: : parameter 'buffering', value 'no'.
10/31 15:15:49.585 e14 Tgt: : parameter 'asyncmode', value 'yes'.
10/31 15:15:49.725 e14 Tgt: : parameter 'ImageSizeLow', value '0'.
10/31 15:15:49.803 e14 Tgt: : parameter 'ImageSizeHigh', value '50'.
10/31 15:15:49.881 e14 Tgt: : parameter 'readonly', value 'no'.
10/31 15:15:49.959 e14 Tgt: : parameter 'readonly', value 'no'.
10/31 15:15:50.037 e14 Tgt: : parameter 'DeviceState', value '1'.
10/31 15:15:50.178 e14 Tgt: : parameter 'CacheMode', value 'wt'.
10/31 15:15:50.256 e14 Tgt: : parameter 'CacheSizeMB', value '512'.
10/31 15:15:50.334 e14 Tgt: : parameter 'CacheBlockExpiryPeriodMS', value '5000'.
10/31 15:15:50.412 e14 Tgt: : parameter '#_TargetName_#', value 'iqn.2008-08.com.starwindsoftware:san01-hyp01-srv'.
10/31 15:15:50.490 e80 IMG: *** ImageFile_ScsiExec: COMPARE_AND_WRITE (0x89) is not supported.
10/31 15:15:50.490 e14 SCSI: SCSIOP_COMPARE_AND_WRITE test failed for LUN. We will emulate the SCSIOP.
10/31 15:15:50.568 e80 Ssc: *** SscScsi_InquiryHandler: INQUIRY VPD page 0xb0 is not supported!
10/31 15:15:50.568 e14 SCSI: SCSIOP_WRITE_SAME test failed for LUN. We will emulate the SCSIOP.
10/31 15:15:50.646 e14 Tgt: iqn.2008-08.com.starwindsoftware:san01-hyp01-srv: device ImageFile7: new LUN 0 mapped to target LUN 5.
10/31 15:15:50.786 e14 Tgt: iqn.2008-08.com.starwindsoftware:san01-hyp01-srv: attached device ImageFile7 (found 1 LUNs).
10/31 15:15:50.864 e14 Tgt: : parameter 'header', value '0'.
10/31 15:15:50.942 e14 Tgt: : parameter 'file', value 'My Computer\D\Windows 7\BUHA01-PC1.img'.
10/31 15:15:51.020 e14 Tgt: : parameter 'buffering', value 'no'.
10/31 15:15:51.098 e14 Tgt: : parameter 'asyncmode', value 'yes'.
10/31 15:15:51.176 e14 Tgt: : parameter 'ImageSizeLow', value '1182793728'.
10/31 15:15:51.254 e14 Tgt: : parameter 'ImageSizeHigh', value '16'.
10/31 15:15:51.332 e14 Tgt: : parameter 'readonly', value 'no'.
10/31 15:15:51.410 e14 Tgt: : parameter 'readonly', value 'no'.
10/31 15:15:51.488 e14 Tgt: : parameter 'DeviceState', value '1'.
10/31 15:15:51.566 e14 Tgt: : parameter 'CacheMode', value 'wt'.
10/31 15:15:51.644 e14 Tgt: : parameter 'CacheSizeMB', value '512'.
10/31 15:15:51.722 e14 Tgt: : parameter 'CacheBlockExpiryPeriodMS', value '5000'.
10/31 15:15:51.800 e14 Tgt: : parameter '#_TargetName_#', value 'iqn.2008-08.com.starwindsoftware:san01-hyp01-srv'.
10/31 15:15:51.878 e88 IMG: *** ImageFile_ScsiExec: COMPARE_AND_WRITE (0x89) is not supported.
10/31 15:15:51.878 e14 SCSI: SCSIOP_COMPARE_AND_WRITE test failed for LUN. We will emulate the SCSIOP.
10/31 15:15:51.956 e88 Ssc: *** SscScsi_InquiryHandler: INQUIRY VPD page 0xb0 is not supported!
10/31 15:15:51.956 e14 SCSI: SCSIOP_WRITE_SAME test failed for LUN. We will emulate the SCSIOP.
10/31 15:15:52.034 e14 Tgt: iqn.2008-08.com.starwindsoftware:san01-hyp01-srv: device ImageFile8: new LUN 0 mapped to target LUN 6.
10/31 15:15:52.112 e14 Tgt: iqn.2008-08.com.starwindsoftware:san01-hyp01-srv: attached device ImageFile8 (found 1 LUNs).
10/31 15:15:52.252 e14 conf: Target [0x0000000001BC1480] 'iqn.2008-08.com.starwindsoftware:san01-hyp01-srv' has been created, 7 devices attached.
10/31 15:15:52.330 e14 conf: Reaction of type 'eventlog' [0xFFFFFFFF, 0x0C] loaded successfully.
10/31 15:15:52.408 e14 conf: Variable 'DefaultAccessPolicy' is set to 'allow'.
10/31 15:15:52.486 e14 Srv: Update tracker options: UpdatePeriod = 7, UpdateLastRequest = 20121027, UpdateHost = www.starwindsoftware.com, UpdatePage = /updatetracker/index.php, UpdatePort = 80, UpdateCopyId = 4A9E5B3F-CDFF-4D4A-8CFD326EDB238A2C
10/31 15:15:52.564 e14 Srv: Refreshing device list (complete)...
10/31 15:15:52.642 e14 SPTI: '\\?\scsi#disk&ven_adaptec&prod_array#5&448368e&0&040000#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}': 'Adaptec  Array            V1.0': adapter 0, bus 4, target 0, LUN 0; maxTransferLength 262144, alignmentMask 0x0
10/31 15:15:52.720 e14 PerformanceDB: CPerformanceCounter::WriteOperationalData called on uninitialized counter(DB entry: 0000000000000000, Record: 0000000000000000).
10/31 15:15:52.798 e14 PerformanceDB: CPerformanceCounter::Close exiting with error: WriteOperationalData failed.
10/31 15:15:52.876 e14 SPTI: '\\?\scsi#disk&ven_adaptec&prod_array#5&448368e&0&040100#{53f56307-b6bf-11d0-94f2-00a0c91efb8b}': 'Adaptec  Array            V1.0': adapter 0, bus 4, target 1, LUN 0; maxTransferLength 262144, alignmentMask 0x0
10/31 15:15:52.876 e14 PerformanceDB: CPerformanceCounter::WriteOperationalData called on uninitialized counter(DB entry: 0000000000000000, Record: 0000000000000000).
10/31 15:15:52.954 e14 PerformanceDB: CPerformanceCounter::Close exiting with error: WriteOperationalData failed.
10/31 15:15:53.048 e14 SPTI: '\\?\scsi#cdrom&ven_slimtype&prod_dvd_a__ds8a3s#4&3b049e88&0&010100#{53f56308-b6bf-11d0-94f2-00a0c91efb8b}': 'Slimtype DVD A  DS8A3S    HP53': adapter 5, bus 1, target 1, LUN 0; maxTransferLength 131072, alignmentMask 0x1
10/31 15:15:53.126 e14 Srv: Found SPTI device '\\?\scsi#cdrom&ven_slimtype&prod_dvd_a__ds8a3s#4&3b049e88&0&010100#{53f56308-b6bf-11d0-94f2-00a0c91efb8b}': 'Slimtype DVD A  DS8A3S    HP53'
10/31 15:15:53.204 e9c conf: Waiting for Control connections at 0.0.0.0:3261 ...
10/31 15:15:53.204 ea0 bc: Waiting for broadcast UDP packets at 0.0.0.0:3261...
10/31 15:15:53.204 e14 Srv: Waiting for iSCSI connections at 169.254.75.223:3260 ...
10/31 15:15:53.204 e14 Srv: Waiting for iSCSI connections at 192.168.99.1:3260 ...
10/31 15:15:53.204 e14 Srv: Waiting for iSCSI connections at 192.168.98.1:3260 ...
10/31 15:15:53.204 e14 Srv: Waiting for iSCSI connections at 127.0.0.1:3260 ...
10/31 15:16:23.827 e14 Srv: Interface list has been changed. Refreshing...
10/31 15:16:23.827 e14 Srv: Waiting for iSCSI connections at 169.254.75.223:3260 ...
10/31 15:16:23.827 e14 Srv: Waiting for iSCSI connections at 192.168.98.1:3260 ...
10/31 15:16:23.827 e14 Srv: Waiting for iSCSI connections at 127.0.0.1:3260 ...
10/31 15:16:27.275 e14 Srv: Interface list has been changed. Refreshing...
10/31 15:16:27.275 e14 Srv: Waiting for iSCSI connections at 169.254.75.223:3260 ...
10/31 15:16:27.275 e14 Srv: Waiting for iSCSI connections at 192.168.99.1:3260 ...
10/31 15:16:27.275 e14 Srv: Waiting for iSCSI connections at 192.168.98.1:3260 ...
10/31 15:16:27.275 e14 Srv: Waiting for iSCSI connections at 127.0.0.1:3260 ...
10/31 15:19:13.291 e14 Srv: Accepted iSCSI connection from 192.168.99.2:49152 to 192.168.99.1:3260. (Id = 0x1)
10/31 15:19:13.291 e14 C[1], FREE: Event - CONNECTED.
10/31 15:19:13.291 e14 C[1], XPT_UP: T3.
10/31 15:19:13.291 8ac C[1], XPT_UP: Login request: ISID 0x400001370001, TSIH 0x0000.
10/31 15:19:13.291 8ac C[1], XPT_UP: Event - LOGIN.
10/31 15:19:13.291 8ac C[1], IN_LOGIN: T4.
10/31 15:19:13.291 8ac Params: <<< String param 'InitiatorName': received 'iqn.1991-05.com.microsoft:hyp01-srv', accepted 'iqn.1991-05.com.microsoft:hyp01-srv'
10/31 15:19:13.291 8ac Params: <<< Enum param 'SessionType': received 'Normal', accepted 'Normal'
10/31 15:19:13.291 8ac Params: <<< String param 'TargetName': received 'iqn.2008-08.com.starwindsoftware:san01-hyp01-srv', accepted 'iqn.2008-08.com.starwindsoftware:san01-hyp01-srv'
10/31 15:19:13.291 8ac Params: <<< Enum param 'AuthMethod': received 'None', accepted 'None'
10/31 15:19:13.291 8ac Tgt: open 'iqn.2008-08.com.starwindsoftware:san01-hyp01-srv': 1 session(s) opened, 0 more allowed.
10/31 15:19:13.291 8ac Params: <<< Enum param 'AuthMethod': received 'None', accepted 'None'
10/31 15:19:13.291 8ac Params: >>> AuthMethod=None.
10/31 15:19:13.291 8ac Params: >>> TargetAlias=HYP01-SRV.
10/31 15:19:13.291 8ac Params: >>> TargetPortalGroupTag=1.
10/31 15:19:13.291 700 T[1,1]: session 0x1, connection 0x1 : end of stage 0, next stage 1.
10/31 15:19:13.291 8ac Params: <<< Enum param 'HeaderDigest': received 'None,CRC32C', accepted 'None'
10/31 15:19:13.291 8ac Params: <<< Enum param 'DataDigest': received 'None,CRC32C', accepted 'None'
10/31 15:19:13.291 8ac Params: <<< Numeric param 'ErrorRecoveryLevel': received 2, accepted 0
10/31 15:19:13.291 8ac Params: <<< Boolean param 'InitialR2T': received No, accepted 0
10/31 15:19:13.291 8ac Params: <<< Boolean param 'ImmediateData': received Yes, accepted 1
10/31 15:19:13.291 8ac Params: <<< Numeric param 'MaxRecvDataSegmentLength': received 65536, accepted 65536
10/31 15:19:13.291 8ac Params: <<< Numeric param 'MaxBurstLength': received 262144, accepted 262144
10/31 15:19:13.291 8ac Params: <<< Numeric param 'FirstBurstLength': received 65536, accepted 65536
10/31 15:19:13.291 8ac Params: <<< Numeric param 'MaxConnections': received 32, accepted 1
10/31 15:19:13.291 8ac Params: <<< Boolean param 'DataPDUInOrder': received Yes, accepted 1
10/31 15:19:13.291 8ac Params: <<< Boolean param 'DataSequenceInOrder': received Yes, accepted 1
10/31 15:19:13.291 8ac Params: <<< Numeric param 'DefaultTime2Wait': received 0, accepted 0
10/31 15:19:13.291 8ac Params: <<< Numeric param 'DefaultTime2Retain': received 60, accepted 20
10/31 15:19:13.291 8ac Params: <<< Numeric param 'MaxOutstandingR2T': received 16, accepted 1
10/31 15:19:13.291 8ac Params: >>> ErrorRecoveryLevel=0.
10/31 15:19:13.291 8ac Params: >>> MaxConnections=1.
10/31 15:19:13.291 8ac Params: >>> HeaderDigest=None.
10/31 15:19:13.291 8ac Params: >>> DataDigest=None.
10/31 15:19:13.291 8ac Params: >>> InitialR2T=No.
10/31 15:19:13.291 8ac Params: >>> ImmediateData=Yes.
10/31 15:19:13.291 8ac Params: >>> MaxRecvDataSegmentLength=262144.
10/31 15:19:13.291 8ac Params: >>> MaxBurstLength=262144.
10/31 15:19:13.291 8ac Params: >>> FirstBurstLength=65536.
10/31 15:19:13.291 8ac Params: >>> DefaultTime2Wait=0.
10/31 15:19:13.291 8ac Params: >>> DefaultTime2Retain=20.
10/31 15:19:13.291 8ac Params: >>> MaxOutstandingR2T=1.
10/31 15:19:13.291 8ac Params: >>> DataPDUInOrder=Yes.
10/31 15:19:13.291 8ac Params: >>> DataSequenceInOrder=Yes.
10/31 15:19:13.291 700 T[1,1]: session 0x1, connection 0x1 : end of stage 1, next stage 3.
10/31 15:19:13.291 700 C[1], IN_LOGIN: Event - LOGIN_ACCEPT.
10/31 15:19:13.291 700 C[1], LIN: T5.
10/31 15:19:16.754 e14 Srv: Accepted iSCSI connection from 192.168.99.2:49156 to 192.168.99.1:3260. (Id = 0x2)
10/31 15:19:16.754 e14 C[2], FREE: Event - CONNECTED.
10/31 15:19:16.754 e14 C[2], XPT_UP: T3.
10/31 15:19:16.754 c34 C[2], XPT_UP: Login request: ISID 0x400001370000, TSIH 0x0000.
10/31 15:19:16.754 c34 C[2], XPT_UP: Event - LOGIN.
10/31 15:19:16.754 c34 C[2], IN_LOGIN: T4.
10/31 15:19:16.754 c34 Params: <<< String param 'InitiatorName': received 'iqn.1991-05.com.microsoft:hyp01-srv', accepted 'iqn.1991-05.com.microsoft:hyp01-srv'
10/31 15:19:16.754 c34 Params: <<< Enum param 'SessionType': received 'Discovery', accepted 'Discovery'
10/31 15:19:16.754 c34 Params: <<< Enum param 'AuthMethod': received 'None', accepted 'None'
10/31 15:19:16.754 c34 Params: <<< Enum param 'AuthMethod': received 'None', accepted 'None'
10/31 15:19:16.754 c34 Params: >>> AuthMethod=None.
10/31 15:19:16.754 838 T[2,1]: session 0x2, connection 0x2 : end of stage 0, next stage 1.
10/31 15:19:16.754 c34 Params: <<< Enum param 'HeaderDigest': received 'None,CRC32C', accepted 'None'
10/31 15:19:16.754 c34 Params: <<< Enum param 'DataDigest': received 'None,CRC32C', accepted 'None'
10/31 15:19:16.754 c34 Params: <<< Numeric param 'MaxRecvDataSegmentLength': received 65536, accepted 65536
10/31 15:19:16.754 c34 Params: <<< Numeric param 'DefaultTime2Wait': received 0, accepted 0
10/31 15:19:16.754 c34 Params: <<< Numeric param 'DefaultTime2Retain': received 60, accepted 20
10/31 15:19:16.754 c34 Params: >>> HeaderDigest=None.
10/31 15:19:16.754 c34 Params: >>> DataDigest=None.
10/31 15:19:16.754 c34 Params: >>> InitialR2T=No.
10/31 15:19:16.754 c34 Params: >>> ImmediateData=Yes.
10/31 15:19:16.754 c34 Params: >>> MaxRecvDataSegmentLength=262144.
10/31 15:19:16.754 c34 Params: >>> MaxBurstLength=262144.
10/31 15:19:16.754 c34 Params: >>> FirstBurstLength=262144.
10/31 15:19:16.754 c34 Params: >>> DefaultTime2Wait=0.
10/31 15:19:16.754 c34 Params: >>> DefaultTime2Retain=20.
10/31 15:19:16.754 c34 Params: >>> MaxOutstandingR2T=1.
10/31 15:19:16.754 c34 Params: >>> DataPDUInOrder=Yes.
10/31 15:19:16.754 c34 Params: >>> DataSequenceInOrder=Yes.
10/31 15:19:16.754 838 T[2,1]: session 0x2, connection 0x2 : end of stage 1, next stage 3.
10/31 15:19:16.754 838 C[2], IN_LOGIN: Event - LOGIN_ACCEPT.
10/31 15:19:16.754 838 C[2], LIN: T5.
10/31 15:19:16.754 838 C[2], LIN: Event - LOGOUT.
10/31 15:19:16.754 838 C[2], IN_LOGOUT: T9/10.
10/31 15:19:16.754 72c C[2], IN_LOGOUT: Event - LOGOUT_ACCEPT.
10/31 15:19:16.754 72c C[2], FREE: T13.
10/31 15:19:16.754 c34 C[2], FREE: recvData returned 10058
10/31 15:20:04.007 e14 Srv: Interface list has been changed. Refreshing...
10/31 15:20:04.007 e14 Srv: Waiting for iSCSI connections at 169.254.75.223:3260 ...
10/31 15:20:04.007 e14 Srv: Waiting for iSCSI connections at 192.168.98.1:3260 ...
10/31 15:20:04.007 e14 Srv: Waiting for iSCSI connections at 127.0.0.1:3260 ...
10/31 15:20:08.328 8ac C[1], LIN: recvData returned 10054
10/31 15:20:08.328 8ac C[1], LIN: *** 'recv' thread: recv failed 10058.
10/31 15:20:08.328 700 Tgt: close 'iqn.2008-08.com.starwindsoftware:san01-hyp01-srv': 0 session(s) opened, 1 more allowed.
10/31 15:20:08.671 e14 Srv: Interface list has been changed. Refreshing...
10/31 15:20:08.671 e14 Srv: Waiting for iSCSI connections at 169.254.75.223:3260 ...
10/31 15:20:08.671 e14 Srv: Waiting for iSCSI connections at 192.168.99.1:3260 ...
10/31 15:20:08.671 e14 Srv: Waiting for iSCSI connections at 192.168.98.1:3260 ...
10/31 15:20:08.671 e14 Srv: Waiting for iSCSI connections at 127.0.0.1:3260 ...
10/31 15:37:48.105 e14 Srv: Interface list has been changed. Refreshing...
10/31 15:37:48.105 e14 Srv: Waiting for iSCSI connections at 169.254.75.223:3260 ...
10/31 15:37:48.105 e14 Srv: Waiting for iSCSI connections at 192.168.98.1:3260 ...
10/31 15:37:48.105 e14 Srv: Waiting for iSCSI connections at 127.0.0.1:3260 ...
10/31 15:37:52.770 e14 Srv: Interface list has been changed. Refreshing...
10/31 15:37:52.770 e14 Srv: Waiting for iSCSI connections at 169.254.75.223:3260 ...
10/31 15:37:52.770 e14 Srv: Waiting for iSCSI connections at 192.168.99.1:3260 ...
10/31 15:37:52.770 e14 Srv: Waiting for iSCSI connections at 192.168.98.1:3260 ...
10/31 15:37:52.770 e14 Srv: Waiting for iSCSI connections at 127.0.0.1:3260 ...
10/31 15:42:53.524 e14 Srv: Interface list has been changed. Refreshing...
10/31 15:42:53.540 e14 Srv: Waiting for iSCSI connections at 169.254.75.223:3260 ...
10/31 15:42:53.540 e14 Srv: Waiting for iSCSI connections at 192.168.98.1:3260 ...
10/31 15:42:53.540 e14 Srv: Waiting for iSCSI connections at 127.0.0.1:3260 ...
10/31 15:42:57.596 e14 Srv: Interface list has been changed. Refreshing...
10/31 15:42:57.596 e14 Srv: Waiting for iSCSI connections at 169.254.75.223:3260 ...
10/31 15:42:57.596 e14 Srv: Waiting for iSCSI connections at 192.168.99.1:3260 ...
10/31 15:42:57.596 e14 Srv: Waiting for iSCSI connections at 192.168.98.1:3260 ...
10/31 15:42:57.596 e14 Srv: Waiting for iSCSI connections at 127.0.0.1:3260 ...
10/31 16:06:27.673 e14 Srv: Interface list has been changed. Refreshing...
10/31 16:06:27.673 e14 Srv: Waiting for iSCSI connections at 169.254.75.223:3260 ...
10/31 16:06:27.673 e14 Srv: Waiting for iSCSI connections at 192.168.98.1:3260 ...
10/31 16:06:27.673 e14 Srv: Waiting for iSCSI connections at 127.0.0.1:3260 ...
10/31 16:06:32.135 e14 Srv: Interface list has been changed. Refreshing...
10/31 16:06:32.135 e14 Srv: Waiting for iSCSI connections at 169.254.75.223:3260 ...
10/31 16:06:32.135 e14 Srv: Waiting for iSCSI connections at 192.168.99.1:3260 ...
10/31 16:06:32.135 e14 Srv: Waiting for iSCSI connections at 192.168.98.1:3260 ...
10/31 16:06:32.135 e14 Srv: Waiting for iSCSI connections at 127.0.0.1:3260 ...
10/31 16:06:48.764 e14 Srv: Interface list has been changed. Refreshing...
10/31 16:06:48.764 e14 Srv: Waiting for iSCSI connections at 169.254.75.223:3260 ...
10/31 16:06:48.764 e14 Srv: Waiting for iSCSI connections at 192.168.98.1:3260 ...
10/31 16:06:48.764 e14 Srv: Waiting for iSCSI connections at 127.0.0.1:3260 ...
10/31 16:07:01.135 e14 Srv: Interface list has been changed. Refreshing...
10/31 16:07:01.135 e14 Srv: Waiting for iSCSI connections at 169.254.75.223:3260 ...
10/31 16:07:01.135 e14 Srv: Waiting for iSCSI connections at 192.168.99.1:3260 ...
10/31 16:07:01.135 e14 Srv: Waiting for iSCSI connections at 192.168.98.1:3260 ...
10/31 16:07:01.135 e14 Srv: Waiting for iSCSI connections at 127.0.0.1:3260 ...
10/31 16:09:54.967 e14 Srv: Accepted iSCSI connection from 192.168.99.2:49152 to 192.168.99.1:3260. (Id = 0x3)
10/31 16:09:54.967 e14 C[3], FREE: Event - CONNECTED.
10/31 16:09:54.967 e14 C[3], XPT_UP: T3.
10/31 16:09:54.967 f64 C[3], XPT_UP: Login request: ISID 0x400001370001, TSIH 0x0000.
10/31 16:09:54.967 f64 C[3], XPT_UP: Event - LOGIN.
10/31 16:09:54.967 f64 C[3], IN_LOGIN: T4.
10/31 16:09:54.967 f64 Params: <<< String param 'InitiatorName': received 'iqn.1991-05.com.microsoft:hyp01-srv', accepted 'iqn.1991-05.com.microsoft:hyp01-srv'
10/31 16:09:54.967 f64 Params: <<< Enum param 'SessionType': received 'Normal', accepted 'Normal'
10/31 16:09:54.967 f64 Params: <<< String param 'TargetName': received 'iqn.2008-08.com.starwindsoftware:san01-hyp01-srv', accepted 'iqn.2008-08.com.starwindsoftware:san01-hyp01-srv'
10/31 16:09:54.967 f64 Params: <<< Enum param 'AuthMethod': received 'None', accepted 'None'
10/31 16:09:54.967 f64 PR: Reusing old session 0x1 (new 0x3) from iqn.1991-05.com.microsoft:hyp01-srv,400001370001 
10/31 16:09:54.967 f64 PR: Reusing old session 0x1 (new 0x3) from iqn.1991-05.com.microsoft:hyp01-srv,400001370001 
10/31 16:09:54.967 f64 PR: Reusing old session 0x1 (new 0x3) from iqn.1991-05.com.microsoft:hyp01-srv,400001370001 
10/31 16:09:54.967 f64 PR: Reusing old session 0x1 (new 0x3) from iqn.1991-05.com.microsoft:hyp01-srv,400001370001 
10/31 16:09:54.967 f64 PR: Reusing old session 0x1 (new 0x3) from iqn.1991-05.com.microsoft:hyp01-srv,400001370001 
10/31 16:09:54.967 f64 PR: Reusing old session 0x1 (new 0x3) from iqn.1991-05.com.microsoft:hyp01-srv,400001370001 
10/31 16:09:54.967 f64 PR: Reusing old session 0x1 (new 0x3) from iqn.1991-05.com.microsoft:hyp01-srv,400001370001 
10/31 16:09:54.967 f64 Tgt: open 'iqn.2008-08.com.starwindsoftware:san01-hyp01-srv': 1 session(s) opened, 0 more allowed.
10/31 16:09:54.967 f64 Params: <<< Enum param 'AuthMethod': received 'None', accepted 'None'
10/31 16:09:54.967 f64 Params: >>> AuthMethod=None.
10/31 16:09:54.967 f64 Params: >>> TargetAlias=HYP01-SRV.
10/31 16:09:54.967 f64 Params: >>> TargetPortalGroupTag=1.
10/31 16:09:54.967 db8 T[3,1]: session 0x3, connection 0x3 : end of stage 0, next stage 1.
10/31 16:09:54.967 f64 Params: <<< Enum param 'HeaderDigest': received 'None,CRC32C', accepted 'None'
10/31 16:09:54.967 f64 Params: <<< Enum param 'DataDigest': received 'None,CRC32C', accepted 'None'
10/31 16:09:54.967 f64 Params: <<< Numeric param 'ErrorRecoveryLevel': received 2, accepted 0
10/31 16:09:54.967 f64 Params: <<< Boolean param 'InitialR2T': received No, accepted 0
10/31 16:09:54.967 f64 Params: <<< Boolean param 'ImmediateData': received Yes, accepted 1
10/31 16:09:54.967 f64 Params: <<< Numeric param 'MaxRecvDataSegmentLength': received 65536, accepted 65536
10/31 16:09:54.967 f64 Params: <<< Numeric param 'MaxBurstLength': received 262144, accepted 262144
10/31 16:09:54.967 f64 Params: <<< Numeric param 'FirstBurstLength': received 65536, accepted 65536
10/31 16:09:54.967 f64 Params: <<< Numeric param 'MaxConnections': received 32, accepted 1
10/31 16:09:54.967 f64 Params: <<< Boolean param 'DataPDUInOrder': received Yes, accepted 1
10/31 16:09:54.967 f64 Params: <<< Boolean param 'DataSequenceInOrder': received Yes, accepted 1
10/31 16:09:54.967 f64 Params: <<< Numeric param 'DefaultTime2Wait': received 0, accepted 0
10/31 16:09:54.967 f64 Params: <<< Numeric param 'DefaultTime2Retain': received 60, accepted 20
10/31 16:09:54.967 f64 Params: <<< Numeric param 'MaxOutstandingR2T': received 16, accepted 1
10/31 16:09:54.967 f64 Params: >>> ErrorRecoveryLevel=0.
10/31 16:09:54.967 f64 Params: >>> MaxConnections=1.
10/31 16:09:54.967 f64 Params: >>> HeaderDigest=None.
10/31 16:09:54.967 f64 Params: >>> DataDigest=None.
10/31 16:09:54.967 f64 Params: >>> InitialR2T=No.
10/31 16:09:54.967 f64 Params: >>> ImmediateData=Yes.
10/31 16:09:54.967 f64 Params: >>> MaxRecvDataSegmentLength=262144.
10/31 16:09:54.967 f64 Params: >>> MaxBurstLength=262144.
10/31 16:09:54.967 f64 Params: >>> FirstBurstLength=65536.
10/31 16:09:54.967 f64 Params: >>> DefaultTime2Wait=0.
10/31 16:09:54.967 f64 Params: >>> DefaultTime2Retain=20.
10/31 16:09:54.967 f64 Params: >>> MaxOutstandingR2T=1.
10/31 16:09:54.967 f64 Params: >>> DataPDUInOrder=Yes.
10/31 16:09:54.967 f64 Params: >>> DataSequenceInOrder=Yes.
10/31 16:09:54.967 db8 T[3,1]: session 0x3, connection 0x3 : end of stage 1, next stage 3.
10/31 16:09:54.967 db8 C[3], IN_LOGIN: Event - LOGIN_ACCEPT.
10/31 16:09:54.967 db8 C[3], LIN: T5.
10/31 16:09:58.961 e14 Srv: Accepted iSCSI connection from 192.168.99.2:49157 to 192.168.99.1:3260. (Id = 0x4)
10/31 16:09:58.961 e14 C[4], FREE: Event - CONNECTED.
10/31 16:09:58.961 e14 C[4], XPT_UP: T3.
10/31 16:09:58.961 828 C[4], XPT_UP: Login request: ISID 0x400001370000, TSIH 0x0000.
10/31 16:09:58.976 828 C[4], XPT_UP: Event - LOGIN.
10/31 16:09:58.976 828 C[4], IN_LOGIN: T4.
10/31 16:09:58.976 828 Params: <<< String param 'InitiatorName': received 'iqn.1991-05.com.microsoft:hyp01-srv', accepted 'iqn.1991-05.com.microsoft:hyp01-srv'
10/31 16:09:58.976 828 Params: <<< Enum param 'SessionType': received 'Discovery', accepted 'Discovery'
10/31 16:09:58.976 828 Params: <<< Enum param 'AuthMethod': received 'None', accepted 'None'
10/31 16:09:58.976 828 Params: <<< Enum param 'AuthMethod': received 'None', accepted 'None'
10/31 16:09:58.976 828 Params: >>> AuthMethod=None.
10/31 16:09:58.976 f44 T[4,1]: session 0x4, connection 0x4 : end of stage 0, next stage 1.
10/31 16:09:58.976 828 Params: <<< Enum param 'HeaderDigest': received 'None,CRC32C', accepted 'None'
10/31 16:09:58.976 828 Params: <<< Enum param 'DataDigest': received 'None,CRC32C', accepted 'None'
10/31 16:09:58.976 828 Params: <<< Numeric param 'MaxRecvDataSegmentLength': received 65536, accepted 65536
10/31 16:09:58.976 828 Params: <<< Numeric param 'DefaultTime2Wait': received 0, accepted 0
10/31 16:09:58.976 828 Params: <<< Numeric param 'DefaultTime2Retain': received 60, accepted 20
10/31 16:09:58.976 828 Params: >>> HeaderDigest=None.
10/31 16:09:58.976 828 Params: >>> DataDigest=None.
10/31 16:09:58.976 828 Params: >>> InitialR2T=No.
10/31 16:09:58.976 828 Params: >>> ImmediateData=Yes.
10/31 16:09:58.976 828 Params: >>> MaxRecvDataSegmentLength=262144.
10/31 16:09:58.976 828 Params: >>> MaxBurstLength=262144.
10/31 16:09:58.976 828 Params: >>> FirstBurstLength=262144.
10/31 16:09:58.976 828 Params: >>> DefaultTime2Wait=0.
10/31 16:09:58.976 828 Params: >>> DefaultTime2Retain=20.
10/31 16:09:58.976 828 Params: >>> MaxOutstandingR2T=1.
10/31 16:09:58.976 828 Params: >>> DataPDUInOrder=Yes.
10/31 16:09:58.976 828 Params: >>> DataSequenceInOrder=Yes.
10/31 16:09:58.976 f44 T[4,1]: session 0x4, connection 0x4 : end of stage 1, next stage 3.
10/31 16:09:58.976 f44 C[4], IN_LOGIN: Event - LOGIN_ACCEPT.
10/31 16:09:58.976 f44 C[4], LIN: T5.
10/31 16:09:58.976 f44 C[4], LIN: Event - LOGOUT.
10/31 16:09:58.976 f44 C[4], IN_LOGOUT: T9/10.
10/31 16:09:58.976 f90 C[4], IN_LOGOUT: Event - LOGOUT_ACCEPT.
10/31 16:09:58.976 f90 C[4], FREE: T13.
10/31 16:09:58.976 828 C[4], FREE: recvData returned 10058
10/31 16:17:05.452 e14 Srv: Interface list has been changed. Refreshing...
10/31 16:17:05.467 e14 Srv: Waiting for iSCSI connections at 192.168.100.45:3260 ...
10/31 16:17:05.467 e14 Srv: Waiting for iSCSI connections at 192.168.99.1:3260 ...
10/31 16:17:05.467 e14 Srv: Waiting for iSCSI connections at 192.168.98.1:3260 ...
10/31 16:17:05.467 e14 Srv: Waiting for iSCSI connections at 127.0.0.1:3260 ...
10/31 16:17:09.118 e14 Srv: Interface list has been changed. Refreshing...
10/31 16:17:09.118 e14 Srv: Waiting for iSCSI connections at 192.168.100.45:3260 ...
10/31 16:17:09.118 e14 Srv: Waiting for iSCSI connections at 192.168.99.1:3260 ...
10/31 16:17:09.118 e14 Srv: Waiting for iSCSI connections at 192.168.98.1:3260 ...
10/31 16:17:09.118 e14 Srv: Waiting for iSCSI connections at 127.0.0.1:3260 ...
10/31 22:45:14.810 e14 Srv: Interface list has been changed. Refreshing...
10/31 22:45:14.826 e14 Srv: Waiting for iSCSI connections at 192.168.100.45:3260 ...
10/31 22:45:14.826 e14 Srv: Waiting for iSCSI connections at 192.168.99.1:3260 ...
10/31 22:45:14.826 e14 Srv: Waiting for iSCSI connections at 127.0.0.1:3260 ...
10/31 22:45:18.679 e14 Srv: Interface list has been changed. Refreshing...
10/31 22:45:18.679 e14 Srv: Waiting for iSCSI connections at 192.168.100.45:3260 ...
10/31 22:45:18.679 e14 Srv: Waiting for iSCSI connections at 192.168.99.1:3260 ...
10/31 22:45:18.679 e14 Srv: Waiting for iSCSI connections at 192.168.98.1:3260 ...
10/31 22:45:18.679 e14 Srv: Waiting for iSCSI connections at 127.0.0.1:3260 ...
11/6 21:40:59.648 edc C[3], LIN: ** ExpCmdSN >= MaxCmdSN (29244755 >= 29244755), no tasks (63 active) in 'recv' or 'exec' state, ping...
11/6 21:41:55.636 edc C[3], LIN: ** ExpCmdSN >= MaxCmdSN (29270461 >= 29270461), no tasks (63 active) in 'recv' or 'exec' state, ping...
11/7 10:04:27.400 edc C[3], LIN: ** ExpCmdSN >= MaxCmdSN (35326164 >= 35326164), no tasks (63 active) in 'recv' or 'exec' state, ping...
11/8 22:59:23.264 f64 C[3], LIN: recvData returned 10054
11/8 22:59:23.264 f64 C[3], LIN: *** 'recv' thread: recv failed 10058.
11/8 22:59:23.264 db8 Tgt: close 'iqn.2008-08.com.starwindsoftware:san01-hyp01-srv': 0 session(s) opened, 1 more allowed.
11/8 22:59:29.410 e14 Srv: Accepted iSCSI connection from 192.168.99.2:63293 to 192.168.99.1:3260. (Id = 0x5)
11/8 22:59:29.410 e14 C[5], FREE: Event - CONNECTED.
11/8 22:59:29.410 e14 C[5], XPT_UP: T3.
11/8 22:59:29.410 dc0 C[5], XPT_UP: Login request: ISID 0x400001370001, TSIH 0x0000.
11/8 22:59:29.426 dc0 C[5], XPT_UP: Event - LOGIN.
11/8 22:59:29.426 dc0 C[5], IN_LOGIN: T4.
11/8 22:59:29.426 dc0 Params: <<< String param 'InitiatorName': received 'iqn.1991-05.com.microsoft:hyp01-srv', accepted 'iqn.1991-05.com.microsoft:hyp01-srv'
11/8 22:59:29.426 dc0 Params: <<< Enum param 'SessionType': received 'Normal', accepted 'Normal'
11/8 22:59:29.426 dc0 Params: <<< String param 'TargetName': received 'iqn.2008-08.com.starwindsoftware:san01-hyp01-srv', accepted 'iqn.2008-08.com.starwindsoftware:san01-hyp01-srv'
11/8 22:59:29.426 dc0 Params: <<< Enum param 'AuthMethod': received 'None', accepted 'None'
11/8 22:59:29.426 dc0 PR: Reusing old session 0x3 (new 0x5) from iqn.1991-05.com.microsoft:hyp01-srv,400001370001 
11/8 22:59:29.426 dc0 PR: Reusing old session 0x3 (new 0x5) from iqn.1991-05.com.microsoft:hyp01-srv,400001370001 
11/8 22:59:29.426 dc0 PR: Reusing old session 0x3 (new 0x5) from iqn.1991-05.com.microsoft:hyp01-srv,400001370001 
11/8 22:59:29.426 dc0 PR: Reusing old session 0x3 (new 0x5) from iqn.1991-05.com.microsoft:hyp01-srv,400001370001 
11/8 22:59:29.426 dc0 PR: Reusing old session 0x3 (new 0x5) from iqn.1991-05.com.microsoft:hyp01-srv,400001370001 
11/8 22:59:29.426 dc0 PR: Reusing old session 0x3 (new 0x5) from iqn.1991-05.com.microsoft:hyp01-srv,400001370001 
11/8 22:59:29.426 dc0 PR: Reusing old session 0x3 (new 0x5) from iqn.1991-05.com.microsoft:hyp01-srv,400001370001 
11/8 22:59:29.426 dc0 Tgt: open 'iqn.2008-08.com.starwindsoftware:san01-hyp01-srv': 1 session(s) opened, 0 more allowed.
11/8 22:59:29.426 dc0 Params: <<< Enum param 'AuthMethod': received 'None', accepted 'None'
11/8 22:59:29.426 dc0 Params: >>> AuthMethod=None.
11/8 22:59:29.426 dc0 Params: >>> TargetAlias=HYP01-SRV.
11/8 22:59:29.426 dc0 Params: >>> TargetPortalGroupTag=1.
11/8 22:59:29.426 f34 T[5,1]: session 0x5, connection 0x5 : end of stage 0, next stage 1.
11/8 22:59:29.426 dc0 Params: <<< Enum param 'HeaderDigest': received 'None,CRC32C', accepted 'None'
11/8 22:59:29.426 dc0 Params: <<< Enum param 'DataDigest': received 'None,CRC32C', accepted 'None'
11/8 22:59:29.426 dc0 Params: <<< Numeric param 'ErrorRecoveryLevel': received 2, accepted 0
11/8 22:59:29.426 dc0 Params: <<< Boolean param 'InitialR2T': received No, accepted 0
11/8 22:59:29.426 dc0 Params: <<< Boolean param 'ImmediateData': received Yes, accepted 1
11/8 22:59:29.426 dc0 Params: <<< Numeric param 'MaxRecvDataSegmentLength': received 65536, accepted 65536
11/8 22:59:29.426 dc0 Params: <<< Numeric param 'MaxBurstLength': received 262144, accepted 262144
11/8 22:59:29.426 dc0 Params: <<< Numeric param 'FirstBurstLength': received 65536, accepted 65536
11/8 22:59:29.426 dc0 Params: <<< Numeric param 'MaxConnections': received 32, accepted 1
11/8 22:59:29.426 dc0 Params: <<< Boolean param 'DataPDUInOrder': received Yes, accepted 1
11/8 22:59:29.426 dc0 Params: <<< Boolean param 'DataSequenceInOrder': received Yes, accepted 1
11/8 22:59:29.426 dc0 Params: <<< Numeric param 'DefaultTime2Wait': received 0, accepted 0
11/8 22:59:29.426 dc0 Params: <<< Numeric param 'DefaultTime2Retain': received 60, accepted 20
11/8 22:59:29.426 dc0 Params: <<< Numeric param 'MaxOutstandingR2T': received 16, accepted 1
11/8 22:59:29.426 dc0 Params: >>> ErrorRecoveryLevel=0.
11/8 22:59:29.426 dc0 Params: >>> MaxConnections=1.
11/8 22:59:29.426 dc0 Params: >>> HeaderDigest=None.
11/8 22:59:29.426 dc0 Params: >>> DataDigest=None.
11/8 22:59:29.426 dc0 Params: >>> InitialR2T=No.
11/8 22:59:29.426 dc0 Params: >>> ImmediateData=Yes.
11/8 22:59:29.426 dc0 Params: >>> MaxRecvDataSegmentLength=262144.
11/8 22:59:29.426 dc0 Params: >>> MaxBurstLength=262144.
11/8 22:59:29.426 dc0 Params: >>> FirstBurstLength=65536.
11/8 22:59:29.426 dc0 Params: >>> DefaultTime2Wait=0.
11/8 22:59:29.426 dc0 Params: >>> DefaultTime2Retain=20.
11/8 22:59:29.426 dc0 Params: >>> MaxOutstandingR2T=1.
11/8 22:59:29.426 dc0 Params: >>> DataPDUInOrder=Yes.
11/8 22:59:29.426 dc0 Params: >>> DataSequenceInOrder=Yes.
11/8 22:59:29.426 f34 T[5,1]: session 0x5, connection 0x5 : end of stage 1, next stage 3.
11/8 22:59:29.426 f34 C[5], IN_LOGIN: Event - LOGIN_ACCEPT.
11/8 22:59:29.426 f34 C[5], LIN: T5.
11/17 13:27:05.815 e14 Srv: Interface list has been changed. Refreshing...
11/17 13:27:05.815 e14 Srv: Waiting for iSCSI connections at 192.168.100.45:3260 ...
11/17 13:27:05.815 e14 Srv: Waiting for iSCSI connections at 192.168.98.1:3260 ...
11/17 13:27:05.815 e14 Srv: Waiting for iSCSI connections at 127.0.0.1:3260 ...
11/17 13:27:10.167 dc0 C[5], LIN: recvData returned 10054
11/17 13:27:10.167 dc0 C[5], LIN: *** 'recv' thread: recv failed 10058.
11/17 13:27:10.167 f34 Tgt: close 'iqn.2008-08.com.starwindsoftware:san01-hyp01-srv': 0 session(s) opened, 1 more allowed.
11/17 13:27:19.122 e10 ntsrv: *** SERVICE_CONTROL_PRESHUTDOWN signal. ***
11/17 13:27:19.200 e14 Srv: iSCSI listener stopped.
11/17 13:27:19.200 e9c conf: Stop listening to control connections.
11/17 13:27:19.200 ea0 bc: Socket error: 10004
11/17 13:27:19.200 ea0 bc: Stop listening to UDP packets.
11/17 13:27:19.200 e14 Srv: Shutting down...
11/17 13:27:19.200 e14 Tgt: iqn.2008-08.com.starwindsoftware:san01-hyp01-srv: device 'ImageFile2' is detached.
11/17 13:27:19.200 e14 PR: Set Unit attention 0x3f/0xe for session 0x5 from iqn.1991-05.com.microsoft:hyp01-srv,400001370001.
11/17 13:27:19.200 e14 PR: Set Unit attention 0x3f/0xe for session 0x5 from iqn.1991-05.com.microsoft:hyp01-srv,400001370001.
11/17 13:27:19.200 e14 PR: Set Unit attention 0x3f/0xe for session 0x5 from iqn.1991-05.com.microsoft:hyp01-srv,400001370001.
11/17 13:27:19.200 e14 PR: Set Unit attention 0x3f/0xe for session 0x5 from iqn.1991-05.com.microsoft:hyp01-srv,400001370001.
11/17 13:27:19.200 e14 PR: Set Unit attention 0x3f/0xe for session 0x5 from iqn.1991-05.com.microsoft:hyp01-srv,400001370001.
11/17 13:27:19.200 e14 PR: Set Unit attention 0x3f/0xe for session 0x5 from iqn.1991-05.com.microsoft:hyp01-srv,400001370001.
11/17 13:27:19.200 e14 Tgt: iqn.2008-08.com.starwindsoftware:san01-hyp01-srv: device 'ImageFile3' is detached.
11/17 13:27:19.200 e14 PR: Set Unit attention 0x3f/0xe for session 0x5 from iqn.1991-05.com.microsoft:hyp01-srv,400001370001.
11/17 13:27:19.200 e14 PR: Set Unit attention 0x3f/0xe for session 0x5 from iqn.1991-05.com.microsoft:hyp01-srv,400001370001.
11/17 13:27:19.200 e14 PR: Set Unit attention 0x3f/0xe for session 0x5 from iqn.1991-05.com.microsoft:hyp01-srv,400001370001.
11/17 13:27:19.200 e14 PR: Set Unit attention 0x3f/0xe for session 0x5 from iqn.1991-05.com.microsoft:hyp01-srv,400001370001.
11/17 13:27:19.200 e14 PR: Set Unit attention 0x3f/0xe for session 0x5 from iqn.1991-05.com.microsoft:hyp01-srv,400001370001.
11/17 13:27:19.200 e14 Tgt: iqn.2008-08.com.starwindsoftware:san01-hyp01-srv: device 'ImageFile4' is detached.
11/17 13:27:19.200 e14 PR: Set Unit attention 0x3f/0xe for session 0x5 from iqn.1991-05.com.microsoft:hyp01-srv,400001370001.
11/17 13:27:19.200 e14 PR: Set Unit attention 0x3f/0xe for session 0x5 from iqn.1991-05.com.microsoft:hyp01-srv,400001370001.
11/17 13:27:19.200 e14 PR: Set Unit attention 0x3f/0xe for session 0x5 from iqn.1991-05.com.microsoft:hyp01-srv,400001370001.
11/17 13:27:19.200 e14 PR: Set Unit attention 0x3f/0xe for session 0x5 from iqn.1991-05.com.microsoft:hyp01-srv,400001370001.
11/17 13:27:19.200 e14 Tgt: iqn.2008-08.com.starwindsoftware:san01-hyp01-srv: device 'ImageFile5' is detached.
11/17 13:27:19.200 e14 PR: Set Unit attention 0x3f/0xe for session 0x5 from iqn.1991-05.com.microsoft:hyp01-srv,400001370001.
11/17 13:27:19.200 e14 PR: Set Unit attention 0x3f/0xe for session 0x5 from iqn.1991-05.com.microsoft:hyp01-srv,400001370001.
11/17 13:27:19.200 e14 PR: Set Unit attention 0x3f/0xe for session 0x5 from iqn.1991-05.com.microsoft:hyp01-srv,400001370001.
11/17 13:27:19.200 e14 Tgt: iqn.2008-08.com.starwindsoftware:san01-hyp01-srv: device 'ImageFile6' is detached.
11/17 13:27:19.200 e14 PR: Set Unit attention 0x3f/0xe for session 0x5 from iqn.1991-05.com.microsoft:hyp01-srv,400001370001.
11/17 13:27:19.200 e14 PR: Set Unit attention 0x3f/0xe for session 0x5 from iqn.1991-05.com.microsoft:hyp01-srv,400001370001.
11/17 13:27:19.200 e14 Tgt: iqn.2008-08.com.starwindsoftware:san01-hyp01-srv: device 'ImageFile7' is detached.
11/17 13:27:19.200 e14 PR: Set Unit attention 0x3f/0xe for session 0x5 from iqn.1991-05.com.microsoft:hyp01-srv,400001370001.
11/17 13:27:19.200 e14 Tgt: iqn.2008-08.com.starwindsoftware:san01-hyp01-srv: device 'ImageFile8' is detached.
11/17 13:27:19.200 e14 error: assertion failed: c:\_starwind\_v5\starwind\service\common\fn_common.cpp:28 (isEmpty())
11/17 13:27:19.200 e14 PerformanceDB: CPerformanceCounter::WriteOperationalData called on uninitialized counter(DB entry: 0000000000000000, Record: 0000000000000000).
11/17 13:27:19.200 e14 PerformanceDB: CPerformanceCounter::Close exiting with error: WriteOperationalData failed.
11/17 13:27:19.200 e14 error: assertion failed: c:\_starwind\_v5\starwind\service\common\fn_common.cpp:28 (isEmpty())
11/17 13:27:19.200 e14 Srv: Waiting for 5 seconds for SSC devices to close...
11/17 13:27:19.200 f04 SCSI: ImageFile2: releasing stop guard
11/17 13:27:19.200 f04 error: assertion failed: c:\_starwind\_v5\starwind\service\common\fn_common.cpp:28 (isEmpty())
11/17 13:27:19.200 f60 SCSI: ImageFile3: releasing stop guard
11/17 13:27:19.200 f60 error: assertion failed: c:\_starwind\_v5\starwind\service\common\fn_common.cpp:28 (isEmpty())
11/17 13:27:19.590 3dc SCSI: ImageFile4: releasing stop guard
11/17 13:27:19.590 3dc error: assertion failed: c:\_starwind\_v5\starwind\service\common\fn_common.cpp:28 (isEmpty())
11/17 13:27:19.839 414 SCSI: ImageFile5: releasing stop guard
11/17 13:27:19.839 414 error: assertion failed: c:\_starwind\_v5\starwind\service\common\fn_common.cpp:28 (isEmpty())
11/17 13:27:19.949 f04 SCSI: ImageFile6: releasing stop guard
11/17 13:27:19.949 f04 error: assertion failed: c:\_starwind\_v5\starwind\service\common\fn_common.cpp:28 (isEmpty())
11/17 13:27:20.167 41c SCSI: ImageFile7: releasing stop guard
11/17 13:27:20.167 41c error: assertion failed: c:\_starwind\_v5\starwind\service\common\fn_common.cpp:28 (isEmpty())
11/17 13:27:20.323 71c SCSI: ImageFile8: releasing stop guard
11/17 13:27:20.323 71c error: assertion failed: c:\_starwind\_v5\starwind\service\common\fn_common.cpp:28 (isEmpty())
11/17 13:27:20.323 e14 Srv: All devices closed.
11/17 13:27:20.339 e14 EventDB: Closing data file
11/17 13:27:20.339 e14 EventDB: Closing strings file
11/17 13:27:20.339 e14 EventDB: Closing data file
11/17 13:27:20.339 e14 EventDB: Closing strings file
11/17 13:27:20.339 e14 EventDB: Closing data file
11/17 13:27:20.339 e14 EventDB: Closing strings file
11/17 13:27:20.339 e14 EventDB: Closing data file
11/17 13:27:20.339 e14 EventDB: Closing strings file
11/17 13:27:20.339 e14 EventDB: Closing data file
11/17 13:27:20.339 e14 EventDB: Closing strings file
11/17 13:27:20.385 e14 Srv: Shutdown completed.
