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





1 comment:

  1. Was there a problem with HA or is this a general interpretation question of what HA is/was doing?

    ReplyDelete