Build 12166 Add-HADevice w/ 4096 sector size

Software-based VM-centric and flash-friendly VM storage + free version

Moderators: anton (staff), art (staff), Max (staff), Anatoly (staff)

Post Reply
zxu
Posts: 8
Joined: Fri Aug 18, 2017 1:47 pm

Sun Jul 08, 2018 3:03 am

After upgrading to build 12166, using PowerShell to create HA device fails with the provided sample script. The server is Windows 2016 with 4k native backend storage.

Code: Select all

	$server = New-SWServer -host 172.17.62.11 -port 3261 -user root -password starwind

	$server.Connect()

	$firstNode = new-Object Node

	$firstNode.HostName = "172.17.62.11"
	$firstNode.ImagePath = "My computer\D\temp"
	$firstNode.ImageName = "masterImg21"
	$firstNode.Size = 12
	$firstNode.CreateImage = $true
	$firstNode.TargetAlias = "targetha21"
	$firstNode.AutoSynch = $true
	$firstNode.SyncInterface = "#p2=192.168.39.12:3260"
	$firstNode.HBInterface = "#p2=172.17.62.12:3260"
	$firstNode.PoolName = "default_pool"
	$firstNode.SyncSessionCount = 1
	$firstNode.ALUAOptimized = $true
    
	#
	# device sector size. Possible values: 512 or 4096(May be incompatible with some clients!) bytes. 
	#
	$firstNode.SectorSize = 4096
	
	#
	# 'SerialID' should be between 16 and 31 symbols. If it not specified StarWind Service will generate it. 
	# Note: Second node always has the same serial ID. You do not need to specify it for second node
	#
	$firstNode.SerialID = "4f30384e672654a2fbe5dc19c269be"
    
	$secondNode = new-Object Node

	$secondNode.HostName = "172.17.62.12"
	$secondNode.HostPort = "3261"
	$secondNode.Login = "root"
	$secondNode.Password = "starwind"
	$secondNode.ImagePath = "My computer\D\temp"
	$secondNode.ImageName = "partnerImg22"
	$secondNode.Size = 12
	$secondNode.CreateImage = $true
	$secondNode.TargetAlias = "partnerha22"
	$secondNode.AutoSynch = $true
	$secondNode.SyncInterface = "#p1=192.168.39.11:3260"
	$secondNode.HBInterface = "#p1=172.17.62.11:3260"
	$secondNode.SyncSessionCount = 1
	$secondNode.ALUAOptimized = $true
        
	$device = Add-HADevice -server $server -firstNode $firstNode -secondNode $secondNode -initMethod "Clear"
The device creation on the first node seem to complete with some error/warning.

Code: Select all

7/7 22:25:10.817 2188 IMG: ImageFile_CreateRawFile: File 'D:\temp\masterImg21.img', size: 12 MB, flags 0x240...
7/7 22:25:10.817 2188 IMG: ImageFile_CreateRawFile: Using SetFileValidData...
7/7 22:25:10.817 2188 IMG: ImageFile_CreateRawFile: Zero out only the first and the last 1MB of the image.
7/7 22:25:10.817 2188 IMG: ImageFile_CreateRawFile: WARNING: This can damage security if the file image is exported directly to untrusted clients!
7/7 22:25:10.848 2188 IMG: ImageFile_CreateRawFile: File 'D:\temp\masterImg21.img' created. Total elapsed time = 0 sec.
7/7 22:25:10.880 2188 Common: *** sw_common::Sw_Disk_Header::create: (file: D:\temp\masterImg21.swdsk, cached: no).
7/7 22:25:10.880 2188 Common: *** sw_common::Sw_Disk_Header::create: creation parameters:
		- device name: (null);
		- plugin name: imagefile;
		- storage path: My computer\D\temp\masterImg21.img;
		- device LUN: 0;
		- device size: 12;
		- storage offset: 0;
		- serial Id: (null);
		- EUI-64: (null);
		- vendor id: STARWIND;
		- product id: STARWIND        ;
		- revision level: 0001.
	L1 cache parameters:
		- mode: none;
		- size: 64;
		- flags: 0;
		- expiration time: 0;
		- high watermark: 0;
		- low watermark: 0.
	L2 cache parameters:
		- mode: (null);
		- storage: (null);
		- size: 0;
		- flags: 0;
		- expiration time: 0;
		- high watermark: 0;
		- low watermark: 0.
7/7 22:25:10.880 2188 Common: *** sw_common::Sw_XML_Storage_Impl::str2type: The "(null)" type is not supported.
7/7 22:25:10.880 2188 Common: *** sw_common::Sw_XML_Storage_Impl::str2type: The "(null)" type is not supported.
7/7 22:25:10.927 2188 Common: sw_common::Sw_Disk_Header::open: (file: D:\temp\masterImg21.swdsk, readonly: no).
7/7 22:25:10.942 1044 SCSI: : parameter 'DeviceHeaderPath', value 'My computer\D\temp\masterImg21.swdsk'.
7/7 22:25:10.942 1044 SCSI: : parameter 'file', value 'My computer\D\temp\masterImg21.swdsk'.
7/7 22:25:10.942 1044 IMG: SscPort_Create: Parsing parameters from control connection: 
7/7 22:25:10.942 1044 IMG: SscPort_Create: Header path parsed to 'D:\temp\masterImg21.swdsk'.
7/7 22:25:10.942 1044 IMG: addParameter: Parameter processed (add): DeviceHeaderPathPhysical = "D:\temp\masterImg21.swdsk"
7/7 22:25:10.942 1044 IMG: addParameter: Parameter processed (add): file = "My computer\D\temp\masterImg21.swdsk"
7/7 22:25:10.942 1044 Common: sw_common::Sw_Disk_Header::open: (file: D:\temp\masterImg21.swdsk, readonly: no).
7/7 22:25:10.942 1044 IMG: SscPort_Create: Parsing the Device Header File 'D:\temp\masterImg21.swdsk':
7/7 22:25:10.942 1044 IMG: addParameter: Parameter processed (update): file = "My computer\D\temp\masterImg21.swdsk" -> "My computer\D\temp\masterImg21.img"
7/7 22:25:10.942 1044 IMG: addParameter: Parameter processed (add): SectorSize = "4096"
7/7 22:25:10.942 1044 IMG: addParameter: Parameter processed (add): SerialId = "1F013877895289EA"
7/7 22:25:10.942 1044 IMG: addParameter: Parameter processed (add): eui64 = "1F013877895289EA"
7/7 22:25:10.942 1044 IMG: addParameter: Parameter processed (update): SerialId = "1F013877895289EA" -> "1F013877895289EA"
7/7 22:25:10.942 1044 IMG: addParameter: Parameter processed (update): eui64 = "1F013877895289EA" -> "1F013877895289EA"
7/7 22:25:10.942 1044 IMG: SscPort_Create: Opening device 'imagefile9', image file 'My computer\D\temp\masterImg21.img', buffering=0, async=1, readonly=0.
7/7 22:25:10.942 1044 IMG: ImageFile_Create: 'D:\temp\masterImg21.img': type 0, geometry: sct 16, trks 32, cyl 6, TotalSectors: 3072, SectorSize: 4096, PhySectorSize: 4096
7/7 22:25:10.942 1044 IMG: ImageFile_Create: VendorId 'STARWIND', ProductId 'STARWIND        ', Revision '0001', Serial '1F013877895289EA'
7/7 22:25:10.942 1044 IMG: ImageFile_Create: 'D:\temp\masterImg21.img': disk is HDD, UNMAP not supported.
7/7 22:25:10.942 1044 SCSI: iScsiDevice::updateDeviceIds: EUI64 retrieved: 1F013877895289EA (hex)
7/7 22:25:10.942 1044 SCSI: iScsiDevice::updateDeviceIds: SerialID retrieved: 1F013877895289EA
7/7 22:25:10.942 1044 SCSI: iScsiDevice::updateDiskSize: Disk 'imagefile9' (12 MB)
7/7 22:25:10.942 2188 conf: ConfCommand::processNew: Device [0x000001DAB074ADC0] 'imagefile9' has been created.
The device serial ID configured in the script seems to be completely ignored by the host. The log indicated Sw_Disk_Header::Create did not get serial id and it failed to convert a string parameter to certain type enumeration (sw_common::Sw_XML_Storage_Impl::str2type: The "(null)" type is not supported.).

The generated image device header has the following. The sector size seems to be correctly set to 4096 per the script.

Code: Select all

<?xml version="1.0" encoding="UTF-8"?>
<header signature="StarWind" version="1.0">
  <device active="true" plugin="imagefile" name="imagefile">
    <storages>
      <storage id="1" type="device" name="imagefile" lun="0x0">
        <interval size="12" units="MB"/>
        <inquiry>
          <serial_id>1F013877895289EA</serial_id>
          <vendor id="STARWIND"/>
          <product id="STARWIND        " revision="0001"/>
          <eui_64>1F013877895289EA</eui_64>
        </inquiry>
        <geometry>
          <sector size="4096" psize="4096"/>
          <track sectors="16"/>
          <cylinder tracks="32" count="6"/>
        </geometry>
      </storage>
    </storages>
  </device>
  <system>
    <resources>
      <storages>
        <storage id="1" name="My computer\D\temp\masterImg21.img" type="file">
          <interval size="12" units="MB"/>
        </storage>
      </storages>
      <network/>
    </resources>
  </system>
  <node id="1" name="imagefile" shut="false" active="true">
    <storages>
      <storage_ref id="1"/>
    </storages>
  </node>
</header>
The image device creation on the secondary node completely fails. In addition to "sw_common::Sw_XML_Storage_Impl::str2type: The "(null)" type is not supported." error, we have an interesting error "Incompatible logical volume sector size (4096 > 512)!". It appears the sector size 4096 is completely ignored in creating the image file on the secondary node.

Code: Select all

7/7 22:25:09.859 2d34 conf: TelnetListener::listenConnections: Accepted control connection from 172.17.64.3:60044.
7/7 22:25:10.372 1914 IMG: ImageFile_CreateRawFile: File 'D:\temp\partnerImg22.img', size: 12 MB, flags 0x240...
7/7 22:25:10.373 1914 IMG: ImageFile_CreateRawFile: Using SetFileValidData...
7/7 22:25:10.373 1914 IMG: ImageFile_CreateRawFile: Zero out only the first and the last 1MB of the image.
7/7 22:25:10.373 1914 IMG: ImageFile_CreateRawFile: WARNING: This can damage security if the file image is exported directly to untrusted clients!
7/7 22:25:10.391 1914 IMG: ImageFile_CreateRawFile: File 'D:\temp\partnerImg22.img' created. Total elapsed time = 0 sec.
7/7 22:25:10.425 1914 Common: *** sw_common::Sw_Disk_Header::create: (file: D:\temp\partnerImg22.swdsk, cached: no).
7/7 22:25:10.425 1914 Common: *** sw_common::Sw_Disk_Header::create: creation parameters:
		- device name: (null);
		- plugin name: imagefile;
		- storage path: My computer\D\temp\partnerImg22.img;
		- device LUN: 0;
		- device size: 12;
		- storage offset: 0;
		- serial Id: (null);
		- EUI-64: (null);
		- vendor id: STARWIND;
		- product id: STARWIND        ;
		- revision level: 0001.
	L1 cache parameters:
		- mode: none;
		- size: 64;
		- flags: 0;
		- expiration time: 0;
		- high watermark: 0;
		- low watermark: 0.
	L2 cache parameters:
		- mode: (null);
		- storage: (null);
		- size: 0;
		- flags: 0;
		- expiration time: 0;
		- high watermark: 0;
		- low watermark: 0.
7/7 22:25:10.425 1914 Common: *** sw_common::Sw_XML_Storage_Impl::str2type: The "(null)" type is not supported.
7/7 22:25:10.425 1914 Common: *** sw_common::Sw_XML_Storage_Impl::str2type: The "(null)" type is not supported.
7/7 22:25:10.461 1914 Common: sw_common::Sw_Disk_Header::open: (file: D:\temp\partnerImg22.swdsk, readonly: no).
7/7 22:25:10.462 1d1c SCSI: : parameter 'DeviceHeaderPath', value 'My computer\D\temp\partnerImg22.swdsk'.
7/7 22:25:10.462 1d1c SCSI: : parameter 'file', value 'My computer\D\temp\partnerImg22.swdsk'.
7/7 22:25:10.462 1d1c IMG: SscPort_Create: Parsing parameters from control connection: 
7/7 22:25:10.462 1d1c IMG: SscPort_Create: Header path parsed to 'D:\temp\partnerImg22.swdsk'.
7/7 22:25:10.462 1d1c IMG: addParameter: Parameter processed (add): DeviceHeaderPathPhysical = "D:\temp\partnerImg22.swdsk"
7/7 22:25:10.462 1d1c IMG: addParameter: Parameter processed (add): file = "My computer\D\temp\partnerImg22.swdsk"
7/7 22:25:10.462 1d1c Common: sw_common::Sw_Disk_Header::open: (file: D:\temp\partnerImg22.swdsk, readonly: no).
7/7 22:25:10.462 1d1c IMG: SscPort_Create: Parsing the Device Header File 'D:\temp\partnerImg22.swdsk':
7/7 22:25:10.463 1d1c IMG: addParameter: Parameter processed (update): file = "My computer\D\temp\partnerImg22.swdsk" -> "My computer\D\temp\partnerImg22.img"
7/7 22:25:10.463 1d1c IMG: addParameter: Parameter processed (add): SerialId = "FF56059158C0D5D3"
7/7 22:25:10.463 1d1c IMG: addParameter: Parameter processed (add): eui64 = "FF56059158C0D5D3"
7/7 22:25:10.463 1d1c IMG: addParameter: Parameter processed (update): SerialId = "FF56059158C0D5D3" -> "FF56059158C0D5D3"
7/7 22:25:10.463 1d1c IMG: addParameter: Parameter processed (update): eui64 = "FF56059158C0D5D3" -> "FF56059158C0D5D3"
7/7 22:25:10.463 1d1c IMG: SscPort_Create: Opening device 'imagefile9', image file 'My computer\D\temp\partnerImg22.img', buffering=0, async=1, readonly=0.
7/7 22:25:10.463 1d1c IMG: *** ImageFile_BuildInquiry: D:\temp\partnerImg22.img: Incompatible logical volume sector size (4096 > 512)!
7/7 22:25:10.464 1d1c IMG: *** SscPort_Create: Create('My computer\D\temp\partnerImg22.img') error (0xc000000d)!
7/7 22:25:10.464 1d1c SCSI: *** iScsiSscDevice::open: Failed to create 'imagefile9' device.
7/7 22:25:10.464 1d1c Srv: iScsiServer::deviceOpen: Device 'imagefile9' - open failed!
7/7 22:25:10.465 1914 conf: ConfCommand::processNew: Device [0x000001E2B07F9E40] 'imagefile9' has been created.
7/7 22:25:10.575 1914 HA: SscPort_ControlRequest: Received create header command
7/7 22:25:10.575 1914 HA: *** HAUtility::create_header: parameter 'CreateHeader', value ''.
7/7 22:25:10.575 1914 HA: *** HAUtility::create_header: parameter 'DeviceHeaderPath', value 'My computer\D\temp\partnerImg22_HA.swdsk'.
7/7 22:25:10.575 1914 HA: *** HAUtility::create_header: parameter 'Type', value 'ImageFile_HA'.
7/7 22:25:10.575 1914 HA: *** HAUtility::create_header: parameter 'file', value 'imagefile9'.
7/7 22:25:10.575 1914 HA: *** HAUtility::create_header: parameter 'size', value '12'.
7/7 22:25:10.575 1914 HA: *** HAUtility::create_header: parameter 'Priority', value '#p0=1;#p1=0'.
7/7 22:25:10.575 1914 HA: *** HAUtility::create_header: parameter 'nodeType', value '#p0=1;#p1=1'.
7/7 22:25:10.575 1914 HA: *** HAUtility::create_header: parameter 'PartnerTargetName', value '#p1=iqn.2008-08.com.starwindsoftware:172.17.62.11-targetha21'.
7/7 22:25:10.575 1914 HA: *** HAUtility::create_header: parameter 'PartnerIP', value '#p1=192.168.39.11:sync:3260:1,172.17.62.11:heartbeat:3260:1'.
7/7 22:25:10.575 1914 HA: *** HAUtility::create_header: parameter 'IsAutoSynchEnabled', value '1'.
7/7 22:25:10.575 1914 HA: *** HAUtility::create_header: parameter 'AuthChapLogin', value '#p1=0b'.
7/7 22:25:10.575 1914 HA: *** HAUtility::create_header: parameter 'AuthChapPassword', value '#p1=0b'.
7/7 22:25:10.575 1914 HA: *** HAUtility::create_header: parameter 'AuthMChapName', value '#p1=0b'.
7/7 22:25:10.575 1914 HA: *** HAUtility::create_header: parameter 'AuthMChapSecret', value '#p1=0b'.
7/7 22:25:10.575 1914 HA: *** HAUtility::create_header: parameter 'AuthChapType', value '#p1=none'.
7/7 22:25:10.575 1914 HA: *** HAUtility::create_header: parameter 'Offset', value '0'.
7/7 22:25:10.575 1914 HA: *** HAUtility::create_header: parameter 'CacheMode', value 'none'.
7/7 22:25:10.575 1914 HA: *** HAUtility::create_header: parameter 'CacheSizeMB', value '64'.
7/7 22:25:10.575 1914 HA: *** HAUtility::create_header: parameter 'Replicator', value '#p0=0'.
7/7 22:25:10.575 1914 HA: *** HAUtility::create_header: parameter 'plugin', value 'HAImage'.
7/7 22:25:10.575 1914 Common: *** sw_common::Sw_Disk_Header::create: (file: D:\temp\partnerImg22_HA.swdsk, cached: yes).
7/7 22:25:10.576 1914 Common: *** sw_common::Sw_Disk_Header::create: creation parameters:
		- device name: (null);
		- plugin name: HAImage;
		- storage path: imagefile9;
		- device LUN: 0;
		- device size: 12;
		- storage offset: 0;
		- serial Id: (null);
		- EUI-64: (null);
		- vendor id: STARWIND;
		- product id: STARWIND        ;
		- revision level: 0001.
	L1 cache parameters:
		- mode: none;
		- size: 64;
		- flags: 0;
		- expiration time: 0;
		- high watermark: 0;
		- low watermark: 0.
	L2 cache parameters:
		- mode: (null);
		- storage: (null);
		- size: 0;
		- flags: 0;
		- expiration time: 0;
		- high watermark: 0;
		- low watermark: 0.
7/7 22:25:10.576 1914 Common: *** sw_common::Sw_XML_Storage_Impl::str2type: The "(null)" type is not supported.
7/7 22:25:10.576 1914 Common: *** sw_common::Sw_XML_Storage_Impl::str2type: The "(null)" type is not supported.
7/7 22:25:10.576 1914 Common: *** sw_common::storage_type: The specified storage is not supported: .
7/7 22:25:10.576 1914 Common: *** sw_common::Sw_Disk_Header::storage: Either the storage name is empty or its type is invalid.
7/7 22:25:10.576 1914 Common: *** sw_common::Sw_XML_Storage_Impl::str2type: The "(null)" type is not supported.
7/7 22:25:10.681 1914 Common: sw_common::Sw_Disk_Header::open: (file: D:\temp\partnerImg22_HA.swdsk, readonly: no).
7/7 22:25:10.681 1914 Common: *** Browser_ParsePath: Incorrect path supplied: 'imagefile9'!
7/7 22:25:10.681 1914 FileBrowser: *** CFileBrowser::parsePath: Only paths specified in 'imgdir' allowed
7/7 22:25:10.681 1914 Srv: *** iScsiServer::getSscDeviceByStoragePath: Control request failed. Failed to convert virtual path (imagefile9).
7/7 22:25:10.681 1d1c SCSI: : parameter 'DeviceHeaderPath', value 'My computer\D\temp\partnerImg22_HA.swdsk'.
7/7 22:25:10.681 1d1c SCSI: : parameter 'OwnTargetName', value 'iqn.2008-08.com.starwindsoftware:172.17.62.12-partnerha22'.
7/7 22:25:10.681 1d1c SCSI: : parameter 'file', value 'My computer\D\temp\partnerImg22_HA.swdsk'.
7/7 22:25:10.681 1d1c SCSI: : parameter 'serialId', value ''.
7/7 22:25:10.681 1d1c SCSI: : parameter 'asyncmode', value 'yes'.
7/7 22:25:10.681 1d1c SCSI: : parameter 'readonly', value 'no'.
7/7 22:25:10.681 1d1c SCSI: : parameter 'highavailability', value 'yes'.
7/7 22:25:10.681 1d1c SCSI: : parameter 'buffering', value 'no'.
7/7 22:25:10.681 1d1c SCSI: : parameter 'header', value '65536'.
7/7 22:25:10.681 1d1c SCSI: : parameter 'CacheMode', value 'none'.
7/7 22:25:10.681 1d1c SCSI: : parameter 'CacheSizeMB', value '64'.
7/7 22:25:10.681 1d1c SCSI: : parameter 'AluaNodeGroupStates', value '0,0'.
7/7 22:25:10.681 1d1c IMG: SscPort_Create: Parsing parameters from control connection: 
7/7 22:25:10.681 1d1c IMG: SscPort_Create: Header path parsed to 'D:\temp\partnerImg22.swdsk'.
7/7 22:25:10.681 1d1c IMG: addParameter: Parameter processed (add): DeviceHeaderPathPhysical = "D:\temp\partnerImg22.swdsk"
7/7 22:25:10.681 1d1c IMG: addParameter: Parameter processed (add): file = "My computer\D\temp\partnerImg22.swdsk"
7/7 22:25:10.681 1d1c Common: sw_common::Sw_Disk_Header::open: (file: D:\temp\partnerImg22.swdsk, readonly: no).
7/7 22:25:10.682 1d1c IMG: SscPort_Create: Parsing the Device Header File 'D:\temp\partnerImg22.swdsk':
7/7 22:25:10.682 1d1c IMG: addParameter: Parameter processed (update): file = "My computer\D\temp\partnerImg22.swdsk" -> "My computer\D\temp\partnerImg22.img"
7/7 22:25:10.682 1d1c IMG: addParameter: Parameter processed (add): SerialId = "FF56059158C0D5D3"
7/7 22:25:10.682 1d1c IMG: addParameter: Parameter processed (add): eui64 = "FF56059158C0D5D3"
7/7 22:25:10.682 1d1c IMG: addParameter: Parameter processed (update): SerialId = "FF56059158C0D5D3" -> "FF56059158C0D5D3"
7/7 22:25:10.682 1d1c IMG: addParameter: Parameter processed (update): eui64 = "FF56059158C0D5D3" -> "FF56059158C0D5D3"
7/7 22:25:10.682 1d1c IMG: SscPort_Create: Opening device 'imagefile9', image file 'My computer\D\temp\partnerImg22.img', buffering=0, async=1, readonly=0.
7/7 22:25:10.682 1d1c IMG: *** ImageFile_BuildInquiry: D:\temp\partnerImg22.img: Incompatible logical volume sector size (4096 > 512)!
7/7 22:25:10.683 1d1c IMG: *** SscPort_Create: Create('My computer\D\temp\partnerImg22.img') error (0xc000000d)!
7/7 22:25:10.683 1d1c SCSI: *** iScsiSscDevice::open: Failed to create 'imagefile9' device.
7/7 22:25:10.683 1d1c Plugin: iScsiPlugin::pluginCallback: Device is not opened by service core!
7/7 22:25:10.683 1d1c Plugin: iScsiPlugin::pluginCallback: Device 'imagefile9' not found or has wrong type!
7/7 22:25:10.683 1d1c HA: *** CHADevice::get_storage_device_interface_by_name: EXITing with failure(failed), error getting storage device interface for device imagefile9, error code  0x57.
7/7 22:25:10.683 1d1c HA: *** SscPort_Create: Getting storage device interface failed, error code 0x57.
7/7 22:25:10.683 1d1c HA: *** CHADevice::release_storage_device_interface: Error releasing storage device interface, error code 0x57.
7/7 22:25:10.683 1d1c SCSI: *** iScsiSscDevice::open: Failed to create 'HAImage6' device.
7/7 22:25:10.683 1d1c Srv: iScsiServer::deviceOpen: Device 'HAImage6' - open failed!
7/7 22:25:10.683 1914 conf: ConfCommand::processNew: Device [0x000001E2B0BE3CC0] 'HAImage6' has been created.
7/7 22:25:10.729 1d1c Srv: iScsiServer::addTargetCallback: Creating target 'iqn.2008-08.com.starwindsoftware:172.17.62.12-partnerha22', type 0, device list 'HAImage6'...
7/7 22:25:10.730 1d1c SCSI: : parameter 'DeviceHeaderPath', value 'My computer\D\temp\partnerImg22_HA.swdsk'.
7/7 22:25:10.730 1d1c SCSI: : parameter 'OwnTargetName', value 'iqn.2008-08.com.starwindsoftware:172.17.62.12-partnerha22'.
7/7 22:25:10.730 1d1c SCSI: : parameter 'file', value 'My computer\D\temp\partnerImg22_HA.swdsk'.
7/7 22:25:10.730 1d1c SCSI: : parameter 'serialId', value ''.
7/7 22:25:10.730 1d1c SCSI: : parameter 'asyncmode', value 'yes'.
7/7 22:25:10.730 1d1c SCSI: : parameter 'readonly', value 'no'.
7/7 22:25:10.730 1d1c SCSI: : parameter 'highavailability', value 'yes'.
7/7 22:25:10.730 1d1c SCSI: : parameter 'buffering', value 'no'.
7/7 22:25:10.730 1d1c SCSI: : parameter 'header', value '65536'.
7/7 22:25:10.730 1d1c SCSI: : parameter 'CacheMode', value 'none'.
7/7 22:25:10.730 1d1c SCSI: : parameter 'CacheSizeMB', value '64'.
7/7 22:25:10.730 1d1c SCSI: : parameter 'AluaNodeGroupStates', value '0,0'.
7/7 22:25:10.730 1d1c SCSI: : parameter '#_TargetName_#', value 'iqn.2008-08.com.starwindsoftware:172.17.62.12-partnerha22'.
7/7 22:25:10.730 1d1c IMG: SscPort_Create: Parsing parameters from control connection: 
7/7 22:25:10.730 1d1c IMG: SscPort_Create: Header path parsed to 'D:\temp\partnerImg22.swdsk'.
7/7 22:25:10.730 1d1c IMG: addParameter: Parameter processed (add): DeviceHeaderPathPhysical = "D:\temp\partnerImg22.swdsk"
7/7 22:25:10.730 1d1c IMG: addParameter: Parameter processed (add): file = "My computer\D\temp\partnerImg22.swdsk"
7/7 22:25:10.730 1d1c Common: sw_common::Sw_Disk_Header::open: (file: D:\temp\partnerImg22.swdsk, readonly: no).
7/7 22:25:10.730 1d1c IMG: SscPort_Create: Parsing the Device Header File 'D:\temp\partnerImg22.swdsk':
7/7 22:25:10.730 1d1c IMG: addParameter: Parameter processed (update): file = "My computer\D\temp\partnerImg22.swdsk" -> "My computer\D\temp\partnerImg22.img"
7/7 22:25:10.730 1d1c IMG: addParameter: Parameter processed (add): SerialId = "FF56059158C0D5D3"
7/7 22:25:10.731 1d1c IMG: addParameter: Parameter processed (add): eui64 = "FF56059158C0D5D3"
7/7 22:25:10.731 1d1c IMG: addParameter: Parameter processed (update): SerialId = "FF56059158C0D5D3" -> "FF56059158C0D5D3"
7/7 22:25:10.731 1d1c IMG: addParameter: Parameter processed (update): eui64 = "FF56059158C0D5D3" -> "FF56059158C0D5D3"
7/7 22:25:10.731 1d1c IMG: SscPort_Create: Opening device 'imagefile9', image file 'My computer\D\temp\partnerImg22.img', buffering=0, async=1, readonly=0.
7/7 22:25:10.731 1d1c IMG: *** ImageFile_BuildInquiry: D:\temp\partnerImg22.img: Incompatible logical volume sector size (4096 > 512)!
7/7 22:25:10.731 1d1c IMG: *** SscPort_Create: Create('My computer\D\temp\partnerImg22.img') error (0xc000000d)!
7/7 22:25:10.731 1d1c SCSI: *** iScsiSscDevice::open: Failed to create 'imagefile9' device.
7/7 22:25:10.731 1d1c Plugin: iScsiPlugin::pluginCallback: Device is not opened by service core!
7/7 22:25:10.731 1d1c Plugin: iScsiPlugin::pluginCallback: Device 'imagefile9' not found or has wrong type!
7/7 22:25:10.731 1d1c HA: *** CHADevice::get_storage_device_interface_by_name: EXITing with failure(failed), error getting storage device interface for device imagefile9, error code  0x57.
7/7 22:25:10.731 1d1c HA: *** SscPort_Create: Getting storage device interface failed, error code 0x57.
7/7 22:25:10.731 1d1c HA: *** CHADevice::release_storage_device_interface: Error releasing storage device interface, error code 0x57.
7/7 22:25:10.731 1d1c SCSI: *** iScsiSscDevice::open: Failed to create 'HAImage6' device.
7/7 22:25:10.731 1d1c Srv: iScsiServer::deviceOpen: Device 'HAImage6' - open failed!
7/7 22:25:10.731 1d1c Tgt: iScsiTarget::attachDevice: : * cannot open the device 'HAImage6'. It is not active.
7/7 22:25:10.731 1d1c IMG: SscPort_Create: Parsing parameters from control connection: 
7/7 22:25:10.731 1d1c IMG: SscPort_Create: Header path parsed to 'D:\temp\partnerImg22.swdsk'.
7/7 22:25:10.731 1d1c IMG: addParameter: Parameter processed (add): DeviceHeaderPathPhysical = "D:\temp\partnerImg22.swdsk"
7/7 22:25:10.732 1d1c IMG: addParameter: Parameter processed (add): file = "My computer\D\temp\partnerImg22.swdsk"
7/7 22:25:10.732 1d1c Common: sw_common::Sw_Disk_Header::open: (file: D:\temp\partnerImg22.swdsk, readonly: no).
7/7 22:25:10.732 1d1c IMG: SscPort_Create: Parsing the Device Header File 'D:\temp\partnerImg22.swdsk':
7/7 22:25:10.732 1d1c IMG: addParameter: Parameter processed (update): file = "My computer\D\temp\partnerImg22.swdsk" -> "My computer\D\temp\partnerImg22.img"
7/7 22:25:10.732 1d1c IMG: addParameter: Parameter processed (add): SerialId = "FF56059158C0D5D3"
7/7 22:25:10.732 1d1c IMG: addParameter: Parameter processed (add): eui64 = "FF56059158C0D5D3"
7/7 22:25:10.732 1d1c IMG: addParameter: Parameter processed (update): SerialId = "FF56059158C0D5D3" -> "FF56059158C0D5D3"
7/7 22:25:10.732 1d1c IMG: addParameter: Parameter processed (update): eui64 = "FF56059158C0D5D3" -> "FF56059158C0D5D3"
7/7 22:25:10.732 1d1c IMG: SscPort_Create: Opening device 'imagefile9', image file 'My computer\D\temp\partnerImg22.img', buffering=0, async=1, readonly=0.
7/7 22:25:10.732 1d1c IMG: *** ImageFile_BuildInquiry: D:\temp\partnerImg22.img: Incompatible logical volume sector size (4096 > 512)!
7/7 22:25:10.733 1d1c IMG: *** SscPort_Create: Create('My computer\D\temp\partnerImg22.img') error (0xc000000d)!
7/7 22:25:10.733 1d1c SCSI: *** iScsiSscDevice::open: Failed to create 'imagefile9' device.
Looking at the image file header created by the process, it clearly indicates the wrong sector size.

Code: Select all

<?xml version="1.0" encoding="UTF-8"?>
<header signature="StarWind" version="1.0">
  <device active="true" plugin="imagefile" name="imagefile">
    <storages>
      <storage id="1" type="device" name="imagefile" lun="0x0">
        <interval size="12" units="MB"/>
        <inquiry>
          <serial_id>FF56059158C0D5D3</serial_id>
          <vendor id="STARWIND"/>
          <product id="STARWIND        " revision="0001"/>
          <eui_64>FF56059158C0D5D3</eui_64>
        </inquiry>
        <geometry>
          <sector size="512" psize="4096"/>
          <track sectors="16"/>
          <cylinder tracks="32" count="48"/>
        </geometry>
      </storage>
    </storages>
  </device>
  <system>
    <resources>
      <storages>
        <storage id="1" name="My computer\D\temp\partnerImg22.img" type="file">
          <interval size="12" units="MB"/>
        </storage>
      </storages>
      <network/>
    </resources>
  </system>
  <node id="1" name="imagefile" shut="false" active="true">
    <storages>
      <storage_ref id="1"/>
    </storages>
  </node>
</header>
Both nodes are running the exact same hardware. The backend storage is 4K native Seagate drives with Adaptec/Microsemi RAID controllers.

Is there any alternative way to create HA devices via PowerShell? Can we create the image devices on each node and then bind them together by creating the HA devices? I have also noticed a new Add-HADevice in the PowerShell module but there is no documentation on it at all.

Code: Select all

7/7 22:00:44.930 30b8 Srv: StarWind Virtual SAN v8.0.0 (Build 12166, [SwSAN], Win64)
7/7 22:00:44.930 30b8 Srv: Built May  7 2018 17:45:06
7/7 22:00:44.937 30b8 Srv: Windows Server 2016 Standard Edition (v10.0 Build 14393)
7/7 22:00:44.937 30b8 Srv: Processor packages/cores/logical: 2/16/32
Boris (staff)
Staff
Posts: 805
Joined: Fri Jul 28, 2017 8:18 am

Thu Jul 12, 2018 7:13 pm

Could you provide me with a link to the log bundles from both StarWind nodes? Use StarWind Log Collector to aggregate the bundles. It can be downloaded from https://knowledgebase.starwindsoftware. ... collector/
You can PM me the link not to share it publicly.
zxu
Posts: 8
Joined: Fri Aug 18, 2017 1:47 pm

Fri Jul 13, 2018 8:19 pm

Log files from both nodes were sent.
Boris (staff)
Staff
Posts: 805
Joined: Fri Jul 28, 2017 8:18 am

Mon Jul 16, 2018 8:23 pm

I got the logs and will investigate the issue.
Will keep you and the community updated about the results.
Boris (staff)
Staff
Posts: 805
Joined: Fri Jul 28, 2017 8:18 am

Mon Jul 23, 2018 6:11 pm

zxu,

I have spoken to the guys from our R&D team and they have already introduced force-checking for the disk sector size for both nodes. This will be available in the next release of the StarWindX module, most likely with the next StarWind VSAN release.
As for the Serial Number parameter, for now it is ignored, and the serial number is generated automatically.
Post Reply