B484 2015-03-05 10:39:50 19 I B A rescan-bus operation was done. (number of disks that were found: 12, number of enclosures that were found: 1) (rescan reason code: 4) A509 2015-03-05 10:39:50 23 I A Vdisk creation has started. (vdisk: VD01, SN: 00000000000000000000000000000000) 4-disk RAID10, format type: online initialization, chunk size: 64KB A510 2015-03-05 10:39:50 6 I A Vdisk creation failed. Command failed. (error code: 1). (Vdisk: VD01, SN: 00000000000000000000000000000000) 03/05 10:39:45 ERROR: nvDevice NOT present value=0 03/05 10:39:49 Lookup VD01 for other SC, error code 204 03/05 10:39:49 sendThisReply: ERROR: commandCode=1007; errorCode=204; linkType=6 03/05 10:39:50 MetaRcv ZONING_INIT ilun=0 03/05 10:39:50 NVD isAnyBitSet() 03/05 10:39:50 CAPI2RAID_Rescan: reason 4 type 3 Callers: 0x5fcc1e 0x40492e 0x404b0a 0x407ec7 0x2fc000 0x2fc000 03/05 10:39:50 RAID CT_SetAge - Setting Age 14. 03/05 10:39:50 sendThisReply: ERROR: commandCode=1050; errorCode=1; linkType=1 03/05 10:39:50 CloseDrain 00 01 00 00 00 t=CtSrv 03/05 10:39:50 CT_LOCK_DRAIN_ALL_CTRS 03/05 10:39:50 c2fPrepareForRescan flush data logs 03/05 10:39:50 Flushing our logs 03/05 10:39:50 Flushed 0 03/05 10:39:50 Pausing Ios without tasks 03/05 10:39:50 CloseDrain 00 02 00 01 00 t=CtSrv 03/05 10:39:50 CT_SRV: Start rescan type 3 03/05 10:39:50 RV_ReInit - Getting DsLock 03/05 10:39:50 RV_ReInit - START 03/05 10:39:50 12 Drives: 03/05 10:39:50 0=0:0 1=0:1 2=0:2 3=0:3 4=0:4 5=0:5 6=0:6 03/05 10:39:50 7=0:7 8=0:8 9=0:9 10=0:10 11=0:11 03/05 10:39:50 No DiskSet, drives 0 1 2 3 4 5 6 7 8 9 10 11 03/05 10:39:50 RV_ReInit - Releasing DsLock 03/05 10:39:50 RV_ReInit - EXIT 03/05 10:39:50 ***** Config - ConfigCount:1, ForeignConfig:1, DriveCount:12 ***** 03/05 10:39:50 RAID CT_GetAge - returning local_age 14 03/05 10:39:50 RAID_ConfigUpdatePreviousContainerInfo - UPDATING... 03/05 10:39:50 RAID_ConfigUpdatePreviousContainerInfo - NO valid entries in currentContainerInfo 03/05 10:39:50 Read all partitions from 12 drives (N=new, E=error, L=locked, O=old): 03/05 10:39:50 # ent Serial Number CTR/RAI/EN/OF DMap drv# OWN morph? 03/05 10:39:50 Age Start Size #/LVL/TR/ST PStat CStat cookie 03/05 10:39:50 RAID readAllPartitions totals: 03/05 10:39:50 oldPartitionCount: 0 03/05 10:39:50 foreignDriveCount: 0 03/05 10:39:50 noPartitionDriveCount: 0 03/05 10:39:50 noDiskSetDriveCount: 0 03/05 10:39:50 RAID_QuarantineContainers - NOT in failover/failback mode 03/05 10:39:50 Skip quarantine, no current arrays 03/05 10:39:50 Metadata age: local=0, remote=0 03/05 10:39:50 RAID CT_SetAge - Setting Age 14. 03/05 10:39:50 Config - END - ConfigCount:1 03/05 10:39:50 CT_SRV: restarting utilities after rescan... 03/05 10:39:50 CT_OpenDrain 00 02 00 02 00 t=CtSrv 03/05 10:39:50 CT_SRV: Rescan done 03/05 10:39:50 CT_OpenDrain 00 01 00 01 00 t=CtSrv 03/05 10:39:50 DMSSNAP::Rescan SetB hostID=ffh 03/05 10:39:50 ZMGR: none sent ofo=f fb=f 03/05 10:39:50 CAPI2RAID_Rescan: calling CapiInvalidateRaidInfo 03/05 10:39:50 UpdateCfglimsInfo(0xCE) 03/05 10:39:50 UpdateCfglimsInfo totals: snapsUsed=0 MVsUsed=0 BSsUsed=0 MSsUsed=0 SBSsUsed=0 03/05 10:39:50 ZMGR: none sent ofo=f fb=f 03/05 10:39:50 DMS_RaidStateChange: start failover/initialization process 03/05 10:39:50 dms_failoverThreadEntryFunctions: initialization start 03/05 10:39:50 dms_failoverThreadEntryFunctions: initialization end 03/05 10:39:50 DEBUG: CAPI c2fSetAdvancedLanInfo dhcp1 03/05 10:39:50 BldCtrlrStruct update, 0 vdisk, 0 vol, 12 drvs 03/05 10:39:50 ERROR: nvDevice NOT present value=0 03/05 10:39:50 CAPI CONFIGURATION CHANGE - reason = 22, ConfigSequenceNumber = 78 03/05 10:39:50 EVENT RESCAN BUS DONE Reason Code: 4 Drvs: 12 EMPs: 1 03/05 10:39:50 CAPI2RAID_Rescan: done 03/05 10:39:50 NVD isAnyBitSet() 03/05 10:39:51 ERROR: nvDevice NOT present value=0 03/05 10:39:49 CAPI: Name 'VD01' does not exist 03/05 10:39:49 ERROR: nvDevice NOT present value=0 03/05 10:39:49 CAPI: Add array entered 03/05 10:39:49 Drive WWN 5000c50013280927, channel 0, scsiId 0 03/05 10:39:49 Drive WWN 5000c5001314d267, channel 0, scsiId 1 03/05 10:39:49 Drive WWN 5000c500129b3187, channel 0, scsiId 2 03/05 10:39:49 Drive WWN 5000c500129bbbdb, channel 0, scsiId 3 03/05 10:39:49 CapiValidDriveList - drive list is of type:4 03/05 10:39:49 RAID InitDriveMetadata -- driveno 0 03/05 10:39:49 Drive 0 Write BadBlock metadata, instance 0 03/05 10:39:49 Add drive 1 to disk set 054f83275, 2 members 03/05 10:39:49 RAID InitDriveMetadata -- driveno 1 03/05 10:39:49 Drive 1 Write BadBlock metadata, instance 0 03/05 10:39:49 Add drive 2 to disk set 054f83275, 3 members 03/05 10:39:49 RAID InitDriveMetadata -- driveno 2 03/05 10:39:49 Drive 2 Write BadBlock metadata, instance 0 03/05 10:39:49 Add drive 3 to disk set 054f83275, 4 members 03/05 10:39:49 RAID InitDriveMetadata -- driveno 3 03/05 10:39:49 Drive 3 Write BadBlock metadata, instance 0 03/05 10:39:49 CloseDrain 00 01 00 00 00 t=CtSrv 03/05 10:39:49 Drive 0 Write BadBlock metadata, instance 1 03/05 10:39:49 RAID Write ArrayDef, drive 0, partID 0 03/05 10:39:49 Drive 1 Write BadBlock metadata, instance 1 03/05 10:39:49 RAID Write ArrayDef, drive 1, partID 0 03/05 10:39:49 Drive 2 Write BadBlock metadata, instance 1 03/05 10:39:49 RAID Write ArrayDef, drive 2, partID 0 03/05 10:39:49 Drive 3 Write BadBlock metadata, instance 1 03/05 10:39:49 RAID Write ArrayDef, drive 3, partID 0 03/05 10:39:49 RAID CT_SetAge - Setting Age 32. 03/05 10:39:49 ***** Config - ConfigCount:1, ForeignConfig:0, DriveCount:12 ***** 03/05 10:39:49 RAID CT_GetAge - returning local_age 32 03/05 10:39:49 RAID_PurgeForeignPreviousRaidInfo - 3 entries purged 03/05 10:39:49 RAID_ConfigUpdatePreviousContainerInfo - UPDATING... 03/05 10:39:49 RAID_ConfigUpdatePreviousContainerInfo - NO valid entries in currentContainerInfo 03/05 10:39:49 Read all partitions from 12 drives (N=new, E=error, L=locked, O=old): 03/05 10:39:49 # ent Serial Number CTR/RAI/EN/OF DMap drv# OWN morph? 03/05 10:39:49 Age Start Size #/LVL/TR/ST PStat CStat cookie 03/05 10:39:49 N 1 0 1016bc7532f85400 Pri: 33/R1 / 2/ 0 0 0 LCL 03/05 10:39:49 31 8000 22e34180 Sec: 0/R0 / 2/ 0 x20000 x00000 00000000 03/05 10:39:49 N 2 0 1016bc7532f85400 Pri: 33/R1 / 2/ 1 0 1 LCL 03/05 10:39:49 31 8000 22e34180 Sec: 0/R0 / 2/ 0 x20000 x00000 00000001 03/05 10:39:49 N 3 0 1016bc7532f85400 Pri: 34/R1 / 2/ 0 0 2 LCL 03/05 10:39:49 31 8000 22e34180 Sec: 0/R0 / 2/ 1 x20000 x00000 00000002 03/05 10:39:49 N 4 0 1016bc7532f85400 Pri: 34/R1 / 2/ 1 0 3 LCL 03/05 10:39:49 31 8000 22e34180 Sec: 0/R0 / 2/ 1 x20000 x00000 00000003 03/05 10:39:49 RAID readAllPartitions totals: 03/05 10:39:49 oldPartitionCount: 0 03/05 10:39:49 foreignDriveCount: 0 03/05 10:39:49 noPartitionDriveCount: 0 03/05 10:39:49 noDiskSetDriveCount: 0 03/05 10:39:49 Define pri ctr:33: 2 drive RAID1, parts 1 2 03/05 10:39:49 Define pri ctr:34: 2 drive RAID1, parts 3 4 03/05 10:39:49 Setup partition 5 for ctr:33 03/05 10:39:49 Setup partition 6 for ctr:34 03/05 10:39:49 Define sec ctr:0: 2 entry STRIPE, parts 5 6 03/05 10:39:49 RAID_QuarantineContainers - NOT in failover/failback mode 03/05 10:39:49 CTR QM PRVCTR QM PBCTR QM HEALTH 03/05 10:39:49 0 0 -1 - -1 - 0 03/05 10:39:49 RAID ************************************************************** 03/05 10:39:49 RAID_DisplayPreBootRaidInfo: 03/05 10:39:49 ctr vld hlth hrsn lvl mmap soff qmode SN 03/05 10:39:49 RAID_DisplayPreBootRaidInfo - 0 entries in preboot table 03/05 10:39:49 RAID ************************************************************** 03/05 10:39:49 RAID ctr:0, vld:2, hlth:0, rsn:27, rlvl:10, mm:0, qm:0 03/05 10:39:49 QMode ctr 0 nothing missing, not quarantined 03/05 10:39:49 0 NVD clearQuarantineBitMask() 03/05 10:39:49 RAID ***************** Quarantine Summary *************** 03/05 10:39:49 ctr:0 NOT QRTD, health:0, rlvl:10 03/05 10:39:49 RAID ***************** Quarantine Summary End *************** 03/05 10:39:49 RAID_QuarantineContainers - NOT in failover/failback mode 03/05 10:39:49 CTR QM PRVCTR QM PBCTR QM HEALTH 03/05 10:39:49 0 0 -1 - 33 0 0 03/05 10:39:49 RAID ************************************************************** 03/05 10:39:49 RAID_DisplayPreBootRaidInfo: 03/05 10:39:49 ctr vld hlth hrsn lvl mmap soff qmode SN 03/05 10:39:49 33 2 FTOL FTOL 1 0000 0 N 1016bc7532f854 03/05 10:39:49 34 2 FTOL FTOL 1 0000 1 N 1016bc7532f854 03/05 10:39:49 RAID_DisplayPreBootRaidInfo - 2 entries in preboot table 03/05 10:39:49 RAID ************************************************************** 03/05 10:39:49 RAID ctr:0, vld:2, hlth:0, rsn:27, rlvl:10, mm:0, qm:0 03/05 10:39:49 QMode ctr 0 nothing missing, not quarantined 03/05 10:39:49 0 NVD clearQuarantineBitMask() 03/05 10:39:49 RAID ***************** Quarantine Summary *************** 03/05 10:39:49 ctr:0 NOT QRTD, health:0, rlvl:10 03/05 10:39:49 RAID ***************** Quarantine Summary End *************** 03/05 10:39:49 RAID_QuarantineContainers - END 03/05 10:39:49 RAID_QuarantineContainers - END 03/05 10:39:49 Ctr 0, meta age 0 03/05 10:39:49 Metadata age: local=0, remote=0 03/05 10:39:49 Ctr 33 Set Toggle 03/05 10:39:49 Ctr 34 Set Toggle 03/05 10:39:49 ctr 0: No AP metadata 03/05 10:39:49 RAID_UpdateVdiskMemberInfo, ctr:0 03/05 10:39:49 container 0 doesn't have vdisk member info record 03/05 10:39:49 0 write vdisk member info for each member drive 03/05 10:39:49 Array 0, commit primary metadata, age 0 03/05 10:39:49 Ctr 0 read vdisk layout 03/05 10:39:49 Created vdisk layout for container 0, 4 drives 03/05 10:39:49 Vdisk layout details, 4 drives: 03/05 10:39:49 offset original current 03/05 10:39:49 ------- -------- ------- 03/05 10:39:49 ( 0, 0) ( 0, 0) ( 0, 0) 03/05 10:39:49 ( 0, 1) ( 0, 1) ( 0, 1) 03/05 10:39:49 ( 1, 0) ( 0, 2) ( 0, 2) 03/05 10:39:49 ( 1, 1) ( 0, 3) ( 0, 3) 03/05 10:39:49 ---------------------------------------- 03/05 10:39:49 Array 0 Write VdiskLayout metadata, instance 0 03/05 10:39:49 Array 0, commit secondary metadata, age 0 03/05 10:39:50 RAID CT_SetAge - Setting Age 32. 03/05 10:39:50 Config - END - ConfigCount:1 03/05 10:39:50 RI Ctr 0 newly exists, FTOL 03/05 10:39:50 CT_OpenDrain 00 01 00 01 00 t=CtSrv 03/05 10:39:50 0 NVD writeUIDtoDisk() ERROR: 'next' is not present 03/05 10:39:50 Create vdisk, UID disk write failed with error code: 0x100 03/05 10:39:50 CloseDrain 00 01 00 00 00 t=CtSrv 03/05 10:39:50 Discarding Data for 0054f83275bc1610. 03/05 10:39:50 RAID MoveSpare from ctr 0 to ctr -1 03/05 10:39:50 RAID MoveSpare from ctr 33 to ctr -1 03/05 10:39:50 RAID MoveSpare from ctr 34 to ctr -1 03/05 10:39:50 RAID CT_GetAge - returning local_age 32 03/05 10:39:50 Drive 0: Delete Disk Partition 0 03/05 10:39:50 Drive 1: Delete Disk Partition 0 03/05 10:39:50 Drive 2: Delete Disk Partition 0 03/05 10:39:50 Drive 3: Delete Disk Partition 0 03/05 10:39:50 RAID_RemovePreBootEntry - ctr:0 03/05 10:39:50 Reconfig: Clearing container 0 03/05 10:39:50 Reconfig: Clearing container 33 03/05 10:39:50 Reconfig: Clearing container 34 03/05 10:39:50 ***** Config - ConfigCount:1, ForeignConfig:0, DriveCount:12 ***** 03/05 10:39:50 RAID CT_GetAge - returning local_age 32 03/05 10:39:50 RAID_ConfigUpdatePreviousContainerInfo - UPDATING... 03/05 10:39:50 Read all partitions from 12 drives (N=new, E=error, L=locked, O=old): 03/05 10:39:50 # ent Serial Number CTR/RAI/EN/OF DMap drv# OWN morph? 03/05 10:39:50 Age Start Size #/LVL/TR/ST PStat CStat cookie 03/05 10:39:50 RAID readAllPartitions totals: 03/05 10:39:50 oldPartitionCount: 0 03/05 10:39:50 foreignDriveCount: 0 03/05 10:39:50 noPartitionDriveCount: 0 03/05 10:39:50 noDiskSetDriveCount: 0 03/05 10:39:50 RAID_QuarantineContainers - NOT in failover/failback mode 03/05 10:39:50 Skip quarantine, no current arrays 03/05 10:39:50 Metadata age: local=0, remote=0 03/05 10:39:50 RAID CT_SetAge - Setting Age 32. 03/05 10:39:50 Config - END - ConfigCount:1 03/05 10:39:50 RI Ctr 0 disappeared 03/05 10:39:50 CT_OpenDrain 00 01 00 01 00 t=CtSrv 03/05 10:39:50 DMSSNAP::Rescan SetA hostID=ffh 03/05 10:39:50 ZMGR: none sent ofo=f fb=f 03/05 10:39:50 SendReconfig, Callers: 0x407f70 0x48c5ac 0x494d64 0x4a79eb 0x49c7ed 0x2fc000 03/05 10:39:50 EVENT ADD VDISK START VD01 4 drive RAID10 Online 64K COMMAND FAILED 03/05 10:39:50 EVENT ADD VDISK DONE VD01 SN00000000000000 Util Failed COMMAND FAILED 03/05 10:39:50 MetaRcv ZONING_INIT ilun=0 03/05 10:39:50 MetaRcv ZONING_INIT ilun=0 03/05 10:39:50 EMP0.0 500c0ff0103cf13c LEDsOff 03/05 10:39:51 ERROR: nvDevice NOT present value=0 03/05 10:39:45 ERROR: nvDevice NOT present value=0 03/05 10:39:49 Lookup VD01 for other SC, error code 204 03/05 10:39:49 sendThisReply: ERROR: commandCode=1007; errorCode=204; linkType=6 03/05 10:39:50 MetaRcv ZONING_INIT ilun=0 03/05 10:39:50 NVD isAnyBitSet() 03/05 10:39:50 CAPI2RAID_Rescan: reason 4 type 3 Callers: 0x5fcc1e 0x40492e 0x404b0a 0x407ec7 0x2fc000 0x2fc000 03/05 10:39:50 RAID CT_SetAge - Setting Age 14. 03/05 10:39:50 sendThisReply: ERROR: commandCode=1050; errorCode=1; linkType=1 03/05 10:39:50 CloseDrain 00 01 00 00 00 t=CtSrv 03/05 10:39:50 CT_LOCK_DRAIN_ALL_CTRS 03/05 10:39:50 c2fPrepareForRescan flush data logs 03/05 10:39:50 Flushing our logs 03/05 10:39:50 Flushed 0 03/05 10:39:50 Pausing Ios without tasks 03/05 10:39:50 CloseDrain 00 02 00 01 00 t=CtSrv 03/05 10:39:50 CT_SRV: Start rescan type 3 03/05 10:39:50 RV_ReInit - Getting DsLock 03/05 10:39:50 RV_ReInit - START 03/05 10:39:50 12 Drives: 03/05 10:39:50 0=0:0 1=0:1 2=0:2 3=0:3 4=0:4 5=0:5 6=0:6 03/05 10:39:50 7=0:7 8=0:8 9=0:9 10=0:10 11=0:11 03/05 10:39:50 No DiskSet, drives 0 1 2 3 4 5 6 7 8 9 10 11 03/05 10:39:50 RV_ReInit - Releasing DsLock 03/05 10:39:50 RV_ReInit - EXIT 03/05 10:39:50 ***** Config - ConfigCount:1, ForeignConfig:1, DriveCount:12 ***** 03/05 10:39:50 RAID CT_GetAge - returning local_age 14 03/05 10:39:50 RAID_ConfigUpdatePreviousContainerInfo - UPDATING... 03/05 10:39:50 RAID_ConfigUpdatePreviousContainerInfo - NO valid entries in currentContainerInfo 03/05 10:39:50 Read all partitions from 12 drives (N=new, E=error, L=locked, O=old): 03/05 10:39:50 # ent Serial Number CTR/RAI/EN/OF DMap drv# OWN morph? 03/05 10:39:50 Age Start Size #/LVL/TR/ST PStat CStat cookie 03/05 10:39:50 RAID readAllPartitions totals: 03/05 10:39:50 oldPartitionCount: 0 03/05 10:39:50 foreignDriveCount: 0 03/05 10:39:50 noPartitionDriveCount: 0 03/05 10:39:50 noDiskSetDriveCount: 0 03/05 10:39:50 RAID_QuarantineContainers - NOT in failover/failback mode 03/05 10:39:50 Skip quarantine, no current arrays 03/05 10:39:50 Metadata age: local=0, remote=0 03/05 10:39:50 RAID CT_SetAge - Setting Age 14. 03/05 10:39:50 Config - END - ConfigCount:1 03/05 10:39:50 CT_SRV: restarting utilities after rescan... 03/05 10:39:50 CT_OpenDrain 00 02 00 02 00 t=CtSrv 03/05 10:39:50 CT_SRV: Rescan done 03/05 10:39:50 CT_OpenDrain 00 01 00 01 00 t=CtSrv 03/05 10:39:50 DMSSNAP::Rescan SetB hostID=ffh 03/05 10:39:50 ZMGR: none sent ofo=f fb=f 03/05 10:39:50 CAPI2RAID_Rescan: calling CapiInvalidateRaidInfo 03/05 10:39:50 UpdateCfglimsInfo(0xCE) 03/05 10:39:50 UpdateCfglimsInfo totals: snapsUsed=0 MVsUsed=0 BSsUsed=0 MSsUsed=0 SBSsUsed=0 03/05 10:39:50 ZMGR: none sent ofo=f fb=f 03/05 10:39:50 DMS_RaidStateChange: start failover/initialization process 03/05 10:39:50 dms_failoverThreadEntryFunctions: initialization start 03/05 10:39:50 dms_failoverThreadEntryFunctions: initialization end 03/05 10:39:50 DEBUG: CAPI c2fSetAdvancedLanInfo dhcp1 03/05 10:39:50 BldCtrlrStruct update, 0 vdisk, 0 vol, 12 drvs 03/05 10:39:50 ERROR: nvDevice NOT present value=0 03/05 10:39:50 CAPI CONFIGURATION CHANGE - reason = 22, ConfigSequenceNumber = 78 03/05 10:39:50 EVENT RESCAN BUS DONE Reason Code: 4 Drvs: 12 EMPs: 1 03/05 10:39:50 CAPI2RAID_Rescan: done 03/05 10:39:50 NVD isAnyBitSet() 03/05 10:39:51 ERROR: nvDevice NOT present value=0