Showing posts with label FDM VMware HA. Show all posts
Showing posts with label FDM VMware HA. Show all posts

Sunday, August 28, 2011

VMware HA 5.0 log file

For VMware vSphere 5.0 HA (also known Fault Domain Manager, FDM), I have captured the log file (fdm.log, found at /scratch/log/fdm.log) when I tried to enable HA successfully as below for reference. Does anyone can interpret it ? 

====================================================
Section for VMware Fault Domain Manager, pid=5013, version=5.0.0, build=build-455964, option=Release
2011-08-28T14:22:35.431Z [FF9A2400 warning 'Default'] Encountered errors while reading log parameters:
--> Exception: N7Vmacore24InvalidArgumentExceptionEInvalid argument : At least two log files required. 0 specified
2011-08-28T14:22:35.432Z [FF9A2400 info 'Default'] Initialized channel manager
2011-08-28T14:22:35.434Z [FF9A2400 info 'Default'] Current working directory: /vmfs/volumes/4e58c768-0d6e3d14-e9b5-000c29d36aa5/log
2011-08-28T14:22:35.434Z [FF9A2400 verbose 'ThreadPool'] Thread info: Min Io, Max Io, Min Task, Max Task, Max Thread, Keepalive, exit idle, idle secs, max fds: 2, 9, 2, 4, 13, 4, false, 600
2011-08-28T14:22:35.436Z [FF9A2400 info 'Default'] Log path: /var/log/vmware/fdm
2011-08-28T14:22:35.436Z [FF9A2400 info 'Default'] Initializing SSL
2011-08-28T14:22:35.440Z [FF9A2400 info 'Default'] Vmacore::InitSSL: doVersionCheck = false, handshakeTimeoutUs = 20000000
2011-08-28T14:22:35.442Z [FF9A2400 info 'Default'] [Vpxd_EarlyInit] Setting malloc mmap threshold to 128 KB (ret=1)
2011-08-28T14:22:35.442Z [FF9A2400 info 'Default'] [Vpxd_EarlyInit] configFilePath = /etc/opt/vmware/fdm/fdm.cfg
2011-08-28T14:22:35.442Z [FF9A2400 info 'Default'] Creating SSL Contexts
2011-08-28T14:22:35.451Z [FF9A2400 info 'Default'] [Fdm_Main] Starting VMware Fault Domain Manager 5.0.0 build-455964
2011-08-28T14:22:35.453Z [FF9A2400 verbose 'Notifications'] [Notifications::Init] Setting up the notifications subsystem.
2011-08-28T14:22:35.453Z [FF9A2400 verbose 'Notifications'] [Notification::AddListener] Adding listener of type Csi::Notifications::ClusterStateChange: FdmService (listeners = 1)
2011-08-28T14:22:35.453Z [FF9A2400 verbose 'Notifications'] [Notification::AddListener] Adding listener of type Csi::Notifications::DumpStateChange: FdmService (listeners = 1)
2011-08-28T14:22:35.453Z [FF9A2400 verbose 'Notifications'] [Notification::AddListener] Adding listener of type Vim::Event::Event: FdmService (listeners = 1)
2011-08-28T14:22:35.454Z [FF9A2400 verbose 'Notifications'] [Notification::AddListener] Adding listener of type Csi::Notifications::ClusterConfigChange: LogsvcManager (listeners = 1)
2011-08-28T14:22:35.454Z [FF9A2400 info 'Default'] Looking for vpx result filter at /opt/vmware/fdm/fdm/vpxResultFilter.xml
2011-08-28T14:22:35.457Z [FF9A2400 verbose 'Default'] Found default value for property HostHardwareInfo/smcPresent
2011-08-28T14:22:35.457Z [FF9A2400 verbose 'Default'] Found default value for property ConfigTarget/smcPresent
2011-08-28T14:22:35.457Z [FF9A2400 verbose 'Default'] Found default value for property GuestOsDescriptor/smcRequired
2011-08-28T14:22:35.457Z [FF9A2400 verbose 'Default'] Found default value for property VirtualMachineCapability/multipleCoresPerSocketSupported
2011-08-28T14:22:35.457Z [FF9A2400 verbose 'Default'] Found default value for property VirtualUSBXHCIController/autoConnectDevices
2011-08-28T14:22:35.457Z [FF9A2400 verbose 'Default'] Found default value for property VirtualUSBXHCIControllerOption/autoConnectDevices
2011-08-28T14:22:35.457Z [FF9A2400 verbose 'Default'] Found default value for property VirtualUSBXHCIControllerOption/supportedSpeeds
2011-08-28T14:22:35.457Z [FF9A2400 verbose 'Default'] Found default value for property VirtualUSBControllerOption/supportedSpeeds
2011-08-28T14:22:35.457Z [FF9A2400 verbose 'Default'] Found default value for property VirtualHardwareOption/numCoresPerSocket
2011-08-28T14:22:35.458Z [FF9A2400 verbose 'Default'] Found default value for property VirtualHardwareOption/numUSBXHCIControllers
2011-08-28T14:22:35.458Z [FF9A2400 verbose 'Default'] Found default value for property GuestOsDescriptor/numSupportedPhysicalSockets
2011-08-28T14:22:35.458Z [FF9A2400 verbose 'Default'] Found default value for property GuestOsDescriptor/numSupportedCoresPerSocket
2011-08-28T14:22:35.458Z [FF9A2400 verbose 'Default'] Found default value for property GuestOsDescriptor/supportedFirmware
2011-08-28T14:22:35.458Z [FF9A2400 verbose 'Default'] Found default value for property GuestOsDescriptor/recommendedFirmware
2011-08-28T14:22:35.458Z [FF9A2400 verbose 'Default'] Found default value for property GuestOsDescriptor/smcRecommended
2011-08-28T14:22:35.458Z [FF9A2400 verbose 'Default'] Found default value for property GuestOsDescriptor/ich7mRecommended
2011-08-28T14:22:35.458Z [FF9A2400 verbose 'Default'] Found default value for property GuestOsDescriptor/usbRecommended
2011-08-28T14:22:35.458Z [FF9A2400 verbose 'Default'] Found default value for property GuestOsDescriptor/supportLevel
2011-08-28T14:22:35.458Z [FF9A2400 verbose 'Default'] Found default value for property GuestOsDescriptor/supportedForCreate
2011-08-28T14:22:35.458Z [FF9A2400 verbose 'Default'] Found default value for property GuestOsDescriptor/vRAMSizeInKB
2011-08-28T14:22:35.458Z [FF9A2400 verbose 'Default'] Found default value for property VirtualMachineCapability/guestAutoLockSupported
2011-08-28T14:22:35.458Z [FF9A2400 verbose 'Default'] Found default value for property HostCapability/cpuMemoryResourceConfigurationSupported
2011-08-28T14:22:35.458Z [FF9A2400 verbose 'Default'] Found default value for property HostCapability/standbySupported
2011-08-28T14:22:35.458Z [FF9A2400 verbose 'Default'] Found default value for property HostCapability/preAssignedPCIUnitNumbersSupported
2011-08-28T14:22:35.458Z [FF9A2400 verbose 'Default'] Found default value for property HostCapability/perVmSwapFiles
2011-08-28T14:22:35.458Z [FF9A2400 verbose 'Default'] Found default value for property HostCapability/localSwapDatastoreSupported
2011-08-28T14:22:35.458Z [FF9A2400 verbose 'Default'] Found default value for property HostCapability/unsharedSwapVMotionSupported
2011-08-28T14:22:35.459Z [FF9A2400 verbose 'Default'] Found default value for property HostCapability/backgroundSnapshotsSupported
2011-08-28T14:22:35.459Z [FF9A2400 verbose 'Default'] Found default value for property HostCapability/restrictedSnapshotRelocateSupported
2011-08-28T14:22:35.459Z [FF9A2400 verbose 'Default'] Found default value for property HostCapability/screenshotSupported
2011-08-28T14:22:35.459Z [FF9A2400 verbose 'Default'] Found default value for property HostCapability/recordReplaySupported
2011-08-28T14:22:35.459Z [FF9A2400 verbose 'Default'] Found default value for property HostCapability/ftSupported
2011-08-28T14:22:35.459Z [FF9A2400 verbose 'Default'] Found default value for property HostCapability/scaledScreenshotSupported
2011-08-28T14:22:35.459Z [FF9A2400 verbose 'Default'] Found default value for property HostCapability/storageVMotionSupported
2011-08-28T14:22:35.459Z [FF9A2400 verbose 'Default'] Found default value for property HostCapability/vmotionWithStorageVMotionSupported
2011-08-28T14:22:35.459Z [FF9A2400 verbose 'Default'] Found default value for property HostCapability/loginBySSLThumbprintSupported
2011-08-28T14:22:35.459Z [FF9A2400 verbose 'Default'] Found default value for property HostCapability/cloneFromSnapshotSupported
2011-08-28T14:22:35.459Z [FF9A2400 verbose 'Default'] Found default value for property HostCapability/vmotionEncryptionSupported
2011-08-28T14:22:35.459Z [FF9A2400 verbose 'Default'] Found default value for property HostCapability/deltaDiskBackingsSupported
2011-08-28T14:22:35.459Z [FF9A2400 verbose 'Default'] Found default value for property HostCapability/perVMNetworkTrafficShapingSupported
2011-08-28T14:22:35.460Z [FF9A2400 verbose 'Default'] Found default value for property HostCapability/tpmSupported
2011-08-28T14:22:35.460Z [FF9A2400 verbose 'Default'] Found default value for property HostCapability/virtualExecUsageSupported
2011-08-28T14:22:35.460Z [FF9A2400 verbose 'Default'] Found default value for property HostCapability/storageIORMSupported
2011-08-28T14:22:35.460Z [FF9A2400 verbose 'Default'] Found default value for property HostCapability/vmDirectPathGen2Supported
2011-08-28T14:22:35.460Z [FF9A2400 verbose 'Default'] Found default value for property HostCapability/vStorageCapable
2011-08-28T14:22:35.460Z [FF9A2400 verbose 'Default'] Found default value for property HostCapability/snapshotRelayoutSupported
2011-08-28T14:22:35.460Z [FF9A2400 verbose 'Default'] Found default value for property HostCapability/vmfsDatastoreMountCapable
2011-08-28T14:22:35.460Z [FF9A2400 verbose 'Default'] Found default value for property HostInternalCapability/enumerateExtentsSupported
2011-08-28T14:22:35.460Z [FF9A2400 verbose 'Default'] Found default value for property HostInternalCapability/fastSuspendResumeSupported
2011-08-28T14:22:35.460Z [FF9A2400 verbose 'Default'] Found default value for property HostInternalCapability/svmVmxDiskCopySupported
2011-08-28T14:22:35.460Z [FF9A2400 verbose 'Default'] Found default value for property HostInternalCapability/evcSoftwareSupported
2011-08-28T14:22:35.460Z [FF9A2400 verbose 'Default'] Found default value for property HostInternalCapability/lunDisplayNameSupported
2011-08-28T14:22:35.460Z [FF9A2400 verbose 'Default'] Found default value for property HostInternalCapability/virtualDiskDigestSupported
2011-08-28T14:22:35.460Z [FF9A2400 verbose 'Default'] Found default value for property HostInternalCapability/hostProfileEngineSupported
2011-08-28T14:22:35.460Z [FF9A2400 verbose 'Default'] Found default value for property HostInternalCapability/controllableStatsCountersSupported
2011-08-28T14:22:35.460Z [FF9A2400 verbose 'Default'] Found default value for property HostInternalCapability/nfcCopyRawDiskMappingSupported
2011-08-28T14:22:35.460Z [FF9A2400 verbose 'Default'] Found default value for property HostInternalCapability/nfcCopyDeltaDiskSupported
2011-08-28T14:22:35.460Z [FF9A2400 verbose 'Default'] Found default value for property HostInternalCapability/vmotionHostLogStateSupported
2011-08-28T14:22:35.460Z [FF9A2400 verbose 'Default'] Found default value for property HostDiskBlockInfo/provisionBlockSize
2011-08-28T14:22:35.460Z [FF9A2400 verbose 'Default'] Found default value for property HostDatastoreSystemCapabilities/vmfsExtentExpansionSupported
2011-08-28T14:22:35.460Z [FF9A2400 verbose 'Default'] Found default value for property HostDiskBlockInfo/mapStart
2011-08-28T14:22:35.460Z [FF9A2400 verbose 'Default'] Found default value for property HostDiskBlockInfoExtent/readOnly
2011-08-28T14:22:35.460Z [FF9A2400 verbose 'Default'] Found default value for property HostDiskBlockInfoExtent/lazyZero
2011-08-28T14:22:35.460Z [FF9A2400 verbose 'Default'] Found default value for property HostDiskManagerLeaseInfo/leaseTimeout
2011-08-28T14:22:35.461Z [FF9A2400 verbose 'Default'] Found default value for property HostNetCapabilities/vswitchConfigSupported
2011-08-28T14:22:35.463Z [FF9A2400 verbose 'Default'] Found default value for property HostNetCapabilities/vnicConfigSupported
2011-08-28T14:22:35.463Z [FF9A2400 verbose 'Default'] Found default value for property HostNetCapabilities/ipRouteConfigSupported
2011-08-28T14:22:35.463Z [FF9A2400 verbose 'Default'] Found default value for property HostNetCapabilities/dnsConfigSupported
2011-08-28T14:22:35.463Z [FF9A2400 verbose 'Default'] Found default value for property HostNetCapabilities/dhcpOnVnicSupported
2011-08-28T14:22:35.463Z [FF9A2400 verbose 'Default'] Found default value for property HostNetCapabilities/ipV6Supported
2011-08-28T14:22:35.463Z [FF9A2400 verbose 'Default'] Found default value for property PhysicalNic/wakeOnLanSupported
2011-08-28T14:22:35.463Z [FF9A2400 verbose 'Default'] Found default value for property PhysicalNic/mac
2011-08-28T14:22:35.463Z [FF9A2400 verbose 'Default'] Found default value for property HostRuntimeInfo/powerState
2011-08-28T14:22:35.464Z [FF9A2400 verbose 'Default'] Found default value for property HostConfigSummary/faultToleranceEnabled
2011-08-28T14:22:35.464Z [FF9A2400 verbose 'Default'] Found default value for property VirtualMachineCapability/disableSnapshotsSupported
2011-08-28T14:22:35.464Z [FF9A2400 verbose 'Default'] Found default value for property VirtualMachineCapability/lockSnapshotsSupported
2011-08-28T14:22:35.464Z [FF9A2400 verbose 'Default'] Found default value for property VirtualMachineCapability/vmNpivWwnSupported
2011-08-28T14:22:35.464Z [FF9A2400 verbose 'Default'] Found default value for property VirtualMachineCapability/npivWwnOnNonRdmVmSupported
2011-08-28T14:22:35.464Z [FF9A2400 verbose 'Default'] Found default value for property VirtualMachineCapability/swapPlacementSupported
2011-08-28T14:22:35.464Z [FF9A2400 verbose 'Default'] Found default value for property VirtualMachineCapability/diskSharesSupported
2011-08-28T14:22:35.464Z [FF9A2400 verbose 'Default'] Found default value for property VirtualMachineCapability/bootOptionsSupported
2011-08-28T14:22:35.464Z [FF9A2400 verbose 'Default'] Found default value for property VirtualMachineCapability/bootRetryOptionsSupported
2011-08-28T14:22:35.464Z [FF9A2400 verbose 'Default'] Found default value for property VirtualMachineCapability/settingVideoRamSizeSupported
2011-08-28T14:22:35.464Z [FF9A2400 verbose 'Default'] Found default value for property VirtualMachineCapability/settingDisplayTopologySupported
2011-08-28T14:22:35.464Z [FF9A2400 verbose 'Default'] Found default value for property VirtualMachineCapability/settingDisplayTopologyModesSupported
2011-08-28T14:22:35.464Z [FF9A2400 verbose 'Default'] Found default value for property VirtualMachineCapability/toolsSyncTimeSupported
2011-08-28T14:22:35.464Z [FF9A2400 verbose 'Default'] Found default value for property VirtualMachineCapability/virtualMmuUsageSupported
2011-08-28T14:22:35.464Z [FF9A2400 verbose 'Default'] Found default value for property VirtualMachineCapability/recordReplaySupported
2011-08-28T14:22:35.464Z [FF9A2400 verbose 'Default'] Found default value for property VirtualMachineCapability/swapPreservationSupported
2011-08-28T14:22:35.464Z [FF9A2400 verbose 'Default'] Found default value for property VirtualMachineCapability/vmNpivWwnDisableSupported
2011-08-28T14:22:35.464Z [FF9A2400 verbose 'Default'] Found default value for property VirtualMachineCapability/vmNpivWwnUpdateSupported
2011-08-28T14:22:35.464Z [FF9A2400 verbose 'Default'] Found default value for property VirtualMachineCapability/changeTrackingSupported
2011-08-28T14:22:35.464Z [FF9A2400 verbose 'Default'] Found default value for property VirtualMachineCapability/hostBasedReplicationSupported
2011-08-28T14:22:35.464Z [FF9A2400 verbose 'Default'] Found default value for property VirtualMachineCapability/memoryReservationLockSupported
2011-08-28T14:22:35.464Z [FF9A2400 verbose 'Default'] Found default value for property VirtualMachineConfigInfo/alternateGuestName
2011-08-28T14:22:35.464Z [FF9A2400 verbose 'Default'] Found default value for property VirtualMachineConfigInfo/preserveSwapOnPowerOff
2011-08-28T14:22:35.464Z [FF9A2400 verbose 'Default'] Found default value for property VirtualMachineConfigOptionDescriptor/createSupported
2011-08-28T14:22:35.465Z [FF9A2400 verbose 'Default'] Found default value for property VirtualMachineConfigOptionDescriptor/defaultConfigOption
2011-08-28T14:22:35.465Z [FF9A2400 verbose 'Default'] Found default value for property GuestOsDescriptor/supportsVMI
2011-08-28T14:22:35.465Z [FF9A2400 verbose 'Default'] Found default value for property GuestOsDescriptor/supports3D
2011-08-28T14:22:35.465Z [FF9A2400 verbose 'Default'] Found default value for property GuestOsDescriptor/supportsMemoryHotAdd
2011-08-28T14:22:35.465Z [FF9A2400 verbose 'Default'] Found default value for property GuestOsDescriptor/supportsCpuHotAdd
2011-08-28T14:22:35.465Z [FF9A2400 verbose 'Default'] Found default value for property GuestOsDescriptor/supportsCpuHotRemove
2011-08-28T14:22:35.465Z [FF9A2400 verbose 'Default'] Found default value for property VirtualDeviceOption/hotRemoveSupported
2011-08-28T14:22:35.465Z [FF9A2400 verbose 'Default'] Found default value for property VirtualDeviceDeviceBackingOption/autoDetectAvailable
2011-08-28T14:22:35.465Z [FF9A2400 verbose 'Default'] Found default value for property VirtualDeviceRemoteDeviceBackingOption/autoDetectAvailable
2011-08-28T14:22:35.465Z [FF9A2400 verbose 'Default'] Found default value for property VirtualPCIControllerOption/numVmiRoms
2011-08-28T14:22:35.465Z [FF9A2400 verbose 'Default'] Found default value for property VirtualUSBControllerOption/ehciSupported
2011-08-28T14:22:35.465Z [FF9A2400 verbose 'Default'] Found default value for property VirtualDiskSparseVer2BackingOption/uuid
2011-08-28T14:22:35.465Z [FF9A2400 verbose 'Default'] Found default value for property VirtualDiskFlatVer2BackingOption/uuid
2011-08-28T14:22:35.465Z [FF9A2400 verbose 'Default'] Found default value for property VirtualDiskRawDiskMappingVer1BackingOption/uuid
2011-08-28T14:22:35.465Z [FF9A2400 verbose 'Default'] Found default value for property VirtualDiskFlatVer2BackingOption/hotGrowable
2011-08-28T14:22:35.465Z [FF9A2400 verbose 'Default'] Found default value for property VirtualPCIControllerOption/numVmciDevices
2011-08-28T14:22:35.465Z [FF9A2400 verbose 'Default'] Found default value for property VirtualPCIControllerOption/numPCIPassthroughDevices
2011-08-28T14:22:35.465Z [FF9A2400 verbose 'Default'] Found default value for property VirtualPCIControllerOption/numSasSCSIControllers
2011-08-28T14:22:35.465Z [FF9A2400 verbose 'Default'] Found default value for property VirtualPCIControllerOption/numVmxnet3EthernetCards
2011-08-28T14:22:35.465Z [FF9A2400 verbose 'Default'] Found default value for property VirtualPCIControllerOption/numParaVirtualSCSIControllers
2011-08-28T14:22:35.465Z [FF9A2400 verbose 'Default'] Found default value for property VirtualMachineVMCIDeviceOption/allowUnrestrictedCommunication
2011-08-28T14:22:35.465Z [FF9A2400 verbose 'Default'] Found default value for property VirtualDiskFlatVer2BackingOption/thinProvisioned
2011-08-28T14:22:35.465Z [FF9A2400 verbose 'Default'] Found default value for property VirtualMachineConfigOption/supportedMonitorType
2011-08-28T14:22:35.465Z [FF9A2400 verbose 'Default'] Found default value for property VirtualDiskFlatVer2BackingOption/eagerlyScrub
2011-08-28T14:22:35.466Z [FF9A2400 verbose 'Default'] Found default value for property VirtualDiskFlatVer2BackingOption/deltaDiskFormat
2011-08-28T14:22:35.466Z [FF9A2400 verbose 'Default'] Found default value for property VirtualMachineRuntimeInfo/faultToleranceState
2011-08-28T14:22:35.466Z [FF9A2400 verbose 'Default'] Found default value for property VirtualMachineRuntimeInfo/onlineStandby
2011-08-28T14:22:35.466Z [FF9A2400 verbose 'Default'] Found default value for property VirtualMachineRuntimeInfo/recordReplayState
2011-08-28T14:22:35.466Z [FF9A2400 verbose 'Default'] Found default value for property NetworkSummary/ipPoolName
2011-08-28T14:22:35.466Z [FF9A2400 verbose 'Default'] Found default value for property VirtualMachineSnapshotTree/id
2011-08-28T14:22:35.466Z [FF9A2400 verbose 'Default'] Found default value for property VirtualMachineSnapshotTree/revertible
2011-08-28T14:22:35.466Z [FF9A2400 verbose 'Default'] Found default value for property VirtualEthernetCardOption/vmDirectPathGen2Supported
2011-08-28T14:22:35.466Z [FF9A2400 verbose 'Default'] Found default value for property DatastoreCapability/storageIORMSupported
2011-08-28T14:22:35.466Z [FF9A2400 verbose 'Default'] Found default value for property VirtualDiskOption/ioAllocationOption
2011-08-28T14:22:35.466Z [FF9A2400 verbose 'Default'] Found default value for property VirtualHardwareOption/resourceConfigOption
2011-08-28T14:22:35.466Z [FF9A2400 verbose 'Default'] Found default value for property HostSslThumbprintInfo/ownerTag
2011-08-28T14:22:35.466Z [FF9A2400 verbose 'Default'] Found default value for property Capability/userShellAccessSupported
2011-08-28T14:22:35.466Z [FF9A2400 verbose 'Default'] Found default value for property PerfInterval/key
2011-08-28T14:22:35.466Z [FF9A2400 verbose 'Default'] Found default value for property PerfInterval/enabled
2011-08-28T14:22:35.466Z [FF9A2400 verbose 'Default'] Found default value for property AlarmDescription/datastoreConnectionState
2011-08-28T14:22:35.466Z [FF9A2400 verbose 'Default'] Found default value for property AlarmDescription/hostSystemPowerState
2011-08-28T14:22:35.466Z [FF9A2400 verbose 'Default'] Found default value for property AlarmDescription/virtualMachineGuestHeartbeatStatus
2011-08-28T14:22:35.466Z [FF9A2400 verbose 'Default'] Found default value for property ClusterTransitionalEVCManagerEVCState/supportedEVCMode
2011-08-28T14:22:35.466Z [FF9A2400 verbose 'Default'] Found default value for property FileQueryFlags/fileOwner
2011-08-28T14:22:35.466Z [FF9A2400 verbose 'Default'] Found default value for property HostSnmpSystemAgentLimits/capability
2011-08-28T14:22:35.466Z [FF9A2400 verbose 'Default'] Found default value for property VirtualDiskSparseVer2BackingOption/hotGrowable
2011-08-28T14:22:35.466Z [FF9A2400 verbose 'Default'] Found default value for property VirtualDiskRawDiskVer2BackingOption/uuid
2011-08-28T14:22:35.466Z [FF9A2400 verbose 'Default'] Found default value for property VirtualUSB/connected
2011-08-28T14:22:35.466Z [FF9A2400 verbose 'Default'] Found default value for property EVCMode/track
2011-08-28T14:22:35.467Z [FF9A2400 verbose 'Default'] Found default value for property RuleViolation/rule
2011-08-28T14:22:35.467Z [FF9A2400 verbose 'Default'] Found default value for property VirtualHardwareVersionNotSupported/hostName
2011-08-28T14:22:35.467Z [FF9A2400 verbose 'Default'] Found default value for property VirtualHardwareVersionNotSupported/host
2011-08-28T14:22:35.467Z [FF9A2400 verbose 'Default'] Found default value for property ScheduledTaskInfo/taskObject
2011-08-28T14:22:35.467Z [FF9A2400 verbose 'Default'] Found default value for property DVSConfigInfo/networkResourceManagementEnabled
2011-08-28T14:22:35.467Z [FF9A2400 verbose 'Default'] Found default value for property VirtualMachineRuntimeInfo/consolidationNeeded
2011-08-28T14:22:35.467Z [FF9A2400 verbose 'Default'] Found default value for property HostFirewallRule/portType
2011-08-28T14:22:35.467Z [FF9A2400 verbose 'Default'] Found default value for property StorageIORMInfo/statsCollectionEnabled
2011-08-28T14:22:35.467Z [FF9A2400 verbose 'Default'] Found default value for property StorageIORMConfigOption/statsCollectionEnabledOption
2011-08-28T14:22:35.467Z [FF9A2400 verbose 'Default'] Found default value for property UserSession/extensionSession
2011-08-28T14:22:35.467Z [FF9A2400 verbose 'Default'] Found default value for property CpuIncompatible1ECX/pclmulqdq
2011-08-28T14:22:35.467Z [FF9A2400 verbose 'Default'] Found default value for property CpuIncompatible1ECX/aes
2011-08-28T14:22:35.468Z [FF9A2400 info 'Default'] [VpxLRO] 32 max LROs
2011-08-28T14:22:35.468Z [FF9A2400 info 'Default'] [VpxLRO] 0 reserved internal LROs
2011-08-28T14:22:35.468Z [FF9A2400 info 'Default'] [VpxLRO] 0 reserved blocker LROs
2011-08-28T14:22:35.468Z [FF9A2400 info 'Default'] [VpxLRO] 6 reserved short LROs
2011-08-28T14:22:35.468Z [FF9A2400 info 'Default'] [VpxLRO] 2 reserved long LROs
2011-08-28T14:22:35.468Z [FF9A2400 info 'Default'] [VpxLRO] 600-second completed task lifetime
2011-08-28T14:22:35.468Z [FF9A2400 info 'Default'] [VpxLRO] 60-second minimum completed task lifetime
2011-08-28T14:22:35.468Z [FF9A2400 info 'Default'] [VpxLRO] 200 maximum completed tasks
2011-08-28T14:22:35.468Z [FF9A2400 info 'Default'] [VpxLRO] 600-second unregistered task lifetime
2011-08-28T14:22:35.469Z [FF9A2400 info 'ThreadPool'] [SetConfig] Thread info: IoMin: 2, IoMax: 9, TaskMin: 14, TaskMax: 42, Max Thread: 51, Keepalive: 16, thread kill: 600, max fds: -1
2011-08-28T14:22:35.470Z [FF9A2400 verbose 'Notifications'] [Notification::AddListener] Adding listener of type Csi::Notifications::DumpStateChange: Csi::Inventory::InventoryManagerImpl (listeners = 2)
2011-08-28T14:22:35.470Z [FF9A2400 verbose 'Notifications'] [Notification::AddListener] Adding listener of type Csi::Notifications::ClusterConfigChange: Csi::Inventory::InventoryManagerImpl (listeners = 2)
2011-08-28T14:22:35.470Z [FF9A2400 verbose 'Notifications'] [Notification::AddListener] Adding listener of type Csi::Notifications::ClusterConfigChange: Csi::Inventory::Simulator (listeners = 3)
2011-08-28T14:22:35.471Z [FF9A2400 info 'Cluster'] [ClusterPersistence::DoFetchDataSync] Empty persistent store file /etc/opt/vmware/fdm/hostlist
2011-08-28T14:22:35.471Z [FF9A2400 warning 'Cluster'] [ClusterManagerImpl::ReadHostFile] Couldn't open file hostlist
2011-08-28T14:22:35.471Z [FF9A2400 warning 'Cluster'] [ClusterManagerImpl::Initialize] Failed to read host file (ioError 0): Starting with NULL hostlist
2011-08-28T14:22:35.471Z [FF9A2400 verbose 'Cluster'] UpdateLocalHeartbeatInfo: local host  not in cluster list
2011-08-28T14:22:35.472Z [FF9A2400 verbose 'Notifications'] [Notification::AddListener] Adding listener of type Csi::Notifications::HostAgentCnxChange: Csi::Cluster::ClusterElection (listeners = 1)
2011-08-28T14:22:35.472Z [FF9A2400 warning 'Cluster'] Failed to create ipv6 icmp ping socket
2011-08-28T14:22:35.472Z [FF9A2400 info 'Cluster'] [ClusterPersistence::DoFetchDataSync] Empty persistent store file /etc/opt/vmware/fdm/clusterconfig
2011-08-28T14:22:35.472Z [FF9A2400 warning 'Cluster'] [ClusterManagerImpl::ReadPersistentObject] Couldn't open clusterconfig
2011-08-28T14:22:35.472Z [FF9A2400 info 'Cluster'] [ClusterPersistence::DoFetchDataSync] Empty persistent store file /etc/opt/vmware/fdm/compatlist
2011-08-28T14:22:35.472Z [FF9A2400 warning 'Cluster'] [ClusterManagerImpl::ReadPersistentObject] Couldn't open compatlist
2011-08-28T14:22:35.472Z [FF9A2400 verbose 'Notifications'] [Notification::AddListener] Adding listener of type Csi::Notifications::DsStateChange: Csi::Cluster::ClusterManagerImpl (listeners = 1)
2011-08-28T14:22:35.473Z [FF9A2400 verbose 'Notifications'] [Notification::AddListener] Adding listener of type Csi::Notifications::VmStateChange: Csi::Cluster::ClusterManagerImpl (listeners = 1)
2011-08-28T14:22:35.473Z [FF9A2400 verbose 'Notifications'] [Notification::AddListener] Adding listener of type Csi::Notifications::DumpStateChange: Csi::Cluster::ClusterManagerImpl (listeners = 3)
2011-08-28T14:22:35.473Z [FF9A2400 verbose 'Notifications'] [Notification::AddListener] Adding listener of type Csi::Notifications::ClusterConfigChange: Csi::Cluster::ClusterManagerImpl (listeners = 4)
2011-08-28T14:22:35.473Z [FF9A2400 verbose 'Notifications'] [Notification::AddListener] Adding listener of type Csi::Notifications::HostAgentCnxChange: Csi::Cluster::ClusterManagerImpl (listeners = 2)
2011-08-28T14:22:35.473Z [FF9A2400 verbose 'Notifications'] [Notification::AddListener] Adding listener of type Csi::Notifications::ClusterStateChange: Csi::Placement::PlacementManagerImpl::ClusterStateListener (listeners = 2)
2011-08-28T14:22:35.473Z [FF9A2400 verbose 'Notifications'] [Notification::AddListener] Adding listener of type Csi::Notifications::ClusterConfigChange: Csi::Placement::PlacementManagerImpl::ClusterConfigListener (listeners = 5)
2011-08-28T14:22:35.473Z [FF9A2400 verbose 'Notifications'] [Notification::AddListener] Adding listener of type Csi::Notifications::CompatListChange: Csi::Placement::PlacementManagerImpl::CompatListListener (listeners = 1)
2011-08-28T14:22:35.473Z [FF9A2400 verbose 'Notifications'] [Notification::AddListener] Adding listener of type Csi::Notifications::HostStateChange: Csi::Placement::PlacementManagerImpl::HostStateListener (listeners = 1)
2011-08-28T14:22:35.473Z [FF9A2400 verbose 'Notifications'] [Notification::AddListener] Adding listener of type Csi::Notifications::DumpStateChange: Csi::Placement::PlacementManagerImpl::DumpStateListener (listeners = 4)
2011-08-28T14:22:35.473Z [FF9A2400 info 'Placement'] [PlacementManagerImpl::RegisterPlacementEngine] Registered PE default = true, preferred = true, id = 0
2011-08-28T14:22:35.474Z [FF9A2400 verbose 'Execution'] [ActionScheduler] Max concurrency for type 1 is 1
2011-08-28T14:22:35.474Z [FF9A2400 verbose 'Notifications'] [Notification::AddListener] Adding listener of type Csi::Notifications::ClusterStateChange: Csi::Execution::ExecutionManagerImpl::ClusterStateListener (listeners = 3)
2011-08-28T14:22:35.474Z [FF9A2400 verbose 'Notifications'] [Notification::AddListener] Adding listener of type Csi::Notifications::DumpStateChange: Csi::Execution::ExecutionManagerImpl::DumpStateListener (listeners = 5)
2011-08-28T14:22:35.474Z [FF9A2400 verbose 'Notifications'] [Notification::AddListener] Adding listener of type Csi::Notifications::ClusterConfigChange: Csi::Execution::ExecutionManagerImpl::ClusterConfigListener (listeners = 6)
2011-08-28T14:22:35.474Z [FF9A2400 verbose 'Notifications'] [Notification::AddListener] Adding listener of type Csi::Notifications::ExecutionInterrupt: Csi::Execution::ExecutionManagerImpl::ExecutionInterruptListener (listeners = 1)
2011-08-28T14:22:35.474Z [FF9A2400 verbose 'Notifications'] [Notification::AddListener] Adding listener of type Csi::Notifications::ClusterMembershipChange: Csi::Execution::ExecutionManagerImpl (listeners = 1)
2011-08-28T14:22:35.474Z [FF9A2400 verbose 'Policy'] [PolicyManager::Init] Setting up the policy manager subsystem.
2011-08-28T14:22:35.475Z [FF9A2400 verbose 'Policy'] [ClusterConfigCache::Start] Starting the failure manager's clusterConfig cache.
2011-08-28T14:22:35.475Z [FF9A2400 verbose 'Notifications'] [Notification::AddListener] Adding listener of type Csi::Notifications::ClusterConfigChange: Csi::Policies::ClusterConfigCache (listeners = 7)
2011-08-28T14:22:35.475Z [FF9A2400 verbose 'Notifications'] [Notification::AddListener] Adding listener of type Csi::Notifications::ClusterStateChange: Csi::Policies::PolicyManager (listeners = 4)
2011-08-28T14:22:35.475Z [FF9A2400 verbose 'Notifications'] [Notification::AddListener] Adding listener of type Csi::Notifications::DumpStateChange: Csi::Policies::PolicyManager (listeners = 6)
2011-08-28T14:22:35.475Z [FF9A2400 verbose 'Default'] [Inst] Instrumentation service is initialized
2011-08-28T14:22:35.475Z [FF9A2400 verbose 'Notifications'] [Notification::AddListener] Adding listener of type Csi::Notifications::DumpStateChange: Csi::Service::InstrumentationManager::DumpStateListener (listeners = 7)
2011-08-28T14:22:35.475Z [FF9A2400 verbose 'Notifications'] [Notification::AddListener] Adding listener of type Csi::Notifications::ClusterStateChange: Csi::Monitor::IsoAddressMonitor (listeners = 5)
2011-08-28T14:22:35.475Z [FF9A2400 verbose 'Notifications'] [Notification::AddListener] Adding listener of type Csi::Notifications::ClusterConfigChange: Csi::Monitor::IsoAddressMonitor (listeners = 8)
2011-08-28T14:22:35.475Z [FF9A2400 warning 'Cluster'] Failed to create ipv6 icmp ping socket
2011-08-28T14:22:35.475Z [FF9A2400 verbose 'Monitor'] [PingableAddressMonitor::Init] poll interval: 300 Ping reply timeout: 3
2011-08-28T14:22:35.475Z [FF9A2400 verbose 'Notifications'] [Notification::AddListener] Adding listener of type Csi::Notifications::ClusterStateChange: Csi::Monitor::HostAccessMonitor (listeners = 6)
2011-08-28T14:22:35.475Z [FF9A2400 verbose 'Notifications'] [Notification::AddListener] Adding listener of type Csi::Notifications::ClusterConfigChange: Csi::Monitor::HostAccessMonitor (listeners = 9)
2011-08-28T14:22:35.476Z [FF9A2400 warning 'Cluster'] Failed to create ipv6 icmp ping socket
2011-08-28T14:22:35.476Z [FF9A2400 verbose 'Monitor'] [PingableAddressMonitor::Init] poll interval: 300 Ping reply timeout: 3
2011-08-28T14:22:35.476Z [FF9A2400 verbose 'Notifications'] [Notification::AddListener] Adding listener of type Csi::Notifications::ClusterMembershipChange: Csi::Monitor::HostAccessMonitor (listeners = 2)
2011-08-28T14:22:35.476Z [FF9A2400 verbose 'HalCnx'] [HalCnx] Creating temporary connect spec: localhost:443
2011-08-28T14:22:35.476Z [FF9A2400 verbose 'HttpConnectionPool'] HttpConnectionPoolImpl created. maxPoolConnections = 20; idleTimeout = 900000000; maxOpenConnections = 100; maxConnectionAge = 0
2011-08-28T14:22:35.485Z [FFD40B90 warning 'Libs'] SSL_VerifyX509: Certificate verification is disabled, so connection will proceed despite the error
2011-08-28T14:22:35.485Z [FFD40B90 warning 'Libs'] SSL_VerifyX509: Certificate verification is disabled, so connection will proceed despite the error
2011-08-28T14:22:35.485Z [FFD40B90 warning 'Libs'] SSL_VerifyX509: Certificate verification is disabled, so connection will proceed despite the error
2011-08-28T14:22:35.504Z [FF9A2400 verbose 'Default'] [VpxVim] Local and Remote Version are the same. Talking with version vim.version.version7
2011-08-28T14:22:35.504Z [FF9A2400 verbose 'HalCnx'] [HalCnx] Connecting to hostd with version vim.version.version7
2011-08-28T14:22:35.508Z [FF9A2400 verbose 'HalCnx'] [HostdMonitor] Connecting to hostd
2011-08-28T14:22:35.508Z [FF9A2400 verbose 'HttpConnectionPool'] HttpConnectionPoolImpl created. maxPoolConnections = 1; idleTimeout = 900000000; maxOpenConnections = 1; maxConnectionAge = 0
2011-08-28T14:22:35.510Z [FFA87B90 warning 'Libs'] SSL_VerifyX509: Certificate verification is disabled, so connection will proceed despite the error
2011-08-28T14:22:35.510Z [FFA87B90 warning 'Libs'] SSL_VerifyX509: Certificate verification is disabled, so connection will proceed despite the error
2011-08-28T14:22:35.510Z [FFA87B90 warning 'Libs'] SSL_VerifyX509: Certificate verification is disabled, so connection will proceed despite the error
2011-08-28T14:22:35.511Z [FF9A2400 verbose 'HalCnx'] [HalCnx] Logging in with local ticket for vpxuser
2011-08-28T14:22:35.542Z [FF9A2400 verbose 'Default'] [VpxVim] Local and Remote Version are the same. Talking with version vim.version.version7
2011-08-28T14:22:35.542Z [FF9A2400 verbose 'HalCnx'] [HalCnx] Connecting to hostd with version vim.version.version7
2011-08-28T14:22:35.548Z [FF9A2400 verbose 'HalCnx'] Found service instance vim.ServiceInstance:ServiceInstance
2011-08-28T14:22:35.548Z [FF9A2400 verbose 'HttpConnectionPool'] HttpConnectionPoolImpl created. maxPoolConnections = 1; idleTimeout = 900000000; maxOpenConnections = 1; maxConnectionAge = 0
2011-08-28T14:22:35.554Z [FF9A2400 verbose 'HalCnx'] Retrieved service content
2011-08-28T14:22:35.556Z [FF9A2400 verbose 'HalCnx'] Retrieved internal service content
2011-08-28T14:22:35.556Z [FF9A2400 verbose 'HalCnx'] Found session manager vim.SessionManager:ha-sessionmgr
2011-08-28T14:22:35.557Z [FF9A2400 verbose 'HalCnx'] Found perf manager vim.PerformanceManager:ha-perfmgr
2011-08-28T14:22:35.557Z [FF9A2400 verbose 'HalCnx'] Found root folder vim.Folder:ha-folder-root
2011-08-28T14:22:35.559Z [FF9A2400 verbose 'HalCnx'] Found data center vim.Datacenter:ha-datacenter
2011-08-28T14:22:35.561Z [FF9A2400 verbose 'HalCnx'] Found vm folder vim.Folder:ha-folder-vm
2011-08-28T14:22:35.563Z [FF9A2400 verbose 'HalCnx'] Found host folder vim.Folder:ha-folder-host
2011-08-28T14:22:35.564Z [FF9A2400 verbose 'HalCnx'] Found compute resource vim.ComputeResource:ha-compute-res
2011-08-28T14:22:35.569Z [FF9A2400 verbose 'HalCnx'] Found resource pool vim.ResourcePool:ha-root-pool
2011-08-28T14:22:35.571Z [FF9A2400 verbose 'HalCnx'] Found host system vim.HostSystem:ha-host
2011-08-28T14:22:35.574Z [FF9A2400 verbose 'HalCnx'] Retrieved config manager
2011-08-28T14:22:35.574Z [FF9A2400 verbose 'HalCnx'] Found firewall system
2011-08-28T14:22:35.574Z [FF9A2400 verbose 'HalCnx'] Found firmware system
2011-08-28T14:22:35.574Z [FF9A2400 verbose 'HalCnx'] Found service system
2011-08-28T14:22:35.574Z [FF9A2400 verbose 'HalCnx'] Found memory manager system vim.host.MemoryManagerSystem:memoryManagerSystem
2011-08-28T14:22:35.576Z [FF9A2400 verbose 'HalCnx'] Retrieved internal config manager
2011-08-28T14:22:35.577Z [FF9A2400 verbose 'HalCnx'] Set SystemDebugManager
2011-08-28T14:22:35.577Z [FF9A2400 verbose 'HalCnx'] Found service manager vim.ServiceManager:ha-servicemanager
2011-08-28T14:22:35.577Z [FF9A2400 verbose 'HalCnx'] [HalCnx] Retrieved fault tolerant manager
2011-08-28T14:22:35.577Z [FF9A2400 verbose 'HalCnx'] [HalCnx] Retrieved Host Dvs manager
2011-08-28T14:22:35.577Z [FF9A2400 verbose 'HalCnx'] [HalCnx] Retrieved proxy service
2011-08-28T14:22:35.579Z [FF9A2400 verbose 'HalCnx'] [HalCnx] Http proxy port: 80
2011-08-28T14:22:35.579Z [FFE85B90 verbose 'Invt' opID=SWI-dbea2c5] [InventoryManagerImpl::ProcessHostAgentCnxChange] Connected to hostd
2011-08-28T14:22:35.580Z [FFE85B90 verbose 'Hal' opID=SWI-dbea2c5] [StatsProviderImpl::SchedulePolling] No stats listeners! Nothing to do!
2011-08-28T14:22:35.580Z [FFE85B90 verbose 'Election' opID=SWI-dbea2c5] [ClusterElection::Handle(HostAgentCnxNotification)] Connected to the host agent
2011-08-28T14:22:35.580Z [FFE85B90 verbose 'Cluster' opID=SWI-dbea2c5] [ClusterManagerImpl::Handle] Processing host cnx notification
2011-08-28T14:22:35.580Z [FFE85B90 verbose 'Cluster' opID=SWI-dbea2c5] [VmfsUtils::HostdConnected]
2011-08-28T14:22:35.580Z [FFE85B90 verbose 'Cluster' opID=SWI-dbea2c5] [VmfsUtils::HostdConnected] Version 5.0.0 Build 469512
2011-08-28T14:22:35.580Z [FFE85B90 verbose 'Cluster' opID=SWI-dbea2c5] [VmfsUtils::HostdConnected] Looking up 7 functions
-->
2011-08-28T14:22:35.581Z [FFE85B90 verbose 'Cluster' opID=SWI-dbea2c5] [VmfsUtils::HostdConnected] looked up all functions successfully
-->
2011-08-28T14:22:35.581Z [FFE85B90 info 'Cluster' opID=SWI-dbea2c5] [VmfsUtils::HostdConnected] mac addr in UUID for localhost 00:0c:29:d3:6a:a5
2011-08-28T14:22:35.595Z [FFE85B90 info 'Cluster' opID=SWI-dbea2c5] [ClusterManagerImpl::SetIsolationAddresses] Adding isolation address 10.0.0.1
2011-08-28T14:22:35.596Z [FFAC8B90 verbose 'Cluster' opID=SWI-197778c1] ClusterManagerImpl::UpdateSslThumbprintInfo: 0 thumbprints are to be added, 0 thumbprints are to be removed, number thumbprints changes from 0 to 0
2011-08-28T14:22:35.596Z [FFAC8B90 verbose 'Invt' opID=SWI-197778c1] [UpdateHostSslThumbprints] Push thumbprints using add(0)/remove(0) semantic
2011-08-28T14:22:36.898Z [FF9A2400 info 'Hal'] [FdmInvtHost] AtomicUseFence = 0
2011-08-28T14:22:36.898Z [FF9A2400 info 'Cluster'] [ClusterManagerImpl::ListenForMessages] Listening for connections on port 8182
2011-08-28T14:22:36.898Z [FF9A2400 info 'Message'] Binding to :8182
2011-08-28T14:22:36.899Z [FF9A2400 verbose 'Default'] [LogsvcManager] Handling ClusterConfigNotification
2011-08-28T14:22:36.899Z [FF9A2400 verbose 'Invt'] [InventoryManagerImpl::Handle(ClusterConfigNotification)] Processing cluster config
2011-08-28T14:22:36.899Z [FF9A2400 verbose 'Simulator'] [Processing cluster config
2011-08-28T14:22:36.899Z [FF9A2400 verbose 'Simulator'] numPowerOpsPerMinute=0, numResOpsPerMinute=0, sendInterval=0
2011-08-28T14:22:36.899Z [FF9A2400 verbose 'Simulator'] waitTime=60000, numPowerOps=0, numResOps=0
2011-08-28T14:22:36.899Z [FF9A2400 verbose 'Cluster'] Processing cluster config
2011-08-28T14:22:36.903Z [FFF89B90 warning 'Election' opID=SWI-2e07db11] [ClusterElection::UpdateHostListWork] localhost not in new host list
2011-08-28T14:22:36.903Z [FFF89B90 info 'Election' opID=SWI-2e07db11] Not running election
2011-08-28T14:22:36.946Z [FF9A2400 info 'Cluster'] [ClusterManagerImpl::SetIsolationAddresses] Adding isolation address 10.0.0.1
2011-08-28T14:22:36.946Z [FF9A2400 info 'Placement'] [PlacementManagerImpl::ClusterConfigListener::Handle] Get a new cluster config
2011-08-28T14:22:36.946Z [FF9A2400 verbose 'Placement'] [PlacementManagerImpl::ProcessClusterConfig] Finish processing new config
2011-08-28T14:22:36.946Z [FF9A2400 verbose 'Execution'] [ExecutionManagerImpl::ClusterConfigListener::Handle] Get a new cluster config
2011-08-28T14:22:36.946Z [FF9A2400 info 'Execution'] [ExecutionManagerImpl::ProcessClusterConfig] Update _dasOptions
2011-08-28T14:22:36.946Z [FF9A2400 verbose 'Execution'] [ActionScheduler] Max concurrency for type 0 is 32
2011-08-28T14:22:36.946Z [FF9A2400 verbose 'Execution'] [ExecutionManagerImpl::ProcessClusterConfig] Finish processing new config
2011-08-28T14:22:36.947Z [FF9A2400 verbose 'Monitor'] [PingableAddressMonitor::Handle::ClusterConfigNotification] Got a cluster config change
2011-08-28T14:22:36.947Z [FF9A2400 verbose 'Monitor'] [PingableAddressMonitor::Handle::ClusterConfigNotification] Got a cluster config change
2011-08-28T14:22:36.947Z [FF9A2400 info 'Execution'] [ExecutionManagerImpl::ProcessHostInfo] abortFailoverOnCleanPowerOff changed to true
2011-08-28T14:22:36.947Z [FF9A2400 info 'Monitor'] [HostAccessMonitor::ClusterMembershipListener] Cluster membership changed
2011-08-28T14:22:36.948Z [63314B90 verbose 'Invt' opID=SWI-59cfba2] [InventoryManagerImpl::ProcessHostCompatList] processing compat list version:0
2011-08-28T14:22:36.948Z [63314B90 info 'Placement' opID=SWI-59cfba2] [PlacementManagerImpl::CompatListListener::Handle] Get a new compat list
2011-08-28T14:22:36.949Z [FF9A2400 info 'SoapAdapter.HTTPService'] Using default for nonChunkingAgents: 'VMware VI Client|VMware-client|VMware-client/3.*'
2011-08-28T14:22:36.949Z [FF9A2400 info 'SoapAdapter.HTTPService'] Using default for agentsNeedingContentLength: 'VMware-client'
2011-08-28T14:22:36.949Z [FF9A2400 info 'SoapAdapter.HTTPService'] Max buffered response size is 104857600 bytes
2011-08-28T14:22:36.949Z [FF9A2400 warning 'Default'] Document root directory not found at /etc/opt/vmware/fdm/docRoot
2011-08-28T14:22:36.949Z [FF9A2400 info 'SoapAdapter.HTTPService'] Using default for nonChunkingAgents: 'VMware VI Client|VMware-client|VMware-client/3.*'
2011-08-28T14:22:36.949Z [FF9A2400 info 'SoapAdapter.HTTPService'] Using default for agentsNeedingContentLength: 'VMware-client'
2011-08-28T14:22:36.949Z [FF9A2400 info 'SoapAdapter.HTTPService'] Max buffered response size is 104857600 bytes
2011-08-28T14:22:36.949Z [FF9A2400 info 'SoapAdapter'] enableChunkedResponses: true
2011-08-28T14:22:36.949Z [FF9A2400 info 'Libs'] UUID: Unable to open /dev/mem: No such file or directory
2011-08-28T14:22:36.949Z [FF9A2400 info 'Libs'] UUID: Valid gethostid routine. Value = 10A1700.
2011-08-28T14:22:36.950Z [FF9A2400 info 'SoapAdapter.HTTPService'] Http Service started: TCPServerSocket(ASYNC_ACCEPT, ipv4=TCP(fd=21 name=127.0.0.1:9089), ipv6=TCP(null))
2011-08-28T14:22:36.950Z [FF9A2400 info 'Default'] [VpxVmomi] SOAP adapter started on port 9089
2011-08-28T14:22:36.950Z [FF9A2400 info 'DebugBrowser.HTTPService'] Using default for nonChunkingAgents: 'VMware VI Client|VMware-client|VMware-client/3.*'
2011-08-28T14:22:36.950Z [FF9A2400 info 'DebugBrowser.HTTPService'] Using default for agentsNeedingContentLength: 'VMware-client'
2011-08-28T14:22:36.950Z [FF9A2400 info 'DebugBrowser.HTTPService'] Max buffered response size is 104857600 bytes
2011-08-28T14:22:36.950Z [FF9A2400 verbose 'DebugBrowser'] Max POST request size: 1024 KB
2011-08-28T14:22:36.951Z [FF9A2400 info 'DebugBrowser.HTTPService'] Http Service started: TCPServerSocket(ASYNC_ACCEPT, ipv4=TCP(fd=22 name=127.0.0.1:9090), ipv6=TCP(null))
2011-08-28T14:22:36.951Z [FF9A2400 info 'Default'] [FdmVmomi] MOB started on port 9090
2011-08-28T14:22:36.951Z [FF9A2400 info 'Memory checker'] Check resources every 30 secs, soft limit 204800, hard limit 256000.
2011-08-28T14:22:36.951Z [FF9A2400 info 'Handle checker'] Setting system limit of 1024
2011-08-28T14:22:36.951Z [FF9A2400 info 'Handle checker'] Set system limit to 1024
2011-08-28T14:22:37.904Z [FFDC2B90 info 'Cluster' opID=SWI-e5c33ba4] [ClusterManagerImpl::MainLoop] curState 0 lastState
2011-08-28T14:22:38.286Z [FFE44B90 verbose 'Invt' opID=SWI-9d362d10] [HostStateChange::SaveToInventory] host __localhost__ changed version: 5.0.0
2011-08-28T14:22:38.286Z [FFE44B90 verbose 'Invt' opID=SWI-9d362d10] [HostStateChange::SaveToInventory] host __localhost__ changed maxVm: 14
2011-08-28T14:22:38.286Z [FFE44B90 verbose 'Invt' opID=SWI-9d362d10] [HostStateChange::SaveToInventory] host __localhost__ changed maxVCpu: 50
2011-08-28T14:22:38.291Z [FFAC8B90 verbose 'Invt'] [HalDsMonitor::IsSupportedDatastore] Checking datastore datastore1 (1)
2011-08-28T14:22:38.291Z [FFAC8B90 verbose 'Invt'] [HalDsMonitor::IsSupportedDatastore] Checking backing of disk mpx.vmhba1:C0:T0:L0
2011-08-28T14:22:38.291Z [FFAC8B90 verbose 'Invt'] [HalDsMonitor::IsSupportedDatastore] Head partition = /vmfs/devices/disks/mpx.vmhba1:C0:T0:L0:3
2011-08-28T14:22:38.295Z [FFAC8B90 verbose 'Invt'] [HalDsMonitor::HandleDsAdd] Datastore added: name=datastore1 (1), path=/vmfs/volumes/4e46fa14-22f09d6f-3454-000c29d36aa5 accessible=true
2011-08-28T14:22:38.298Z [FFAC8B90 verbose 'Invt'] [HalDsMonitor::IsSupportedDatastore] Checking datastore LUN0
2011-08-28T14:22:38.298Z [FFAC8B90 verbose 'Invt'] [HalDsMonitor::IsSupportedDatastore] Checking backing of disk t10.9454450000000000000000001000000027E30000F0000000
2011-08-28T14:22:38.298Z [FFAC8B90 verbose 'Invt'] [HalDsMonitor::IsSupportedDatastore] Head partition = /vmfs/devices/disks/t10.9454450000000000000000001000000027E30000F0000000:1
2011-08-28T14:22:38.299Z [FFAC8B90 verbose 'Invt'] [HalDsMonitor::HandleDsAdd] Datastore added: name=LUN0, path=/vmfs/volumes/4e59da67-98a9e364-fff8-000c295b51ae accessible=true
2011-08-28T14:22:38.328Z [FFAC8B90 verbose 'Invt'] [HalDsMonitor::IsSupportedDatastore] Checking datastore LUN1
2011-08-28T14:22:38.328Z [FFAC8B90 verbose 'Invt'] [HalDsMonitor::IsSupportedDatastore] Checking backing of disk t10.9454450000000000000000001000000035F30000F0000000
2011-08-28T14:22:38.328Z [FFAC8B90 verbose 'Invt'] [HalDsMonitor::IsSupportedDatastore] Head partition = /vmfs/devices/disks/t10.9454450000000000000000001000000035F30000F0000000:1
2011-08-28T14:22:38.335Z [FFAC8B90 verbose 'Invt'] [HalDsMonitor::HandleDsAdd] Datastore added: name=LUN1, path=/vmfs/volumes/4e59da7b-e1974b2a-2f64-000c295b51ae accessible=true
2011-08-28T14:22:38.336Z [FFAC8B90 verbose 'Invt' opID=SWI-b145eae3] [DsStateChange::SaveToInventory] Processing add update for /vmfs/volumes/4e46fa14-22f09d6f-3454-000c29d36aa5 (4e46fa14-22f09d6f-3454-000c29d36aa5) from __localhost__
2011-08-28T14:22:38.337Z [FFAC8B90 info 'Invt' opID=SWI-b145eae3] [DsStateChange::SaveToInventory] datastore (/vmfs/volumes/4e46fa14-22f09d6f-3454-000c29d36aa5) is accessible to __localhost__.
2011-08-28T14:22:38.337Z [FFAC8B90 verbose 'Invt' opID=SWI-b145eae3] [DsStateChange::SaveToInventory] Processing add update for /vmfs/volumes/4e59da67-98a9e364-fff8-000c295b51ae (4e59da67-98a9e364-fff8-000c295b51ae) from __localhost__
2011-08-28T14:22:38.337Z [FFAC8B90 info 'Invt' opID=SWI-b145eae3] [DsStateChange::SaveToInventory] datastore (/vmfs/volumes/4e59da67-98a9e364-fff8-000c295b51ae) is accessible to __localhost__.
2011-08-28T14:22:38.337Z [FFAC8B90 verbose 'Invt' opID=SWI-b145eae3] [DsStateChange::SaveToInventory] Processing add update for /vmfs/volumes/4e59da7b-e1974b2a-2f64-000c295b51ae (4e59da7b-e1974b2a-2f64-000c295b51ae) from __localhost__
2011-08-28T14:22:38.337Z [FFAC8B90 info 'Invt' opID=SWI-b145eae3] [DsStateChange::SaveToInventory] datastore (/vmfs/volumes/4e59da7b-e1974b2a-2f64-000c295b51ae) is accessible to __localhost__.
2011-08-28T14:22:38.905Z [FFDC2B90 info 'Cluster' opID=SWI-e5c33ba4] [ClusterManagerImpl::AddDatastore] path=/vmfs/volumes/4e46fa14-22f09d6f-3454-000c29d36aa5 mountHost= type=2 accessible=true
2011-08-28T14:22:38.905Z [FFDC2B90 info 'Cluster' opID=SWI-e5c33ba4] [ClusterManagerImpl::AddDatastore] adding local datastore /vmfs/volumes/4e46fa14-22f09d6f-3454-000c29d36aa5
2011-08-28T14:22:38.905Z [FFDC2B90 info 'Cluster' opID=SWI-e5c33ba4] [ClusterManagerImpl::AddDatastore] path=/vmfs/volumes/4e59da67-98a9e364-fff8-000c295b51ae mountHost= type=2 accessible=true
2011-08-28T14:22:38.905Z [FFDC2B90 info 'Cluster' opID=SWI-e5c33ba4] [ClusterManagerImpl::AddDatastore] adding local datastore /vmfs/volumes/4e59da67-98a9e364-fff8-000c295b51ae
2011-08-28T14:22:38.905Z [FFDC2B90 info 'Cluster' opID=SWI-e5c33ba4] [ClusterManagerImpl::AddDatastore] path=/vmfs/volumes/4e59da7b-e1974b2a-2f64-000c295b51ae mountHost= type=2 accessible=true
2011-08-28T14:22:38.905Z [FFDC2B90 info 'Cluster' opID=SWI-e5c33ba4] [ClusterManagerImpl::AddDatastore] adding local datastore /vmfs/volumes/4e59da7b-e1974b2a-2f64-000c295b51ae
2011-08-28T14:22:38.905Z [FFF89B90 info 'Election' opID=SWI-2e07db11] Not running election
2011-08-28T14:23:04.316Z [FFD81B90 info 'Libs'] UUID: Unable to open /dev/mem: No such file or directory
2011-08-28T14:23:04.316Z [FFD81B90 info 'Libs'] UUID: Unable to open /dev/mem: No such file or directory
2011-08-28T14:23:04.318Z [FFD81B90 verbose 'Default'] [VpxLroList::ThreadMainEntry] Unlocked _propProvider to call into external code
2011-08-28T14:23:04.318Z [FFD81B90 verbose 'Default'] [VpxLRO::LroMain] Invoking _currentMain
2011-08-28T14:23:04.318Z [FFD81B90 info 'Default' opID=E995B4F1-000003C7-97-cf] [VpxLRO] -- BEGIN task-internal-1 --  -- csi.FdmService.login -- 5264ad99-bdda-b795-0907-a00f99c57a5a
2011-08-28T14:23:04.323Z [FFE03B90 warning 'Libs'] SSL_VerifyX509: Certificate verification is disabled, so connection will proceed despite the error
2011-08-28T14:23:04.323Z [FFE03B90 warning 'Libs'] SSL_VerifyX509: Certificate verification is disabled, so connection will proceed despite the error
2011-08-28T14:23:04.323Z [FFE03B90 warning 'Libs'] SSL_VerifyX509: Certificate verification is disabled, so connection will proceed despite the error
2011-08-28T14:23:04.345Z [FFD81B90 verbose 'HttpConnectionPool' opID=E995B4F1-000003C7-97-cf] HttpConnectionPoolImpl created. maxPoolConnections = 1; idleTimeout = 900000000; maxOpenConnections = 1; maxConnectionAge = 0
2011-08-28T14:23:04.346Z [FFEC6B90 warning 'Libs'] SSL_VerifyX509: Certificate verification is disabled, so connection will proceed despite the error
2011-08-28T14:23:04.347Z [FFEC6B90 warning 'Libs'] SSL_VerifyX509: Certificate verification is disabled, so connection will proceed despite the error
2011-08-28T14:23:04.347Z [FFEC6B90 warning 'Libs'] SSL_VerifyX509: Certificate verification is disabled, so connection will proceed despite the error
2011-08-28T14:23:04.438Z [FFD81B90 info 'vmomi.soapStub[2]' opID=E995B4F1-000003C7-97-cf] Resetting stub adapter for server TCP:localhost:443 : Closed
2011-08-28T14:23:04.439Z [FFD81B90 verbose 'HalCnx' opID=E995B4F1-000003C7-97-cf] [HalCnx] Authenticate succeeded: userName=vpxuser
2011-08-28T14:23:04.439Z [FFD81B90 info 'Default' opID=E995B4F1-000003C7-97-cf] [VpxLRO] -- FINISH task-internal-1 --  -- csi.FdmService.login -- 5264ad99-bdda-b795-0907-a00f99c57a5a
2011-08-28T14:23:04.439Z [FFD81B90 verbose 'Default'] [VpxLRO::ClearCurrentMain] Clearing _currentMain
2011-08-28T14:23:04.445Z [FFD40B90 verbose 'Default'] [VpxLroList::ThreadMainEntry] Unlocked _propProvider to call into external code
2011-08-28T14:23:04.446Z [FFD40B90 verbose 'Default'] [VpxLRO::LroMain] Invoking _currentMain
2011-08-28T14:23:04.446Z [FFD40B90 info 'Default' opID=E995B4F1-000003C7-97-b7] [VpxLRO] -- BEGIN task-internal-2 --  -- csi.FdmService.retrieveClusterInfo -- 5264ad99-bdda-b795-0907-a00f99c57a5a
2011-08-28T14:23:04.446Z [FFD40B90 info 'Default' opID=E995B4F1-000003C7-97-b7] [VpxLRO] -- FINISH task-internal-2 --  -- csi.FdmService.retrieveClusterInfo -- 5264ad99-bdda-b795-0907-a00f99c57a5a
2011-08-28T14:23:04.446Z [FFD40B90 verbose 'Default'] [VpxLRO::ClearCurrentMain] Clearing _currentMain
2011-08-28T14:23:04.462Z [FFD81B90 verbose 'Default'] [VpxLroList::ThreadMainEntry] Unlocked _propProvider to call into external code
2011-08-28T14:23:04.462Z [FFD81B90 verbose 'Default'] [VpxLRO::LroMain] Invoking _currentMain
2011-08-28T14:23:04.463Z [FFD81B90 info 'Default' opID=E995B4F1-000003C7-97-d8] [VpxLRO] -- BEGIN task-internal-3 --  -- csi.FdmService.setHostList -- 5264ad99-bdda-b795-0907-a00f99c57a5a
2011-08-28T14:23:04.463Z [FFD81B90 verbose 'Cluster' opID=E995B4F1-000003C7-97-d8] [ClusterManagerImpl::UpdateMembershipListInt] Fault domain id changed from  to 0DE334B1-2277-4BDE-A3B6-176C9157B060-19-3596749-vCenter
2011-08-28T14:23:04.463Z [FFD81B90 info 'Cluster' opID=E995B4F1-000003C7-97-d8] [ClusterManagerImpl::UpdateMembershipListInt] Old host version (2 >? 0)
2011-08-28T14:23:04.463Z [FFD81B90 verbose 'Cluster' opID=E995B4F1-000003C7-97-d8] Adding host host-13
2011-08-28T14:23:04.463Z [FFD81B90 verbose 'Cluster' opID=E995B4F1-000003C7-97-d8] Adding host host-9
2011-08-28T14:23:04.463Z [FFD81B90 verbose 'Cluster' opID=E995B4F1-000003C7-97-d8] [ClusterManagerImpl::UpdateMembershipListInt] toWrite.length 1396 data.length 1396
2011-08-28T14:23:04.463Z [FFD81B90 info 'Cluster' opID=E995B4F1-000003C7-97-d8] [ClusterManagerImpl::UpdateMembershipListInt] Updating election state
2011-08-28T14:23:04.463Z [FFD81B90 info 'Cluster' opID=E995B4F1-000003C7-97-d8] [ClusterManagerImpl::UpdateMembershipListInt] Updating SSL Thumbprints
2011-08-28T14:23:04.463Z [FFD81B90 verbose 'Cluster' opID=E995B4F1-000003C7-97-d8] ClusterManagerImpl::UpdateSslThumbprintInfo: 2 thumbprints are to be added, 0 thumbprints are to be removed, number thumbprints changes from 0 to 2
2011-08-28T14:23:04.463Z [FFD81B90 verbose 'Invt' opID=E995B4F1-000003C7-97-d8] [UpdateHostSslThumbprints] Push thumbprints using add(2)/remove(0) semantic
2011-08-28T14:23:04.463Z [FFF89B90 verbose 'Election' opID=SWI-2e07db11] [ClusterElection::UpdateHostListWork] Opening IPv4 socket
2011-08-28T14:23:04.464Z [FFF89B90 verbose 'Election' opID=SWI-2e07db11] [ClusterElection::SetupSocket] Default send buffer size is 9216 msg size 284
2011-08-28T14:23:04.464Z [FFF89B90 verbose 'Election' opID=SWI-2e07db11] [ClusterElection::SetupSocket] Set send buffer size to 65536 bytes
2011-08-28T14:23:04.464Z [FFF89B90 verbose 'Election' opID=SWI-2e07db11] [ClusterElection::SetupSocket] New send buffer size is 65536
2011-08-28T14:23:04.464Z [FFF89B90 info 'Election' opID=SWI-2e07db11] Not running election
2011-08-28T14:23:04.464Z [FFF07B90 info 'Cluster' opID=E995B4F1-000003C7-97-d8-SWI-b5fd328a] [ClusterManagerImpl::StoreDone] Wrote hostlist version 2
2011-08-28T14:23:04.464Z [FFF89B90 verbose 'HalCnx' opID=SWI-2e07db11] [HalCnx] Configuring firewall to open tcp(8182) and udp(8182)
2011-08-28T14:23:04.466Z [FFD81B90 info 'Monitor' opID=E995B4F1-000003C7-97-d8] [HostAccessMonitor::ClusterMembershipListener] Cluster membership changed
2011-08-28T14:23:04.466Z [FFD81B90 info 'Default' opID=E995B4F1-000003C7-97-d8] [VpxLRO] -- FINISH task-internal-3 --  -- csi.FdmService.setHostList -- 5264ad99-bdda-b795-0907-a00f99c57a5a
2011-08-28T14:23:04.467Z [FFD81B90 verbose 'Default'] [VpxLRO::ClearCurrentMain] Clearing _currentMain
2011-08-28T14:23:04.473Z [FFF89B90 verbose 'HalCnx' opID=SWI-2e07db11] [HalCnx] Enabling fdm firewall ruleset
2011-08-28T14:23:04.476Z [FFA87B90 verbose 'Default'] [VpxLroList::ThreadMainEntry] Unlocked _propProvider to call into external code
2011-08-28T14:23:04.476Z [FFA87B90 verbose 'Default'] [VpxLRO::LroMain] Invoking _currentMain
2011-08-28T14:23:04.476Z [FFA87B90 info 'Default' opID=E995B4F1-000003C7-97-5e] [VpxLRO] -- BEGIN task-internal-4 --  -- csi.FdmService.setClusterConfig -- 5264ad99-bdda-b795-0907-a00f99c57a5a
2011-08-28T14:23:04.476Z [FFA87B90 verbose 'Cluster' opID=E995B4F1-000003C7-97-5e] [ClusterManagerImpl::SetClusterConfig] version 3
2011-08-28T14:23:04.479Z [FFA87B90 verbose 'Cluster' opID=E995B4F1-000003C7-97-5e] [ClusterManagerImpl::Compress] compressed from size 1674 to size 658 (max 1685)
2011-08-28T14:23:04.479Z [FFA87B90 verbose 'Cluster' opID=E995B4F1-000003C7-97-5e] [ClusterManagerImpl::UpdatePersistentObject] name clusterconfig version (3 ?> 0) force true
2011-08-28T14:23:04.480Z [FFA87B90 verbose 'Default' opID=E995B4F1-000003C7-97-5e] [LogsvcManager] Handling ClusterConfigNotification
2011-08-28T14:23:04.480Z [FFA87B90 verbose 'Invt' opID=E995B4F1-000003C7-97-5e] [InventoryManagerImpl::Handle(ClusterConfigNotification)] Processing cluster config
2011-08-28T14:23:04.480Z [FFA87B90 verbose 'Invt' opID=E995B4F1-000003C7-97-5e] [InventoryManagerImpl::UpdateAgentVms] Number of required agents vms changed to 0.
2011-08-28T14:23:04.480Z [FFA87B90 verbose 'Simulator' opID=E995B4F1-000003C7-97-5e] [Processing cluster config
2011-08-28T14:23:04.480Z [FFA87B90 verbose 'Simulator' opID=E995B4F1-000003C7-97-5e] numPowerOpsPerMinute=0, numResOpsPerMinute=0, sendInterval=0
2011-08-28T14:23:04.480Z [FFA87B90 verbose 'Simulator' opID=E995B4F1-000003C7-97-5e] waitTime=60000, numPowerOps=0, numResOps=0
2011-08-28T14:23:04.480Z [FFA87B90 verbose 'Cluster' opID=E995B4F1-000003C7-97-5e] Processing cluster config
2011-08-28T14:23:04.480Z [FFE85B90 info 'Cluster' opID=E995B4F1-000003C7-97-5e-SWI-785e34a0] [ClusterManagerImpl::StoreDone] Wrote cluster-config version 3
2011-08-28T14:23:04.489Z [FFA87B90 info 'Cluster' opID=E995B4F1-000003C7-97-5e] [ClusterManagerImpl::SetIsolationAddresses] Adding isolation address 10.0.0.1
2011-08-28T14:23:04.489Z [FFA87B90 info 'Placement' opID=E995B4F1-000003C7-97-5e] [PlacementManagerImpl::ClusterConfigListener::Handle] Get a new cluster config
2011-08-28T14:23:04.489Z [FFA87B90 info 'Placement' opID=E995B4F1-000003C7-97-5e] [PlacementManagerImpl::ProcessClusterConfig] Failover is enabled
2011-08-28T14:23:04.489Z [FFA87B90 info 'Placement' opID=E995B4F1-000003C7-97-5e] [PlacementManagerImpl::ProcessClusterConfig] Host monitoring is enabled
2011-08-28T14:23:04.489Z [FFA87B90 info 'Placement' opID=E995B4F1-000003C7-97-5e] [PlacementManagerImpl::ProcessClusterConfig] Update _dasOptions
2011-08-28T14:23:04.489Z [FFA87B90 info 'Placement' opID=E995B4F1-000003C7-97-5e] [PlacementManagerImpl::ProcessClusterConfig] Update clusterVmDefaults
2011-08-28T14:23:04.489Z [FFA87B90 info 'Placement' opID=E995B4F1-000003C7-97-5e] [PlacementManagerImpl::ProcessClusterConfig] 0 failover hosts specified
2011-08-28T14:23:04.489Z [FFA87B90 verbose 'Placement' opID=E995B4F1-000003C7-97-5e] [PlacementManagerImpl::ProcessClusterConfig] Finish processing new config
2011-08-28T14:23:04.489Z [FFA87B90 verbose 'Execution' opID=E995B4F1-000003C7-97-5e] [ExecutionManagerImpl::ClusterConfigListener::Handle] Get a new cluster config
2011-08-28T14:23:04.489Z [FFA87B90 info 'Execution' opID=E995B4F1-000003C7-97-5e] [ExecutionManagerImpl::ProcessClusterConfig] Update _dasOptions
2011-08-28T14:23:04.489Z [FFA87B90 verbose 'Execution' opID=E995B4F1-000003C7-97-5e] [ActionScheduler] Max concurrency for type 0 is 32
2011-08-28T14:23:04.489Z [FFA87B90 verbose 'Execution' opID=E995B4F1-000003C7-97-5e] [ExecutionManagerImpl::ProcessClusterConfig] Finish processing new config
2011-08-28T14:23:04.489Z [FFA87B90 verbose 'Monitor' opID=E995B4F1-000003C7-97-5e] [PingableAddressMonitor::Handle::ClusterConfigNotification] Got a cluster config change
2011-08-28T14:23:04.489Z [FFA87B90 verbose 'Monitor' opID=E995B4F1-000003C7-97-5e] [PingableAddressMonitor::Handle::ClusterConfigNotification] Got a cluster config change
2011-08-28T14:23:04.489Z [FF9A2400 info 'Policy' opID=E995B4F1-000003C7-97-5e-SWI-365dc7d7] [ClusterConfigCache::ProcessElements(ClusterConfigChange)] Failover is enabled
2011-08-28T14:23:04.490Z [FF9A2400 info 'Policy' opID=E995B4F1-000003C7-97-5e-SWI-365dc7d7] [ClusterConfigCache::ProcessElements(ClusterConfigChange)] Host monitoring is enabled
2011-08-28T14:23:04.490Z [FF9A2400 verbose 'Policy' opID=E995B4F1-000003C7-97-5e-SWI-365dc7d7] [ClusterConfigCache::ParseVmMonitoringConfiguration] VM guest OS monitoring is disabled
2011-08-28T14:23:04.490Z [FF9A2400 verbose 'Policy' opID=E995B4F1-000003C7-97-5e-SWI-365dc7d7] [ClusterConfigCache::ParseVmMonitoringConfiguration] VM application monitoring is disabled
2011-08-28T14:23:04.490Z [FF9A2400 info 'Policy' opID=E995B4F1-000003C7-97-5e-SWI-365dc7d7] [ClusterConfigCache::ProcessElements(ClusterConfigChange)] Update _dasOptions
2011-08-28T14:23:04.490Z [FF9A2400 info 'Policy' opID=E995B4F1-000003C7-97-5e-SWI-365dc7d7] [ClusterConfigCache::ProcessElements(ClusterConfigChange)] Update clusterVmDefaults
2011-08-28T14:23:04.490Z [FFA87B90 info 'Default' opID=E995B4F1-000003C7-97-5e] [VpxLRO] -- FINISH task-internal-4 --  -- csi.FdmService.setClusterConfig -- 5264ad99-bdda-b795-0907-a00f99c57a5a
2011-08-28T14:23:04.490Z [FFA87B90 verbose 'Default'] [VpxLRO::ClearCurrentMain] Clearing _currentMain
2011-08-28T14:23:05.733Z [FFF89B90 info 'Election' opID=SWI-2e07db11] [ClusterElection::ChangeState] Uninitialized => Startup : Have host list, connected to hostd, and listening on tcp socket
2011-08-28T14:23:05.733Z [FFF89B90 info 'Cluster' opID=SWI-2e07db11] Change state to Startup:0
2011-08-28T14:23:05.733Z [FFDC2B90 verbose 'Cluster' opID=SWI-e5c33ba4] [ClusterManagerImpl::CheckElectionState] Transitioned from Uninitialized to Startup
2011-08-28T14:23:05.733Z [FFDC2B90 info 'Invt' opID=SWI-e5c33ba4] [InventoryManagerImpl::NotifyDatastoreUnlockedLocally] Invoked for datastore (/vmfs/volumes/4e59da67-98a9e364-fff8-000c295b51ae).
2011-08-28T14:23:05.734Z [FFDC2B90 info 'Invt' opID=SWI-e5c33ba4] [InventoryManagerImpl::NotifyDatastoreUnlockedLocally] Invoked for datastore (/vmfs/volumes/4e46fa14-22f09d6f-3454-000c29d36aa5).
2011-08-28T14:23:05.734Z [FFDC2B90 info 'Invt' opID=SWI-e5c33ba4] [InventoryManagerImpl::NotifyDatastoreUnlockedLocally] Invoked for datastore (/vmfs/volumes/4e59da7b-e1974b2a-2f64-000c295b51ae).
2011-08-28T14:23:05.734Z [FFDC2B90 info 'Cluster' opID=SWI-e5c33ba4] [ClusterManagerImpl::MainLoop] curState 1 lastState 0
2011-08-28T14:23:05.734Z [FFDC2B90 verbose 'Cluster' opID=SWI-e5c33ba4] UpdateLocalHeartbeatInfo: Adding hb datastore /vmfs/volumes/4e59da7b-e1974b2a-2f64-000c295b51ae
2011-08-28T14:23:05.734Z [FFDC2B90 verbose 'Cluster' opID=SWI-e5c33ba4] HBDatastore::Enable: /vmfs/volumes/4e59da7b-e1974b2a-2f64-000c295b51ae
2011-08-28T14:23:05.734Z [FFDC2B90 verbose 'Cluster' opID=SWI-e5c33ba4] UpdateLocalHeartbeatInfo: Adding hb datastore /vmfs/volumes/4e59da67-98a9e364-fff8-000c295b51ae
2011-08-28T14:23:05.734Z [FFDC2B90 verbose 'Cluster' opID=SWI-e5c33ba4] HBDatastore::Enable: /vmfs/volumes/4e59da67-98a9e364-fff8-000c295b51ae
2011-08-28T14:23:05.735Z [FFF89B90 info 'Election' opID=SWI-2e07db11] ClusterElection::StartupStateFunc: Found node with better goodness @ 10.1.0.30
2011-08-28T14:23:05.734Z [FFEC6B90 info 'Invt' opID=SWI-e59fac87] [InventoryManagerImpl::ProcessClusterChange] Cluster state changed to Startup
2011-08-28T14:23:05.735Z [FFEC6B90 verbose 'PropertyProvider' opID=SWI-e59fac87] RecordOp ASSIGN: clusterState, fdmService
2011-08-28T14:23:05.735Z [FFEC6B90 verbose 'FDM' opID=SWI-e59fac87] [FdmService::Handle::ClusterStateNotification] Cluster state changed: Uninitialized -> Startup
2011-08-28T14:23:05.735Z [FFEC6B90 verbose 'Placement' opID=SWI-e59fac87] [PlacementManagerImpl::ClusterStateListener::Handle] New cluster state is 1
2011-08-28T14:23:05.735Z [FFEC6B90 verbose 'Execution' opID=SWI-e59fac87] [ExecutionManagerImpl::ClusterStateListener::Handle] New cluster state is 1
2011-08-28T14:23:05.735Z [FFEC6B90 verbose 'Policy' opID=SWI-e59fac87] [PolicyManager::Handle(ClusterStateNotification)] Transitioning to startup (1). Disabling global policy and enabling local policy.
2011-08-28T14:23:05.735Z [FFEC6B90 verbose 'Policy' opID=SWI-e59fac87] [LocalIsolationPolicy::OnEnable] Enabling local policy.
2011-08-28T14:23:05.736Z [FFEC6B90 verbose 'Notifications' opID=SWI-e59fac87] [Notification::AddListener] Adding listener of type Csi::Notifications::IsolationChange: Csi::Policies::LocalIsolationPolicy (listeners = 1)
2011-08-28T14:23:05.736Z [FFEC6B90 verbose 'Monitor' opID=SWI-e59fac87] [IsoAddressMonitor::Handle::ClusterStateNotification] Cluster state changed to 1
2011-08-28T14:23:05.736Z [FFEC6B90 verbose 'Monitor' opID=SWI-e59fac87] [PingableAddressMonitor::Handle::ClusterStateNotification] Cluster state changed to 1
2011-08-28T14:23:05.736Z [FFEC6B90 verbose 'Monitor' opID=SWI-e59fac87] [HostAccessMonitor::ClusterStateListener] Cluster state changed to 1
2011-08-28T14:23:05.736Z [FFFCAB90 verbose 'Policy' opID=SWI-bb952131] [LocalVmMonitoringPolicy::ProcessEnable] Enabling local VM Monitoring policy.
2011-08-28T14:23:05.736Z [FFFCAB90 verbose 'Notifications' opID=SWI-bb952131] [Notification::AddListener] Adding listener of type Csi::Notifications::ClusterConfigChange: Csi::Policies::LocalVmMonitoringPolicy (listeners = 10)
2011-08-28T14:23:05.736Z [FFFCAB90 verbose 'Notifications' opID=SWI-bb952131] [Notification::AddListener] Adding listener of type Csi::Notifications::VmHeartbeatStateChange: Csi::Policies::LocalVmMonitoringPolicy (listeners = 1)
2011-08-28T14:23:05.736Z [FFFCAB90 info 'Policy' opID=SWI-bb952131] [LocalVmMonitoringPolicy::ProcessVmMonitoringChange] Updating VM monitoring cluster configuration
2011-08-28T14:23:05.736Z [FFFCAB90 info 'Policy' opID=SWI-bb952131] [LocalVmMonitoringPolicy::MoveVmsToHeartbeatState] Moving all VMs into heartbeat state 0
2011-08-28T14:23:05.736Z [FFFCAB90 info 'Policy' opID=SWI-bb952131] [LocalVmMonitoringPolicy::DisableVmMonitoring] Stopped monitoring all heartbeats
2011-08-28T14:23:05.744Z [FFAC8B90 verbose 'Cluster'] ICMP reply for non-existent pinger 3 (id=isolationAddress)
2011-08-28T14:23:06.712Z [63355B90 verbose 'Default'] [VpxLroList::ThreadMainEntry] Unlocked _propProvider to call into external code
2011-08-28T14:23:06.712Z [63355B90 verbose 'Default'] [VpxLRO::LroMain] Invoking _currentMain
2011-08-28T14:23:06.712Z [63355B90 info 'Default' opID=4c82b728] [VpxLRO] -- BEGIN task-internal-5 --  -- csi.FdmService.retrieveClusterInfo -- 5264ad99-bdda-b795-0907-a00f99c57a5a
2011-08-28T14:23:06.712Z [63355B90 info 'Default' opID=4c82b728] [VpxLRO] -- FINISH task-internal-5 --  -- csi.FdmService.retrieveClusterInfo -- 5264ad99-bdda-b795-0907-a00f99c57a5a
2011-08-28T14:23:06.712Z [63355B90 verbose 'Default'] [VpxLRO::ClearCurrentMain] Clearing _currentMain
2011-08-28T14:23:06.734Z [FFDC2B90 info 'Cluster' opID=SWI-e5c33ba4] [ClusterManagerImpl::AddDatastore] path=/vmfs/volumes/4e59da67-98a9e364-fff8-000c295b51ae mountHost=host-13 type=2 accessible=true
2011-08-28T14:23:06.735Z [FFDC2B90 verbose 'Cluster' opID=SWI-e5c33ba4] HBDatastore::Enable: /vmfs/volumes/4e59da67-98a9e364-fff8-000c295b51ae
2011-08-28T14:23:06.735Z [FFDC2B90 info 'Cluster' opID=SWI-e5c33ba4] [ClusterManagerImpl::AddDatastore] path=/vmfs/volumes/4e59da7b-e1974b2a-2f64-000c295b51ae mountHost=host-13 type=2 accessible=true
2011-08-28T14:23:06.735Z [FFDC2B90 verbose 'Cluster' opID=SWI-e5c33ba4] HBDatastore::Enable: /vmfs/volumes/4e59da7b-e1974b2a-2f64-000c295b51ae
2011-08-28T14:23:06.735Z [FFDC2B90 info 'Cluster' opID=SWI-e5c33ba4] [ClusterManagerImpl::AddDatastore] path=/vmfs/volumes/4e46fa14-22f09d6f-3454-000c29d36aa5 mountHost=host-13 type=2 accessible=true
2011-08-28T14:23:06.736Z [FFF89B90 info 'Election' opID=SWI-2e07db11] ClusterElection::StartupStateFunc: Found node with better goodness @ 10.1.0.30
2011-08-28T14:23:06.736Z [FFF07B90 verbose 'Cluster'] ICMP reply for non-existent pinger 3 (id=isolationAddress)
2011-08-28T14:23:07.738Z [FFF89B90 info 'Election' opID=SWI-2e07db11] ClusterElection::StartupStateFunc: Found node with better goodness @ 10.1.0.30
2011-08-28T14:23:07.738Z [FFFCAB90 verbose 'Cluster'] ICMP reply for non-existent pinger 3 (id=isolationAddress)
2011-08-28T14:23:08.740Z [FFF89B90 info 'Election' opID=SWI-2e07db11] ClusterElection::StartupStateFunc: Found node with better goodness @ 10.1.0.30
2011-08-28T14:23:09.009Z [FFF89B90 info 'Election' opID=SWI-2e07db11] [ClusterElection::ChangeState] Startup => ChoseMaster : Got StartElection
2011-08-28T14:23:09.009Z [FFF89B90 info 'Cluster' opID=SWI-2e07db11] Change state to ChoseMaster:4860536762
2011-08-28T14:23:09.010Z [FFDC2B90 verbose 'Cluster' opID=SWI-e5c33ba4] [ClusterManagerImpl::CheckElectionState] Transitioned from Startup to ChoseMaster
2011-08-28T14:23:09.010Z [FFDC2B90 info 'Invt' opID=SWI-e5c33ba4] [InventoryManagerImpl::NotifyDatastoreUnlockedLocally] Invoked for datastore (/vmfs/volumes/4e59da67-98a9e364-fff8-000c295b51ae).
2011-08-28T14:23:09.010Z [FFDC2B90 info 'Invt' opID=SWI-e5c33ba4] [InventoryManagerImpl::NotifyDatastoreUnlockedLocally] Invoked for datastore (/vmfs/volumes/4e46fa14-22f09d6f-3454-000c29d36aa5).
2011-08-28T14:23:09.010Z [FFDC2B90 info 'Invt' opID=SWI-e5c33ba4] [InventoryManagerImpl::NotifyDatastoreUnlockedLocally] Invoked for datastore (/vmfs/volumes/4e59da7b-e1974b2a-2f64-000c295b51ae).
2011-08-28T14:23:09.010Z [FFDC2B90 info 'Cluster' opID=SWI-e5c33ba4] [ClusterManagerImpl::MainLoop] curState 2 lastState 1
2011-08-28T14:23:16.885Z [FFFCAB90 verbose 'Default'] [VpxLroList::ThreadMainEntry] Unlocked _propProvider to call into external code
2011-08-28T14:23:16.885Z [FFFCAB90 verbose 'Default'] [VpxLRO::LroMain] Invoking _currentMain
2011-08-28T14:23:16.885Z [FFFCAB90 info 'Default' opID=ce368086] [VpxLRO] -- BEGIN task-internal-6 --  -- csi.FdmService.retrieveClusterInfo -- 5264ad99-bdda-b795-0907-a00f99c57a5a
2011-08-28T14:23:16.885Z [FFFCAB90 info 'Default' opID=ce368086] [VpxLRO] -- FINISH task-internal-6 --  -- csi.FdmService.retrieveClusterInfo -- 5264ad99-bdda-b795-0907-a00f99c57a5a
2011-08-28T14:23:16.885Z [FFFCAB90 verbose 'Default'] [VpxLRO::ClearCurrentMain] Clearing _currentMain
2011-08-28T14:23:19.011Z [FFF89B90 info 'Election' opID=SWI-2e07db11] ChoseMaster timeout
2011-08-28T14:23:19.011Z [FFF89B90 info 'Election' opID=SWI-2e07db11] [ClusterElection::ChangeState] ChoseMaster => SlaveConnecting : ChoseMasterStateFunc
2011-08-28T14:23:19.011Z [FFF89B90 info 'Cluster' opID=SWI-2e07db11] Change state to SlaveConnecting:4860536762
2011-08-28T14:23:19.014Z [FFDC2B90 verbose 'Cluster' opID=SWI-e5c33ba4] [ClusterManagerImpl::CheckElectionState] Transitioned from ChoseMaster to SlaveConnecting
2011-08-28T14:23:19.014Z [FFDC2B90 info 'Invt' opID=SWI-e5c33ba4] [InventoryManagerImpl::NotifyDatastoreUnlockedLocally] Invoked for datastore (/vmfs/volumes/4e59da67-98a9e364-fff8-000c295b51ae).
2011-08-28T14:23:19.014Z [FFDC2B90 info 'Invt' opID=SWI-e5c33ba4] [InventoryManagerImpl::NotifyDatastoreUnlockedLocally] Invoked for datastore (/vmfs/volumes/4e46fa14-22f09d6f-3454-000c29d36aa5).
2011-08-28T14:23:19.014Z [FFDC2B90 info 'Invt' opID=SWI-e5c33ba4] [InventoryManagerImpl::NotifyDatastoreUnlockedLocally] Invoked for datastore (/vmfs/volumes/4e59da7b-e1974b2a-2f64-000c295b51ae).
2011-08-28T14:23:19.014Z [FFDC2B90 info 'Cluster' opID=SWI-e5c33ba4] [ClusterManagerImpl::MainLoop] curState 3 lastState 2
2011-08-28T14:23:19.016Z [FFF89B90 info 'Cluster' opID=SWI-2e07db11] [ClusterManagerImpl::ConnectToMaster] Connecting to master host-9 @ 10.1.0.30:8182
2011-08-28T14:23:19.024Z [FFE03B90 warning 'Libs' opID=SWI-4881b4ee] SSL_VerifyX509: Certificate verification is disabled, so connection will proceed despite the error
2011-08-28T14:23:19.024Z [FFE03B90 warning 'Libs' opID=SWI-4881b4ee] SSL_VerifyX509: Certificate verification is disabled, so connection will proceed despite the error
2011-08-28T14:23:19.024Z [FFE03B90 warning 'Libs' opID=SWI-4881b4ee] SSL_VerifyX509: Certificate verification is disabled, so connection will proceed despite the error
2011-08-28T14:23:19.075Z [FFF89B90 verbose 'Cluster' opID=SWI-2e07db11] [ClusterManagerImpl::VerifyHost] Thumbprint match 17:69:42:D0:2D:CB:85:97:30:D8:37:13:9D:CD:D2:78:A7:2F:7D:9B for host host-9
2011-08-28T14:23:19.075Z [FFF89B90 info 'Cluster' opID=SWI-2e07db11] [ClusterManagerImpl::ConnectToMaster] Connected to master @ host-9
2011-08-28T14:23:19.076Z [FFF89B90 info 'Election' opID=SWI-2e07db11] Slave to host @ 10.1.0.30
2011-08-28T14:23:19.076Z [FFF89B90 info 'Election' opID=SWI-2e07db11] [ClusterElection::ChangeState] SlaveConnecting => Slave : SlaveConnectingStateFunc
2011-08-28T14:23:19.076Z [FFF89B90 info 'Cluster' opID=SWI-2e07db11] Change state to Slave:4860536762
2011-08-28T14:23:19.076Z [FFDC2B90 verbose 'Cluster' opID=SWI-e5c33ba4] [ClusterManagerImpl::CheckElectionState] Transitioned from SlaveConnecting to Slave
2011-08-28T14:23:19.076Z [FFDC2B90 info 'Invt' opID=SWI-e5c33ba4] [InventoryManagerImpl::NotifyDatastoreUnlockedLocally] Invoked for datastore (/vmfs/volumes/4e59da67-98a9e364-fff8-000c295b51ae).
2011-08-28T14:23:19.076Z [FFDC2B90 info 'Invt' opID=SWI-e5c33ba4] [InventoryManagerImpl::NotifyDatastoreUnlockedLocally] Invoked for datastore (/vmfs/volumes/4e46fa14-22f09d6f-3454-000c29d36aa5).
2011-08-28T14:23:19.076Z [FFDC2B90 info 'Invt' opID=SWI-e5c33ba4] [InventoryManagerImpl::NotifyDatastoreUnlockedLocally] Invoked for datastore (/vmfs/volumes/4e59da7b-e1974b2a-2f64-000c295b51ae).
2011-08-28T14:23:19.076Z [FFDC2B90 info 'Cluster' opID=SWI-e5c33ba4] [ClusterManagerImpl::MainLoop] curState 4 lastState 3
2011-08-28T14:23:19.076Z [FFDC2B90 verbose 'Cluster' opID=SWI-e5c33ba4] [HBDatastore::Heartbeat] Creating heartbeat file for /vmfs/volumes/4e59da67-98a9e364-fff8-000c295b51ae
2011-08-28T14:23:19.077Z [FFDC2B90 verbose 'Cluster' opID=SWI-e5c33ba4] [HBDatastore::Heartbeat] Creating heartbeat file for /vmfs/volumes/4e59da7b-e1974b2a-2f64-000c295b51ae
2011-08-28T14:23:19.080Z [FFDC2B90 info 'Cluster' opID=SWI-e5c33ba4] [ClusterManagerImpl::MainLoop] curState 4 lastState 3
2011-08-28T14:23:19.080Z [FFDC2B90 verbose 'Cluster' opID=SWI-e5c33ba4] [HBDatastore::Heartbeat] 1 ios in progress for /vmfs/volumes/4e59da67-98a9e364-fff8-000c295b51ae
2011-08-28T14:23:19.080Z [FFDC2B90 verbose 'Cluster' opID=SWI-e5c33ba4] [HBDatastore::Heartbeat] 1 ios in progress for /vmfs/volumes/4e59da7b-e1974b2a-2f64-000c295b51ae
2011-08-28T14:23:19.080Z [FFFCAB90 info 'Invt' opID=SWI-ea3ba051] [InventoryManagerImpl::ProcessClusterChange] Cluster state changed to Slave
2011-08-28T14:23:19.081Z [FFFCAB90 verbose 'PropertyProvider' opID=SWI-ea3ba051] RecordOp ASSIGN: clusterState, fdmService
2011-08-28T14:23:19.081Z [FFFCAB90 verbose 'FDM' opID=SWI-ea3ba051] [FdmService::Handle::ClusterStateNotification] Cluster state changed: Startup -> Slave
2011-08-28T14:23:19.081Z [FFFCAB90 verbose 'Placement' opID=SWI-ea3ba051] [PlacementManagerImpl::ClusterStateListener::Handle] New cluster state is 2
2011-08-28T14:23:19.081Z [FFFCAB90 verbose 'Execution' opID=SWI-ea3ba051] [ExecutionManagerImpl::ClusterStateListener::Handle] New cluster state is 2
2011-08-28T14:23:19.081Z [FFFCAB90 verbose 'Policy' opID=SWI-ea3ba051] [PolicyManager::Handle(ClusterStateNotification)] Transitioning to slave (2). Disabling global policy and enabling local policy.
2011-08-28T14:23:19.081Z [FFFCAB90 verbose 'Monitor' opID=SWI-ea3ba051] [IsoAddressMonitor::Handle::ClusterStateNotification] Cluster state changed to 2
2011-08-28T14:23:19.081Z [FFFCAB90 info 'Monitor' opID=SWI-ea3ba051] [PingableAddressMonitor::Start] Starting
2011-08-28T14:23:19.081Z [FFFCAB90 verbose 'Monitor' opID=SWI-ea3ba051] [PingableAddressMonitor::Handle::ClusterStateNotification] Cluster state changed to 2
2011-08-28T14:23:19.084Z [FFFCAB90 info 'Monitor' opID=SWI-ea3ba051] [PingableAddressMonitor::Start] Starting
2011-08-28T14:23:19.084Z [FFE44B90 verbose 'Monitor' opID=SWI-31b5db5b] [IsoAddressMonitor::UpdateAddressList] Isolation addresses have changed
2011-08-28T14:23:19.085Z [FFE44B90 info 'Monitor' opID=SWI-93d0c977] [HostAccessMonitor::UpdateAddressList] Updating address list
2011-08-28T14:23:19.084Z [FFFCAB90 verbose 'Monitor' opID=SWI-ea3ba051] [HostAccessMonitor::ClusterStateListener] Cluster state changed to 2
2011-08-28T14:23:19.088Z [FFD81B90 verbose 'FDM' opID=SWI-e9f47984] [FdmService] New event: EventEx=com.vmware.vc.HA.AllIsoAddrsPingable vm= host=host-13 tag=host-13:320833892:0
2011-08-28T14:23:19.089Z [FFD81B90 verbose 'PropertyProvider' opID=SWI-e9f47984] RecordOp ADD: event[0], fdmService
2011-08-28T14:23:19.089Z [FFD81B90 verbose 'PropertyProvider' opID=SWI-e9f47984] RecordOp ASSIGN: serverTime, fdmService
2011-08-28T14:23:19.089Z [FFD81B90 verbose 'FDM' opID=SWI-e9f47984] [FdmService] New event: EventEx=com.vmware.vc.HA.AllHostAddrsPingable vm= host=host-13 tag=host-13:320833892:1
2011-08-28T14:23:19.089Z [FFD81B90 verbose 'PropertyProvider' opID=SWI-e9f47984] RecordOp ADD: event[1], fdmService
2011-08-28T14:23:19.095Z [FFD81B90 verbose 'PropertyProvider' opID=SWI-e9f47984] RecordOp ASSIGN: serverTime, fdmService
2011-08-28T14:23:19.227Z [FFF07B90 info 'Cluster' opID=SWI-c45f7dd9] [HBDatastore::OpenHeartbeatFile] Creating heartbeat file /vmfs/volumes/4e59da67-98a9e364-fff8-000c295b51ae @ /vmfs/volumes/4e59da67-98a9e364-fff8-000c295b51ae/.vSphere-HA/FDM-0DE334B1-2277-4BDE-A3B6-176C9157B060-19-3596749-vCenter/host-13-hb
2011-08-28T14:23:19.244Z [63355B90 info 'Cluster' opID=SWI-2e447eae] [HBDatastore::OpenHeartbeatFile] Creating heartbeat file /vmfs/volumes/4e59da7b-e1974b2a-2f64-000c295b51ae @ /vmfs/volumes/4e59da7b-e1974b2a-2f64-000c295b51ae/.vSphere-HA/FDM-0DE334B1-2277-4BDE-A3B6-176C9157B060-19-3596749-vCenter/host-13-hb
2011-08-28T14:23:20.086Z [FFDC2B90 info 'Cluster' opID=SWI-e5c33ba4] [ClusterManagerImpl::AddDatastore] path=/vmfs/volumes/4e59da67-98a9e364-fff8-000c295b51ae mountHost=host-13 type=2 accessible=true
2011-08-28T14:23:20.086Z [FFDC2B90 verbose 'Cluster' opID=SWI-e5c33ba4] HBDatastore::Enable: /vmfs/volumes/4e59da67-98a9e364-fff8-000c295b51ae
2011-08-28T14:23:20.086Z [FFDC2B90 info 'Cluster' opID=SWI-e5c33ba4] [ClusterManagerImpl::AddDatastore] path=/vmfs/volumes/4e59da7b-e1974b2a-2f64-000c295b51ae mountHost=host-13 type=2 accessible=true
2011-08-28T14:23:20.086Z [FFDC2B90 verbose 'Cluster' opID=SWI-e5c33ba4] HBDatastore::Enable: /vmfs/volumes/4e59da7b-e1974b2a-2f64-000c295b51ae
2011-08-28T14:23:20.086Z [FFDC2B90 info 'Cluster' opID=SWI-e5c33ba4] [ClusterManagerImpl::AddDatastore] path=/vmfs/volumes/4e46fa14-22f09d6f-3454-000c29d36aa5 mountHost=host-13 type=2 accessible=true
2011-08-28T14:23:26.883Z [FFE03B90 verbose 'Default'] [VpxLroList::ThreadMainEntry] Unlocked _propProvider to call into external code
2011-08-28T14:23:26.884Z [FFE03B90 verbose 'Default'] [VpxLRO::LroMain] Invoking _currentMain
2011-08-28T14:23:26.884Z [FFE03B90 info 'Default' opID=9cbd5113] [VpxLRO] -- BEGIN task-internal-7 --  -- csi.FdmService.retrieveClusterInfo -- 5264ad99-bdda-b795-0907-a00f99c57a5a
2011-08-28T14:23:26.884Z [FFE03B90 info 'Default' opID=9cbd5113] [VpxLRO] -- FINISH task-internal-7 --  -- csi.FdmService.retrieveClusterInfo -- 5264ad99-bdda-b795-0907-a00f99c57a5a
2011-08-28T14:23:26.884Z [FFE03B90 verbose 'Default'] [VpxLRO::ClearCurrentMain] Clearing _currentMain
2011-08-28T14:23:26.889Z [FFF07B90 verbose 'Default'] [VpxLroList::ThreadMainEntry] Unlocked _propProvider to call into external code
2011-08-28T14:23:26.889Z [FFF07B90 verbose 'Default'] [VpxLRO::LroMain] Invoking _currentMain
2011-08-28T14:23:26.889Z [FFF07B90 info 'Default' opID=1a0f2e8a] [VpxLRO] -- BEGIN task-internal-8 --  -- csi.FdmService.GetAbout -- 5264ad99-bdda-b795-0907-a00f99c57a5a
2011-08-28T14:23:26.890Z [FFF07B90 info 'Default' opID=1a0f2e8a] [VpxLRO] -- FINISH task-internal-8 --  -- csi.FdmService.GetAbout -- 5264ad99-bdda-b795-0907-a00f99c57a5a
2011-08-28T14:23:26.890Z [FFF07B90 verbose 'Default'] [VpxLRO::ClearCurrentMain] Clearing _currentMain
2011-08-28T14:23:30.108Z [FFE44B90 verbose 'Cluster' opID=SWI-c4f6b2ec] [HBDatastore::WritePowerOnList] Writing power-on-list @ /vmfs/volumes/4e59da67-98a9e364-fff8-000c295b51ae/.vSphere-HA/FDM-0DE334B1-2277-4BDE-A3B6-176C9157B060-19-3596749-vCenter/host-13-poweron with 0 vms isolated=false
2011-08-28T14:23:30.108Z [FFEC6B90 verbose 'Cluster' opID=SWI-905e88fd] [HBDatastore::WritePowerOnList] Writing power-on-list @ /vmfs/volumes/4e59da7b-e1974b2a-2f64-000c295b51ae/.vSphere-HA/FDM-0DE334B1-2277-4BDE-A3B6-176C9157B060-19-3596749-vCenter/host-13-poweron with 0 vms isolated=false
2011-08-28T14:23:34.031Z [FFF89B90 verbose 'Election' opID=SWI-2e07db11] CheckVersion: Version[2] Other host GT : 2 > 0
2011-08-28T14:23:34.031Z [FFF89B90 verbose 'Cluster' opID=SWI-2e07db11] VersionChange: version[2] 2 from host-9,10.1.0.30
2011-08-28T14:23:34.032Z [FFF89B90 info 'Cluster' opID=SWI-2e07db11] VersionChange: fetching version[2] 2 from host-9,10.1.0.30
2011-08-28T14:23:34.033Z [FFE03B90 verbose 'Cluster'] [ClusterManagerImpl::NewHostCompatList] version 2
2011-08-28T14:23:34.033Z [FFE03B90 verbose 'Cluster'] [ClusterManagerImpl::Uncompress] Uncompressed from size 260 to size 423
2011-08-28T14:23:34.034Z [FFE03B90 verbose 'Cluster'] [ClusterManagerImpl::UpdatePersistentObject] name compatlist version (2 ?> 0) force false
2011-08-28T14:23:34.035Z [FFE03B90 info 'Cluster' opID=SWI-1462bf07] [ClusterManagerImpl::StoreDone] Wrote host-compatabilty-list version 2
2011-08-28T14:23:34.035Z [FFE03B90 verbose 'Invt' opID=SWI-5c4b3d08] [InventoryManagerImpl::ProcessHostCompatList] processing compat list version:2
2011-08-28T14:23:34.035Z [FFE03B90 info 'Placement' opID=SWI-5c4b3d08] [PlacementManagerImpl::CompatListListener::Handle] Get a new compat list
2011-08-28T14:23:34.920Z [FFE44B90 info 'Hal'] Configuration sync has been requested
2011-08-28T14:23:35.031Z [FFF89B90 verbose 'Election' opID=SWI-2e07db11] CheckVersion: Version[2] Other host GT : 2 > 0
2011-08-28T14:23:35.031Z [FFF89B90 verbose 'Election' opID=SWI-2e07db11] CheckVersion: Pending version change 2 >= 2
2011-08-28T14:23:54.166Z [FFF07B90 verbose 'Cluster'] ProcessAcquireDatastoreMsg: Acquiring datastore /vmfs/volumes/4e46fa14-22f09d6f-3454-000c29d36aa5
2011-08-28T14:23:54.177Z [FFF07B90 verbose 'Cluster' opID=SWI-2e4a27b1] SendFailedAcquire: 8
2011-08-28T14:23:54.178Z [FFF07B90 info 'Invt' opID=SWI-2e4a27b1] [InventoryManagerImpl::NotifyDatastoreUnlockedLocally] Invoked for datastore (/vmfs/volumes/4e46fa14-22f09d6f-3454-000c29d36aa5)



===================================================================================


Environment:


2 x ESXi 5.0
1 x vCenter 5.0
2 x iSCSI LUN