Details
-
Bug
-
Status: Resolved
-
Major
-
Resolution: Cannot Reproduce
-
4.1.0, 4.2.0
-
None
-
Security Level: Public (Anyone can view this level - this is the default.)
-
None
Description
We got a VM with 3 volumes attach.
CS can't start the VM. We've got an error on the ESX. The output logs (/scratch/log/hostd.log) :
2013-06-07T13:24:59.745Z [80A1CB90 info 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=e81c34d3-d5] State Transition (VM_STATE_OFF -> VM_STATE_RECONFIGURING)
2013-06-07T13:24:59.745Z [80A1CB90 verbose 'ha-host' opID=e81c34d3-d5] ModeMgr::Begin: op = normal, current = normal, count = 2
2013-06-07T13:24:59.745Z [80A1CB90 verbose 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=e81c34d3-d5] Invoking interceptor:1-hbr
2013-06-07T13:24:59.750Z [80A1CB90 verbose 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=e81c34d3-d5] Done invoking interceptor:1-hbr
2013-06-07T13:24:59.779Z [80281B90 verbose 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=e81c34d3-d5] Current VM Tracking state: disabled
2013-06-07T13:24:59.782Z [80281B90 info 'HostsvcPlugin' opID=e81c34d3-d5] Lookupvm: World ID not set for VM 14
2013-06-07T13:24:59.783Z [80281B90 verbose 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=e81c34d3-d5] Adjusting tracking state for disk /vmfs/volumes/f9d1a9e8-e9294a75/ROOT-108-149.vmdk to state disabled.
2013-06-07T13:24:59.794Z [80281B90 verbose 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=e81c34d3-d5] Disk /vmfs/volumes/f9d1a9e8-e9294a75/ROOT-108-149.vmdk: Tracking is already deactivated, skipping.
2013-06-07T13:24:59.794Z [80281B90 verbose 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=e81c34d3-d5] Adjusting tracking state for disk /vmfs/volumes/f9d1a9e8-e9294a75/5ea7e674b1324876985a6572fd40b72c.vmdk to state disabled.
2013-06-07T13:24:59.804Z [80281B90 verbose 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=e81c34d3-d5] Disk /vmfs/volumes/f9d1a9e8-e9294a75/5ea7e674b1324876985a6572fd40b72c.vmdk: Tracking is already deactivated, skipping.
2013-06-07T13:24:59.804Z [80281B90 verbose 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=e81c34d3-d5] Adjusting tracking state for disk /vmfs/volumes/f9d1a9e8-e9294a75/29e04b4363194c45a72638ac97281c57.vmdk to state disabled.
2013-06-07T13:24:59.813Z [80281B90 verbose 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=e81c34d3-d5] Disk /vmfs/volumes/f9d1a9e8-e9294a75/29e04b4363194c45a72638ac97281c57.vmdk: Tracking is already deactivated, skipping.
2013-06-07T13:24:59.815Z [80281B90 verbose 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=e81c34d3-d5] Adjusting tracking state for disk /vmfs/volumes/f9d1a9e8-e9294a75/615d905d145e4af3b284e935e754422e.vmdk to state disabled.
2013-06-07T13:24:59.824Z [80281B90 verbose 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=e81c34d3-d5] Disk /vmfs/volumes/f9d1a9e8-e9294a75/615d905d145e4af3b284e935e754422e.vmdk: Tracking is already deactivated, skipping.
2013-06-07T13:24:59.824Z [80281B90 verbose 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=e81c34d3-d5] Setting VM's tracking state to disabled.
2013-06-07T13:24:59.866Z [80816B90 info 'Libs'] VMHS: Transitioned vmx/execState/val to poweredOff
2013-06-07T13:24:59.872Z [80D06B90 verbose 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx'] No Upgrade required
2013-06-07T13:24:59.884Z [80816B90 info 'Libs'] Vix: [9253 foundryVMPowerOps.c:973]: FoundryVMPowerStateChangeCallback: /vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx, vmx/execState/val = poweredOff.
2013-06-07T13:24:59.902Z [80281B90 info 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=e81c34d3-d5] State Transition (VM_STATE_RECONFIGURING -> VM_STATE_OFF)
2013-06-07T13:24:59.902Z [80281B90 verbose 'ha-host' opID=e81c34d3-d5] ModeMgr::End: op = normal, current = normal, count = 3
2013-06-07T13:24:59.903Z [80281B90 info 'ha-eventmgr' opID=e81c34d3-d5] Event 268 : Reconfigured i-3-108-VM on cloud-hyper15c-prp.bop.cloud.bs in ha-datacenter
2013-06-07T13:24:59.910Z [80281B90 info 'ha-host' opID=e81c34d3-d5] vmxSwapEnabled = true vmmOvhd.anonymous: 9522 vmmOvhd.paged: 37128 vmmOvhd.nonpaged: 11399
2013-06-07T13:24:59.910Z [80281B90 info 'ha-host' opID=e81c34d3-d5] vmkOvhd.fixd = 303104 vmkOvhd.variable: 2050 vmkOvhd.selfSwap: 3145728
2013-06-07T13:24:59.910Z [80281B90 info 'ha-host' opID=e81c34d3-d5] Computed from lib overhead: 85692416 for (memPages: 131072, fbSize: 8192, #vcpus: 1, #lsiscsi: 1, #pvscsi: 0, #passthru: 0, #network: 0) vmkOverhead: 4498432
2013-06-07T13:24:59.910Z [80281B90 info 'ha-host' opID=e81c34d3-d5] overhead result (no CBRC): 90189824
2013-06-07T13:24:59.910Z [80281B90 info 'ha-host' opID=e81c34d3-d5] Predicted overhead: 90189824 for (memory: 536870912, video: 4194304, #vcpus: 1, autodetect: true, enable3D: false, svgaPtFbSize: 33554432, cbrcOverhead: 0
2013-06-07T13:24:59.910Z [80281B90 verbose 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=e81c34d3-d5] Time to gather config: 6 (msecs)
2013-06-07T13:24:59.911Z [80A71B90 verbose 'Hbrsvc'] Replicator: ReconfigListener triggered for config VM 14
2013-06-07T13:24:59.919Z [80281B90 info 'HostsvcPlugin' opID=e81c34d3-d5] Lookupvm: World ID not set for VM 14
2013-06-07T13:24:59.923Z [80281B90 info 'ha-host' opID=e81c34d3-d5] vmxSwapEnabled = true vmmOvhd.anonymous: 9522 vmmOvhd.paged: 37128 vmmOvhd.nonpaged: 11399
2013-06-07T13:24:59.923Z [80281B90 info 'ha-host' opID=e81c34d3-d5] vmkOvhd.fixd = 303104 vmkOvhd.variable: 2050 vmkOvhd.selfSwap: 3145728
2013-06-07T13:24:59.923Z [80281B90 info 'ha-host' opID=e81c34d3-d5] Computed from lib overhead: 85692416 for (memPages: 131072, fbSize: 8192, #vcpus: 1, #lsiscsi: 1, #pvscsi: 0, #passthru: 0, #network: 0) vmkOverhead: 4498432
2013-06-07T13:24:59.924Z [80281B90 info 'ha-host' opID=e81c34d3-d5] overhead result (no CBRC): 90189824
2013-06-07T13:24:59.924Z [80281B90 info 'ha-host' opID=e81c34d3-d5] Predicted overhead: 90189824 for (memory: 536870912, video: 4194304, #vcpus: 1, autodetect: true, enable3D: false, svgaPtFbSize: 33554432, cbrcOverhead: 0
2013-06-07T13:24:59.931Z [80281B90 info 'TaskManager' opID=e81c34d3-d5] Task Completed : haTask-14-vim.VirtualMachine.reconfigure-207754403 Status success
2013-06-07T13:24:59.931Z [80281B90 verbose 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=e81c34d3-d5] Reconfigure worker thread completed succesfully
2013-06-07T13:24:59.932Z [80A71B90 verbose 'Hbrsvc'] Replicator: VmReconfig ignoring VM 14 not configured for replication
2013-06-07T13:24:59.935Z [806C2B90 warning 'Locale'] FormatField: Invalid (vim.vm.Message.1)
2013-06-07T13:24:59.936Z [806C2B90 warning 'Locale'] FormatField: Invalid (vim.vm.Message.2)
2013-06-07T13:24:59.936Z [806C2B90 warning 'Locale'] FormatField: Invalid (vim.vm.Message.3)
2013-06-07T13:24:59.949Z [FFE8DAC0 info 'ha-host'] vmxSwapEnabled = true vmmOvhd.anonymous: 9522 vmmOvhd.paged: 37128 vmmOvhd.nonpaged: 11399
2013-06-07T13:24:59.949Z [FFE8DAC0 info 'ha-host'] vmkOvhd.fixd = 303104 vmkOvhd.variable: 2050 vmkOvhd.selfSwap: 3145728
2013-06-07T13:24:59.949Z [FFE8DAC0 info 'ha-host'] Computed from lib overhead: 85692416 for (memPages: 131072, fbSize: 8192, #vcpus: 1, #lsiscsi: 1, #pvscsi: 0, #passthru: 0, #network: 0) vmkOverhead: 4498432
2013-06-07T13:24:59.949Z [FFE8DAC0 info 'ha-host'] overhead result (no CBRC): 90189824
2013-06-07T13:24:59.949Z [FFE8DAC0 info 'ha-host'] Predicted overhead: 90189824 for (memory: 536870912, video: 4194304, #vcpus: 1, autodetect: true, enable3D: false, svgaPtFbSize: 33554432, cbrcOverhead: 0
2013-06-07T13:25:00.002Z [80B0BB90 info 'ha-host'] vmxSwapEnabled = true vmmOvhd.anonymous: 9522 vmmOvhd.paged: 37128 vmmOvhd.nonpaged: 11399
2013-06-07T13:25:00.003Z [80B0BB90 info 'ha-host'] vmkOvhd.fixd = 303104 vmkOvhd.variable: 2050 vmkOvhd.selfSwap: 3145728
2013-06-07T13:25:00.003Z [80B0BB90 info 'ha-host'] Computed from lib overhead: 85692416 for (memPages: 131072, fbSize: 8192, #vcpus: 1, #lsiscsi: 1, #pvscsi: 0, #passthru: 0, #network: 0) vmkOverhead: 4498432
2013-06-07T13:25:00.003Z [80B0BB90 info 'ha-host'] overhead result (no CBRC): 90189824
2013-06-07T13:25:00.003Z [80B0BB90 info 'ha-host'] Predicted overhead: 90189824 for (memory: 536870912, video: 4194304, #vcpus: 1, autodetect: true, enable3D: false, svgaPtFbSize: 33554432, cbrcOverhead: 0
2013-06-07T13:25:00.997Z [80A1CB90 verbose 'Proxysvc Req01193'] New proxy client SSL(TCP(local=10.200.194.15:443, peer=10.200.192.45:59223))
2013-06-07T13:25:01.016Z [FFE8DAC0 verbose 'Locale' opID=f89bda2b] Default resource used for 'counter.virtualDisk.commandsAborted.label' expected in module 'perf'.
2013-06-07T13:25:01.016Z [FFE8DAC0 verbose 'Locale' opID=f89bda2b] Default resource used for 'counter.virtualDisk.commandsAborted.summary' expected in module 'perf'.
2013-06-07T13:25:01.016Z [FFE8DAC0 verbose 'Locale' opID=f89bda2b] Default resource used for 'counter.virtualDisk.busResets.label' expected in module 'perf'.
2013-06-07T13:25:01.016Z [FFE8DAC0 verbose 'Locale' opID=f89bda2b] Default resource used for 'counter.virtualDisk.busResets.summary' expected in module 'perf'.
2013-06-07T13:25:01.062Z [80DF4B90 verbose 'ha-license-manager' opID=f89bda2b] Load: Loading existing file: /etc/vmware/license.cfg
2013-06-07T13:25:01.079Z [80DF4B90 verbose 'Default' opID=f89bda2b] ha-license-manager:Validate -> Valid evaluation detected for "VMware ESX Server 5.0" (lastError=0, desc.IsValid:Yes)
2013-06-07T13:25:01.087Z [80DF4B90 error 'Default' opID=f89bda2b] Unable to parse MaxRam value:
2013-06-07T13:25:01.087Z [80DF4B90 error 'Default' opID=f89bda2b] Unable to parse MaxRamPerCpu value:
2013-06-07T13:25:01.087Z [80DF4B90 error 'Default' opID=f89bda2b] Unable to parse MinRamPerCpu value:
2013-06-07T13:25:01.087Z [80DF4B90 error 'Default' opID=f89bda2b] Unable to parse vram value:
2013-06-07T13:25:01.116Z [80D06B90 verbose 'DvsTracker' opID=f89bda2b] FetchSwitches: added 0 items
2013-06-07T13:25:01.116Z [80D06B90 verbose 'DvsTracker' opID=f89bda2b] FetchDVPortgroups: added 0 items
2013-06-07T13:25:01.116Z [80D06B90 info 'DvsTracker' opID=f89bda2b] FetchUplinkDVPortgroups: added 0 items
2013-06-07T13:25:10.456Z [810C3B90 verbose 'SoapAdapter'] Responded to service state request
2013-06-07T13:25:15.729Z [806C2B90 info 'TaskManager' opID=a2681242-d3] Task Created : haTask-14-vim.VirtualMachine.reconfigure-207754413
2013-06-07T13:25:15.730Z [80A71B90 info 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=a2681242-d3] State Transition (VM_STATE_OFF -> VM_STATE_RECONFIGURING)
2013-06-07T13:25:15.730Z [80A71B90 verbose 'ha-host' opID=a2681242-d3] ModeMgr::Begin: op = normal, current = normal, count = 2
2013-06-07T13:25:15.730Z [80A71B90 verbose 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=a2681242-d3] Invoking interceptor:1-hbr
2013-06-07T13:25:15.735Z [80A71B90 verbose 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=a2681242-d3] Done invoking interceptor:1-hbr
2013-06-07T13:25:15.738Z [80BD1B90 verbose 'Proxysvc Req01194'] New proxy client SSL(TCP(local=10.200.194.15:443, peer=10.200.192.45:59299))
2013-06-07T13:25:15.743Z [80640B90 verbose 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=a2681242-d3] Current VM Tracking state: disabled
2013-06-07T13:25:15.747Z [80640B90 info 'HostsvcPlugin' opID=a2681242-d3] Lookupvm: World ID not set for VM 14
2013-06-07T13:25:15.771Z [80640B90 verbose 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=a2681242-d3] Setting tracking state for disk w. key -2 to false
2013-06-07T13:25:15.780Z [80640B90 verbose 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=a2681242-d3] Setting tracking state for disk w. key -3 to false
2013-06-07T13:25:15.789Z [80640B90 verbose 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=a2681242-d3] Setting tracking state for disk w. key -4 to false
2013-06-07T13:25:15.798Z [80640B90 verbose 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=a2681242-d3] Setting tracking state for disk w. key -5 to false
2013-06-07T13:25:15.800Z [80640B90 info 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=a2681242-d3] AddDevice failed: AddDevice: 54: Error: (3) One of the parameters was invalid
2013-06-07T13:25:15.800Z [80640B90 info 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=a2681242-d3] Reconfigure failed: vmodl.fault.InvalidArgument
2013-06-07T13:25:15.800Z [80640B90 warning 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=a2681242-d3] Exception thrown during reconfigure: (vim.vm.ConfigSpec) {
--> dynamicType = <unset>,
--> changeVersion = <unset>,
--> name = <unset>,
--> version = <unset>,
--> uuid = <unset>,
--> instanceUuid = <unset>,
--> npivWorldWideNameType = <unset>,
--> npivDesiredNodeWwns = <unset>,
--> npivDesiredPortWwns = <unset>,
--> npivTemporaryDisabled = <unset>,
--> npivOnNonRdmDisks = <unset>,
--> npivWorldWideNameOp = <unset>,
--> locationId = <unset>,
--> guestId = "otherGuest64",
--> alternateGuestName = <unset>,
--> annotation = <unset>,
--> files = (vim.vm.FileInfo)
--> tools = (vim.vm.ToolsConfigInfo) null,
--> flags = (vim.vm.FlagInfo) null,
--> consolePreferences = (vim.vm.ConsolePreferences) null,
--> powerOpInfo = (vim.vm.DefaultPowerOpInfo) null,
--> numCPUs = 1,
--> numCoresPerSocket = <unset>,
--> memoryMB = 512,
--> memoryHotAddEnabled = <unset>,
--> cpuHotAddEnabled = <unset>,
--> cpuHotRemoveEnabled = <unset>,
--> virtualICH7MPresent = <unset>,
--> virtualSMCPresent = <unset>,
--> deviceChange = (vim.vm.device.VirtualDeviceSpec) [
--> (vim.vm.device.VirtualDeviceSpec) {
--> dynamicType = <unset>,
--> operation = "edit",
--> fileOperation = <unset>,
--> device = (vim.vm.device.VirtualCdrom) {
--> dynamicType = <unset>,
--> key = 3000,
--> deviceInfo = (vim.Description) { --> dynamicType = <unset>, --> label = "Lecteur CD/DVD 1", --> summary = "Périphérique distant", --> },
--> backing = (vim.vm.device.VirtualCdrom.RemotePassthroughBackingInfo) { --> dynamicType = <unset>, --> deviceName = "", --> useAutoDetect = <unset>, --> exclusive = false, --> },
--> connectable = (vim.vm.device.VirtualDevice.ConnectInfo) { --> dynamicType = <unset>, --> startConnected = true, --> allowGuestControl = false, --> connected = true, --> status = <unset>, --> },
--> controllerKey = 200,
--> unitNumber = 0,
--> },
--> },
--> (vim.vm.device.VirtualDeviceSpec) {
--> dynamicType = <unset>,
--> operation = "add",
--> fileOperation = <unset>,
--> device = (vim.vm.device.VirtualDisk) {
--> dynamicType = <unset>,
--> key = -2,
--> deviceInfo = (vim.Description) null,
--> backing = (vim.vm.device.VirtualDisk.FlatVer2BackingInfo) { --> dynamicType = <unset>, --> fileName = "/vmfs/volumes/f9d1a9e8-e9294a75/ROOT-108-149.vmdk", --> datastore = 'vim.Datastore:datastore-1375', --> diskMode = "persistent", --> split = <unset>, --> writeThrough = <unset>, --> thinProvisioned = <unset>, --> eagerlyScrub = <unset>, --> uuid = <unset>, --> contentId = <unset>, --> changeId = <unset>, --> parent = (vim.vm.device.VirtualDisk.FlatVer2BackingInfo) null, --> deltaDiskFormat = <unset>, --> digestEnabled = <unset>, --> },
--> connectable = (vim.vm.device.VirtualDevice.ConnectInfo) {--> dynamicType = <unset>,--> startConnected = true,--> allowGuestControl = false,--> connected = true,--> status = <unset>,--> },
--> controllerKey = 1000,
--> unitNumber = 1,
--> capacityInKB = 0,
--> shares = (vim.SharesInfo) null,
--> storageIOAllocation = (vim.StorageResourceManager.IOAllocationInfo) null,
--> },
--> },
--> (vim.vm.device.VirtualDeviceSpec) {
--> dynamicType = <unset>,
--> operation = "add",
--> fileOperation = <unset>,
--> device = (vim.vm.device.VirtualDisk) {
--> dynamicType = <unset>,
--> key = -3,
--> deviceInfo = (vim.Description) null,
--> backing = (vim.vm.device.VirtualDisk.FlatVer2BackingInfo) { --> dynamicType = <unset>, --> fileName = "/vmfs/volumes/f9d1a9e8-e9294a75/5ea7e674b1324876985a6572fd40b72c.vmdk", --> datastore = 'vim.Datastore:datastore-1375', --> diskMode = "persistent", --> split = <unset>, --> writeThrough = <unset>, --> thinProvisioned = <unset>, --> eagerlyScrub = <unset>, --> uuid = <unset>, --> contentId = <unset>, --> changeId = <unset>, --> parent = (vim.vm.device.VirtualDisk.FlatVer2BackingInfo) null, --> deltaDiskFormat = <unset>, --> digestEnabled = <unset>, --> },
--> connectable = (vim.vm.device.VirtualDevice.ConnectInfo) { --> dynamicType = <unset>, --> startConnected = true, --> allowGuestControl = false, --> connected = true, --> status = <unset>, --> },
--> controllerKey = 1000,
--> unitNumber = 2,
--> capacityInKB = 0,
--> shares = (vim.SharesInfo) null,
--> storageIOAllocation = (vim.StorageResourceManager.IOAllocationInfo) null,
--> },
--> },
--> (vim.vm.device.VirtualDeviceSpec) {
--> dynamicType = <unset>,
--> operation = "add",
--> fileOperation = <unset>,
--> device = (vim.vm.device.VirtualDisk) {
--> dynamicType = <unset>,
--> key = -4,
--> deviceInfo = (vim.Description) null,
--> backing = (vim.vm.device.VirtualDisk.FlatVer2BackingInfo) { --> dynamicType = <unset>, --> fileName = "/vmfs/volumes/f9d1a9e8-e9294a75/29e04b4363194c45a72638ac97281c57.vmdk", --> datastore = 'vim.Datastore:datastore-1375', --> diskMode = "persistent", --> split = <unset>, --> writeThrough = <unset>, --> thinProvisioned = <unset>, --> eagerlyScrub = <unset>, --> uuid = <unset>, --> contentId = <unset>, --> changeId = <unset>, --> parent = (vim.vm.device.VirtualDisk.FlatVer2BackingInfo) null, --> deltaDiskFormat = <unset>, --> digestEnabled = <unset>, --> },
--> connectable = (vim.vm.device.VirtualDevice.ConnectInfo) {--> dynamicType = <unset>,--> startConnected = true,--> allowGuestControl = false,--> connected = true,--> status = <unset>,--> },
--> controllerKey = 1000,
--> unitNumber = 3,
--> capacityInKB = 0,
--> shares = (vim.SharesInfo) null,
--> storageIOAllocation = (vim.StorageResourceManager.IOAllocationInfo) null,
--> },
--> },
--> (vim.vm.device.VirtualDeviceSpec) {
--> dynamicType = <unset>,
--> operation = "add",
--> fileOperation = <unset>,
--> device = (vim.vm.device.VirtualDisk) {
--> dynamicType = <unset>,
--> key = -5,
--> deviceInfo = (vim.Description) null,
--> backing = (vim.vm.device.VirtualDisk.FlatVer2BackingInfo) { --> dynamicType = <unset>, --> fileName = "/vmfs/volumes/f9d1a9e8-e9294a75/615d905d145e4af3b284e935e754422e.vmdk", --> datastore = 'vim.Datastore:datastore-1375', --> diskMode = "persistent", --> split = <unset>, --> writeThrough = <unset>, --> thinProvisioned = <unset>, --> eagerlyScrub = <unset>, --> uuid = <unset>, --> contentId = <unset>, --> changeId = <unset>, --> parent = (vim.vm.device.VirtualDisk.FlatVer2BackingInfo) null, --> deltaDiskFormat = <unset>, --> digestEnabled = <unset>, --> },
--> connectable = (vim.vm.device.VirtualDevice.ConnectInfo) { --> dynamicType = <unset>, --> startConnected = true, --> allowGuestControl = false, --> connected = true, --> status = <unset>, --> },
--> controllerKey = 1000,
--> unitNumber = 4,
--> capacityInKB = 0,
--> shares = (vim.SharesInfo) null,
--> storageIOAllocation = (vim.StorageResourceManager.IOAllocationInfo) null,
--> },
--> },
--> (vim.vm.device.VirtualDeviceSpec) {
--> dynamicType = <unset>,
--> operation = "add",
--> fileOperation = <unset>,
--> device = (vim.vm.device.VirtualE1000) {
--> dynamicType = <unset>,
--> key = -6,
--> deviceInfo = (vim.Description) null,
--> backing = (vim.vm.device.VirtualEthernetCard.NetworkBackingInfo) { --> dynamicType = <unset>, --> deviceName = "cloud.guest.2000.200.1-vSwitch0", --> useAutoDetect = <unset>, --> network = <unset>, --> inPassthroughMode = <unset>, --> },
--> connectable = (vim.vm.device.VirtualDevice.ConnectInfo) { --> dynamicType = <unset>, --> startConnected = true, --> allowGuestControl = true, --> connected = true, --> status = <unset>, --> },
--> controllerKey = <unset>,
--> unitNumber = 5,
--> addressType = "Manual",
--> macAddress = "06:ec:fe:00:00:6e",
--> wakeOnLanEnabled = <unset>,
--> },
--> },
--> (vim.vm.device.VirtualDeviceSpec) {
--> dynamicType = <unset>,
--> operation = "add",
--> fileOperation = <unset>,
--> device = (vim.vm.device.VirtualE1000) {
--> dynamicType = <unset>,
--> key = -7,
--> deviceInfo = (vim.Description) null,
--> backing = (vim.vm.device.VirtualEthernetCard.NetworkBackingInfo) { --> dynamicType = <unset>, --> deviceName = "cloud.guest.2001.200.1-vSwitch0", --> useAutoDetect = <unset>, --> network = <unset>, --> inPassthroughMode = <unset>, --> },
--> connectable = (vim.vm.device.VirtualDevice.ConnectInfo) {--> dynamicType = <unset>,--> startConnected = true,--> allowGuestControl = true,--> connected = true,--> status = <unset>,--> },
--> controllerKey = <unset>,
--> unitNumber = 6,
--> addressType = "Manual",
--> macAddress = "06:32:ec:00:00:87",
--> wakeOnLanEnabled = <unset>,
--> },
--> },
--> (vim.vm.device.VirtualDeviceSpec) {
--> dynamicType = <unset>,
--> operation = "add",
--> fileOperation = <unset>,
--> device = (vim.vm.device.VirtualE1000) {
--> dynamicType = <unset>,
--> key = -8,
--> deviceInfo = (vim.Description) null,
--> backing = (vim.vm.device.VirtualEthernetCard.NetworkBackingInfo) { --> dynamicType = <unset>, --> deviceName = "cloud.guest.2002.200.1-vSwitch0", --> useAutoDetect = <unset>, --> network = <unset>, --> inPassthroughMode = <unset>, --> },
--> connectable = (vim.vm.device.VirtualDevice.ConnectInfo) { --> dynamicType = <unset>, --> startConnected = true, --> allowGuestControl = true, --> connected = true, --> status = <unset>, --> },
--> controllerKey = <unset>,
--> unitNumber = 7,
--> addressType = "Manual",
--> macAddress = "06:7f:9a:00:00:a3",
--> wakeOnLanEnabled = <unset>,
--> },
--> }
--> ],
--> cpuAllocation = (vim.ResourceAllocationInfo) { --> dynamicType = <unset>, --> reservation = 0, --> expandableReservation = <unset>, --> limit = -1, --> shares = (vim.SharesInfo) null, --> overheadLimit = <unset>, --> },
--> memoryAllocation = (vim.ResourceAllocationInfo) { --> dynamicType = <unset>, --> reservation = 0, --> expandableReservation = <unset>, --> limit = 512, --> shares = (vim.SharesInfo) null, --> overheadLimit = <unset>, --> },
--> cpuAffinity = (vim.vm.AffinityInfo) null,
--> memoryAffinity = (vim.vm.AffinityInfo) null,
--> networkShaper = (vim.vm.NetworkShaperInfo) null,
--> extraConfig = (vim.option.OptionValue) [
--> (vim.option.OptionValue) { --> dynamicType = <unset>, --> key = "machine.id", --> value = "", --> },
--> (vim.option.OptionValue) { --> dynamicType = <unset>, --> key = "devices.hotplug", --> value = "true", --> },
--> (vim.option.OptionValue) { --> dynamicType = <unset>, --> key = "nicAdapter", --> value = "E1000", --> },
--> (vim.option.OptionValue) { --> dynamicType = <unset>, --> key = "RemoteDisplay.vnc.enabled", --> value = "true", --> },
--> (vim.option.OptionValue) { --> dynamicType = <unset>, --> key = "RemoteDisplay.vnc.password", --> value = "1e5b6f481cb3d18a", --> },
--> (vim.option.OptionValue) { --> dynamicType = <unset>, --> key = "RemoteDisplay.vnc.port", --> value = "5936", --> }
--> ],
--> swapPlacement = <unset>,
--> swapDirectory = <unset>,
--> preserveSwapOnPowerOff = <unset>,
--> bootOptions = (vim.vm.BootOptions) null,
--> vAppConfig = (vim.vApp.VmConfigSpec) null,
--> ftInfo = (vim.vm.FaultToleranceConfigInfo) null,
--> vAppConfigRemoved = <unset>,
--> vAssertsEnabled = <unset>,
--> changeTrackingEnabled = <unset>,
--> firmware = <unset>,
--> maxMksConnections = <unset>,
--> guestAutoLockEnabled = <unset>,
--> managedBy = (vim.ext.ManagedByInfo) null,
--> memoryReservationLockedToMax = <unset>,
--> }
--> vmodl.fault.InvalidArgument
2013-06-07T13:25:15.818Z [80640B90 info 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=a2681242-d3] State Transition (VM_STATE_RECONFIGURING -> VM_STATE_OFF)
2013-06-07T13:25:15.819Z [80640B90 verbose 'ha-host' opID=a2681242-d3] ModeMgr::End: op = normal, current = normal, count = 3
2013-06-07T13:25:15.819Z [80640B90 info 'ha-eventmgr' opID=a2681242-d3] Event 269 : Reconfigured i-3-108-VM on cloud-hyper15c-prp.bop.cloud.bs in ha-datacenter
2013-06-07T13:25:15.821Z [80681B90 warning 'Locale'] FormatField: Invalid (vim.vm.Message.1)
2013-06-07T13:25:15.821Z [80681B90 warning 'Locale'] FormatField: Invalid (vim.vm.Message.2)
2013-06-07T13:25:15.821Z [80681B90 warning 'Locale'] FormatField: Invalid (vim.vm.Message.3)
2013-06-07T13:25:15.826Z [80640B90 info 'ha-host' opID=a2681242-d3] vmxSwapEnabled = true vmmOvhd.anonymous: 9522 vmmOvhd.paged: 37128 vmmOvhd.nonpaged: 11399
2013-06-07T13:25:15.827Z [80640B90 info 'ha-host' opID=a2681242-d3] vmkOvhd.fixd = 303104 vmkOvhd.variable: 2050 vmkOvhd.selfSwap: 3145728
2013-06-07T13:25:15.827Z [80640B90 info 'ha-host' opID=a2681242-d3] Computed from lib overhead: 85692416 for (memPages: 131072, fbSize: 8192, #vcpus: 1, #lsiscsi: 1, #pvscsi: 0, #passthru: 0, #network: 0) vmkOverhead: 4498432
2013-06-07T13:25:15.827Z [80640B90 info 'ha-host' opID=a2681242-d3] overhead result (no CBRC): 90189824
2013-06-07T13:25:15.827Z [80640B90 info 'ha-host' opID=a2681242-d3] Predicted overhead: 90189824 for (memory: 536870912, video: 4194304, #vcpus: 1, autodetect: true, enable3D: false, svgaPtFbSize: 33554432, cbrcOverhead: 0
2013-06-07T13:25:15.827Z [80640B90 verbose 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=a2681242-d3] Time to gather config: 6 (msecs)
2013-06-07T13:25:15.827Z [80640B90 info 'HostsvcPlugin' opID=a2681242-d3] Lookupvm: World ID not set for VM 14
2013-06-07T13:25:15.827Z [806C2B90 verbose 'Hbrsvc'] Replicator: ReconfigListener triggered for config VM 14
2013-06-07T13:25:15.833Z [80640B90 info 'TaskManager' opID=a2681242-d3] Task Completed : haTask-14-vim.VirtualMachine.reconfigure-207754413 Status error
2013-06-07T13:25:15.833Z [80640B90 warning 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=a2681242-d3] Reconfigure worker thread failed
2013-06-07T13:25:15.834Z [806C2B90 verbose 'Hbrsvc'] Replicator: VmReconfig ignoring VM 14 not configured for replication
2013-06-07T13:25:15.835Z [80DF4B90 verbose 'Locale'] FormatField: Optional unset (vmodl.fault.InvalidArgument.invalidProperty)
2013-06-07T13:25:15.837Z [80A71B90 verbose 'Locale'] FormatField: Optional unset (vmodl.fault.InvalidArgument.invalidProperty)
2013-06-07T13:25:19.027Z [FFE8DAC0 verbose 'Locale' opID=f2ff0d63-94] Default resource used for 'counter.virtualDisk.commandsAborted.label' expected in module 'perf'.
2013-06-07T13:25:19.027Z [FFE8DAC0 verbose 'Locale' opID=f2ff0d63-94] Default resource used for 'counter.virtualDisk.commandsAborted.summary' expected in module 'perf'.
2013-06-07T13:25:19.027Z [FFE8DAC0 verbose 'Locale' opID=f2ff0d63-94] Default resource used for 'counter.virtualDisk.busResets.label' expected in module 'perf'.
2013-06-07T13:25:19.027Z [FFE8DAC0 verbose 'Locale' opID=f2ff0d63-94] Default resource used for 'counter.virtualDisk.busResets.summary' expected in module 'perf'.
2013-06-07T13:25:19.247Z [80640B90 verbose 'Locale' opID=176ebdd2-1] Default resource used for 'counter.virtualDisk.commandsAborted.label' expected in module 'perf'.
2013-06-07T13:25:19.247Z [80640B90 verbose 'Locale' opID=176ebdd2-1] Default resource used for 'counter.virtualDisk.commandsAborted.summary' expected in module 'perf'.
2013-06-07T13:25:19.247Z [80640B90 verbose 'Locale' opID=176ebdd2-1] Default resource used for 'counter.virtualDisk.busResets.label' expected in module 'perf'.
2013-06-07T13:25:19.247Z [80640B90 verbose 'Locale' opID=176ebdd2-1] Default resource used for 'counter.virtualDisk.busResets.summary' expected in module 'perf'.
2013-06-07T13:25:21.054Z [806C2B90 verbose 'Default'] Power policy is unset
2013-06-07T13:25:21.054Z [80BD1B90 verbose 'Default'] Power policy is unset
2013-06-07T13:25:21.511Z [80281B90 verbose 'SoapAdapter'] Responded to service state request
2013-06-07T13:25:40.458Z [80A1CB90 verbose 'SoapAdapter'] Responded to service state request
2013-06-07T13:25:51.514Z [FFE8DAC0 verbose 'SoapAdapter'] Responded to service state request
2013-06-07T13:25:55.017Z [80D06B90 info 'TaskManager' opID=90ea4be0-81] Task Created : haTask-14-vim.VirtualMachine.reconfigure-207754432
2013-06-07T13:25:55.018Z [80D06B90 info 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=90ea4be0-81] State Transition (VM_STATE_OFF -> VM_STATE_RECONFIGURING)
2013-06-07T13:25:55.018Z [80D06B90 verbose 'ha-host' opID=90ea4be0-81] ModeMgr::Begin: op = normal, current = normal, count = 2
2013-06-07T13:25:55.018Z [80D06B90 verbose 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=90ea4be0-81] Invoking interceptor:1-hbr
2013-06-07T13:25:55.022Z [80D06B90 verbose 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=90ea4be0-81] Done invoking interceptor:1-hbr
2013-06-07T13:25:55.033Z [80C85B90 verbose 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=90ea4be0-81] Current VM Tracking state: disabled
2013-06-07T13:25:55.037Z [80C85B90 info 'HostsvcPlugin' opID=90ea4be0-81] Lookupvm: World ID not set for VM 14
2013-06-07T13:25:55.066Z [80C85B90 verbose 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=90ea4be0-81] Setting tracking state for disk w. key -2 to false
2013-06-07T13:25:55.076Z [80C85B90 verbose 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=90ea4be0-81] Setting tracking state for disk w. key -3 to false
2013-06-07T13:25:55.086Z [80C85B90 verbose 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=90ea4be0-81] Setting tracking state for disk w. key -4 to false
2013-06-07T13:25:55.096Z [80C85B90 verbose 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=90ea4be0-81] Setting tracking state for disk w. key -5 to false
2013-06-07T13:25:55.098Z [80C85B90 info 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=90ea4be0-81] AddDevice failed: AddDevice: 54: Error: (3) One of the parameters was invalid
2013-06-07T13:25:55.098Z [80C85B90 info 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=90ea4be0-81] Reconfigure failed: vmodl.fault.InvalidArgument
2013-06-07T13:25:55.098Z [80C85B90 warning 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=90ea4be0-81] Exception thrown during reconfigure: (vim.vm.ConfigSpec) {
--> dynamicType = <unset>,
--> changeVersion = <unset>,
--> name = <unset>,
--> version = <unset>,
--> uuid = <unset>,
--> instanceUuid = <unset>,
--> npivWorldWideNameType = <unset>,
--> npivDesiredNodeWwns = <unset>,
--> npivDesiredPortWwns = <unset>,
--> npivTemporaryDisabled = <unset>,
--> npivOnNonRdmDisks = <unset>,
--> npivWorldWideNameOp = <unset>,
--> locationId = <unset>,
--> guestId = "otherGuest64",
--> alternateGuestName = <unset>,
--> annotation = <unset>,
--> files = (vim.vm.FileInfo) {--> dynamicType = <unset>,--> vmPathName = "[]/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx",--> snapshotDirectory = <unset>,--> suspendDirectory = <unset>,--> logDirectory = <unset>,--> }
,
--> tools = (vim.vm.ToolsConfigInfo) null,
--> flags = (vim.vm.FlagInfo) null,
--> consolePreferences = (vim.vm.ConsolePreferences) null,
--> powerOpInfo = (vim.vm.DefaultPowerOpInfo) null,
--> numCPUs = 1,
--> numCoresPerSocket = <unset>,
--> memoryMB = 512,
--> memoryHotAddEnabled = <unset>,
--> cpuHotAddEnabled = <unset>,
--> cpuHotRemoveEnabled = <unset>,
--> virtualICH7MPresent = <unset>,
--> virtualSMCPresent = <unset>,
--> deviceChange = (vim.vm.device.VirtualDeviceSpec) [
--> (vim.vm.device.VirtualDeviceSpec) {
--> dynamicType = <unset>,
--> operation = "edit",
--> fileOperation = <unset>,
--> device = (vim.vm.device.VirtualCdrom) {
--> dynamicType = <unset>,
--> key = 3000,
--> deviceInfo = (vim.Description)
,
--> backing = (vim.vm.device.VirtualCdrom.RemotePassthroughBackingInfo)
,
--> connectable = (vim.vm.device.VirtualDevice.ConnectInfo)
--> controllerKey = 200,
--> unitNumber = 0,
--> },
--> },
--> (vim.vm.device.VirtualDeviceSpec) {
--> dynamicType = <unset>,
--> operation = "add",
--> fileOperation = <unset>,
--> device = (vim.vm.device.VirtualDisk) {
--> dynamicType = <unset>,
--> key = -2,
--> deviceInfo = (vim.Description) null,
--> backing = (vim.vm.device.VirtualDisk.FlatVer2BackingInfo) { --> dynamicType = <unset>, --> fileName = "/vmfs/volumes/f9d1a9e8-e9294a75/ROOT-108-149.vmdk", --> datastore = 'vim.Datastore:datastore-1375', --> diskMode = "persistent", --> split = <unset>, --> writeThrough = <unset>, --> thinProvisioned = <unset>, --> eagerlyScrub = <unset>, --> uuid = <unset>, --> contentId = <unset>, --> changeId = <unset>, --> parent = (vim.vm.device.VirtualDisk.FlatVer2BackingInfo) null, --> deltaDiskFormat = <unset>, --> digestEnabled = <unset>, --> },
--> connectable = (vim.vm.device.VirtualDevice.ConnectInfo) {--> dynamicType = <unset>,--> startConnected = true,--> allowGuestControl = false,--> connected = true,--> status = <unset>,--> }
,
--> controllerKey = 1000,
--> unitNumber = 1,
--> capacityInKB = 0,
--> shares = (vim.SharesInfo) null,
--> storageIOAllocation = (vim.StorageResourceManager.IOAllocationInfo) null,
--> },
--> },
--> (vim.vm.device.VirtualDeviceSpec) {
--> dynamicType = <unset>,
--> operation = "add",
--> fileOperation = <unset>,
--> device = (vim.vm.device.VirtualDisk) {
--> dynamicType = <unset>,
--> key = -3,
--> deviceInfo = (vim.Description) null,
--> backing = (vim.vm.device.VirtualDisk.FlatVer2BackingInfo)
,
--> connectable = (vim.vm.device.VirtualDevice.ConnectInfo)
--> controllerKey = 1000,
--> unitNumber = 2,
--> capacityInKB = 0,
--> shares = (vim.SharesInfo) null,
--> storageIOAllocation = (vim.StorageResourceManager.IOAllocationInfo) null,
--> },
--> },
--> (vim.vm.device.VirtualDeviceSpec) {
--> dynamicType = <unset>,
--> operation = "add",
--> fileOperation = <unset>,
--> device = (vim.vm.device.VirtualDisk) {
--> dynamicType = <unset>,
--> key = -4,
--> deviceInfo = (vim.Description) null,
--> backing = (vim.vm.device.VirtualDisk.FlatVer2BackingInfo) { --> dynamicType = <unset>, --> fileName = "/vmfs/volumes/f9d1a9e8-e9294a75/29e04b4363194c45a72638ac97281c57.vmdk", --> datastore = 'vim.Datastore:datastore-1375', --> diskMode = "persistent", --> split = <unset>, --> writeThrough = <unset>, --> thinProvisioned = <unset>, --> eagerlyScrub = <unset>, --> uuid = <unset>, --> contentId = <unset>, --> changeId = <unset>, --> parent = (vim.vm.device.VirtualDisk.FlatVer2BackingInfo) null, --> deltaDiskFormat = <unset>, --> digestEnabled = <unset>, --> },
--> connectable = (vim.vm.device.VirtualDevice.ConnectInfo) {--> dynamicType = <unset>,--> startConnected = true,--> allowGuestControl = false,--> connected = true,--> status = <unset>,--> }
,
--> controllerKey = 1000,
--> unitNumber = 3,
--> capacityInKB = 0,
--> shares = (vim.SharesInfo) null,
--> storageIOAllocation = (vim.StorageResourceManager.IOAllocationInfo) null,
--> },
--> },
--> (vim.vm.device.VirtualDeviceSpec) {
--> dynamicType = <unset>,
--> operation = "add",
--> fileOperation = <unset>,
--> device = (vim.vm.device.VirtualDisk) {
--> dynamicType = <unset>,
--> key = -5,
--> deviceInfo = (vim.Description) null,
--> backing = (vim.vm.device.VirtualDisk.FlatVer2BackingInfo)
,
--> connectable = (vim.vm.device.VirtualDevice.ConnectInfo)
,
--> controllerKey = 1000,
--> unitNumber = 4,
--> capacityInKB = 0,
--> shares = (vim.SharesInfo) null,
--> storageIOAllocation = (vim.StorageResourceManager.IOAllocationInfo) null,
--> },
--> },
--> (vim.vm.device.VirtualDeviceSpec) {
--> dynamicType = <unset>,
--> operation = "add",
--> fileOperation = <unset>,
--> device = (vim.vm.device.VirtualE1000) {
--> dynamicType = <unset>,
--> key = -6,
--> deviceInfo = (vim.Description) null,
--> backing = (vim.vm.device.VirtualEthernetCard.NetworkBackingInfo)
,
--> connectable = (vim.vm.device.VirtualDevice.ConnectInfo)
--> controllerKey = <unset>,
--> unitNumber = 5,
--> addressType = "Manual",
--> macAddress = "06:ec:fe:00:00:6e",
--> wakeOnLanEnabled = <unset>,
--> },
--> },
--> (vim.vm.device.VirtualDeviceSpec) {
--> dynamicType = <unset>,
--> operation = "add",
--> fileOperation = <unset>,
--> device = (vim.vm.device.VirtualE1000) {
--> dynamicType = <unset>,
--> key = -7,
--> deviceInfo = (vim.Description) null,
--> backing = (vim.vm.device.VirtualEthernetCard.NetworkBackingInfo) { --> dynamicType = <unset>, --> deviceName = "cloud.guest.2001.200.1-vSwitch0", --> useAutoDetect = <unset>, --> network = <unset>, --> inPassthroughMode = <unset>, --> },
--> connectable = (vim.vm.device.VirtualDevice.ConnectInfo) {--> dynamicType = <unset>,--> startConnected = true,--> allowGuestControl = true,--> connected = true,--> status = <unset>,--> }
,
--> controllerKey = <unset>,
--> unitNumber = 6,
--> addressType = "Manual",
--> macAddress = "06:32:ec:00:00:87",
--> wakeOnLanEnabled = <unset>,
--> },
--> },
--> (vim.vm.device.VirtualDeviceSpec) {
--> dynamicType = <unset>,
--> operation = "add",
--> fileOperation = <unset>,
--> device = (vim.vm.device.VirtualE1000) {
--> dynamicType = <unset>,
--> key = -8,
--> deviceInfo = (vim.Description) null,
--> backing = (vim.vm.device.VirtualEthernetCard.NetworkBackingInfo)
,
--> connectable = (vim.vm.device.VirtualDevice.ConnectInfo)
,
--> controllerKey = <unset>,
--> unitNumber = 7,
--> addressType = "Manual",
--> macAddress = "06:7f:9a:00:00:a3",
--> wakeOnLanEnabled = <unset>,
--> },
--> }
--> ],
--> cpuAllocation = (vim.ResourceAllocationInfo)
,
--> memoryAllocation = (vim.ResourceAllocationInfo)
,
--> cpuAffinity = (vim.vm.AffinityInfo) null,
--> memoryAffinity = (vim.vm.AffinityInfo) null,
--> networkShaper = (vim.vm.NetworkShaperInfo) null,
--> extraConfig = (vim.option.OptionValue) [
--> (vim.option.OptionValue)
,
--> (vim.option.OptionValue)
,
--> (vim.option.OptionValue)
,
--> (vim.option.OptionValue)
,
--> (vim.option.OptionValue)
,
--> (vim.option.OptionValue)
--> ],
--> swapPlacement = <unset>,
--> swapDirectory = <unset>,
--> preserveSwapOnPowerOff = <unset>,
--> bootOptions = (vim.vm.BootOptions) null,
--> vAppConfig = (vim.vApp.VmConfigSpec) null,
--> ftInfo = (vim.vm.FaultToleranceConfigInfo) null,
--> vAppConfigRemoved = <unset>,
--> vAssertsEnabled = <unset>,
--> changeTrackingEnabled = <unset>,
--> firmware = <unset>,
--> maxMksConnections = <unset>,
--> guestAutoLockEnabled = <unset>,
--> managedBy = (vim.ext.ManagedByInfo) null,
--> memoryReservationLockedToMax = <unset>,
--> }
--> vmodl.fault.InvalidArgument
2013-06-07T13:25:55.110Z [80C85B90 info 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=90ea4be0-81] State Transition (VM_STATE_RECONFIGURING -> VM_STATE_OFF)
2013-06-07T13:25:55.111Z [80C85B90 verbose 'ha-host' opID=90ea4be0-81] ModeMgr::End: op = normal, current = normal, count = 3
2013-06-07T13:25:55.111Z [80C85B90 info 'ha-eventmgr' opID=90ea4be0-81] Event 270 : Reconfigured i-3-108-VM on cloud-hyper15c-prp.bop.cloud.bs in ha-datacenter
2013-06-07T13:25:55.118Z [80C85B90 info 'ha-host' opID=90ea4be0-81] vmxSwapEnabled = true vmmOvhd.anonymous: 9522 vmmOvhd.paged: 37128 vmmOvhd.nonpaged: 11399
2013-06-07T13:25:55.118Z [80C85B90 info 'ha-host' opID=90ea4be0-81] vmkOvhd.fixd = 303104 vmkOvhd.variable: 2050 vmkOvhd.selfSwap: 3145728
2013-06-07T13:25:55.118Z [80C85B90 info 'ha-host' opID=90ea4be0-81] Computed from lib overhead: 85692416 for (memPages: 131072, fbSize: 8192, #vcpus: 1, #lsiscsi: 1, #pvscsi: 0, #passthru: 0, #network: 0) vmkOverhead: 4498432
2013-06-07T13:25:55.118Z [80C85B90 info 'ha-host' opID=90ea4be0-81] overhead result (no CBRC): 90189824
2013-06-07T13:25:55.118Z [80C85B90 info 'ha-host' opID=90ea4be0-81] Predicted overhead: 90189824 for (memory: 536870912, video: 4194304, #vcpus: 1, autodetect: true, enable3D: false, svgaPtFbSize: 33554432, cbrcOverhead: 0
2013-06-07T13:25:55.118Z [80C85B90 verbose 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=90ea4be0-81] Time to gather config: 6 (msecs)
2013-06-07T13:25:55.118Z [80C85B90 info 'HostsvcPlugin' opID=90ea4be0-81] Lookupvm: World ID not set for VM 14
2013-06-07T13:25:55.118Z [80DF4B90 verbose 'Hbrsvc'] Replicator: ReconfigListener triggered for config VM 14
2013-06-07T13:25:55.124Z [80C85B90 info 'TaskManager' opID=90ea4be0-81] Task Completed : haTask-14-vim.VirtualMachine.reconfigure-207754432 Status error
2013-06-07T13:25:55.124Z [80C85B90 warning 'vm:/vmfs/volumes/f9d1a9e8-e9294a75/i-3-108-VM/i-3-108-VM.vmx' opID=90ea4be0-81] Reconfigure worker thread failed
2013-06-07T13:25:55.125Z [80DF4B90 verbose 'Hbrsvc'] Replicator: VmReconfig ignoring VM 14 not configured for replication
2013-06-07T13:25:55.127Z [806C2B90 warning 'Locale'] FormatField: Invalid (vim.vm.Message.1)
2013-06-07T13:25:55.127Z [806C2B90 warning 'Locale'] FormatField: Invalid (vim.vm.Message.2)
2013-06-07T13:25:55.127Z [806C2B90 warning 'Locale'] FormatField: Invalid (vim.vm.Message.3)
2013-06-07T13:25:55.129Z [810C3B90 verbose 'Locale'] FormatField: Optional unset (vmodl.fault.InvalidArgument.invalidProperty)
2013-06-07T13:25:55.134Z [80A71B90 verbose 'Locale'] FormatField: Optional unset (vmodl.fault.InvalidArgument.invalidProperty)
2013-06-07T13:26:10.461Z [80D06B90 verbose 'SoapAdapter'] Responded to service state request
2013-06-07T13:26:21.517Z [80C85B90 verbose 'SoapAdapter'] Responded to service state request
On CS logs :
2013-06-07 15:25:03,871 INFO [vmware.resource.VmwareResource] (DirectAgent-54:cloud-hyper15c-prp.bop.cloud.mbs) Executing resource StartCommand: {"vm":{"id":108,"name":"i-3-108-VM","bootloader":"HVM","type":"User
","cpus":1,"speed":500,"minRam":536870912,"maxRam":536870912,"arch":"x86_64","os":"Debian GNU/Linux 6(64-bit)","bootArgs":"","rebootOnCrash":false,"enableHA":false,"limitCpuUse":false,"vncPassword":"1e5b6f481cb3d1
8a","params":
,"uuid":"cbe505d3-bd8b-4927-a275-9e999eb516ec","disks":[
{"id":102,"name":"volNico","mountPoint":"/ifs/cloud/chevilly/clustervmw-prp/primarystorage","path":"615d905d145e4af3b284e9 35e754422e","size":13958643712,"type":"DATADISK","storagePoolType":"NetworkFilesystem","storagePoolUuid":"7338d550-281e-3613-af42-82809c2888ab","deviceId":4},
{"id":149,"name":"ROOT-108","mountPoint":"/ifs/cloud/ch evilly/clustervmw-prp/primarystorage","path":"ROOT-108-149","size":9663676416,"type":"ROOT","storagePoolType":"NetworkFilesystem","storagePoolUuid":"7338d550-281e-3613-af42-82809c2888ab","deviceId":0},
{"id":150,"n ame":"mat1","mountPoint":"/ifs/cloud/chevilly/clustervmw-prp/primarystorage","path":"5ea7e674b1324876985a6572fd40b72c","size":1073741824,"type":"DATADISK","storagePoolType":"NetworkFilesystem","storagePoolUuid":"7 338d550-281e-3613-af42-82809c2888ab","deviceId":1},
{"id":151,"name":"mat2","mountPoint":"/ifs/cloud/chevilly/clustervmw-prp/primarystorage","path":"29e04b4363194c45a72638ac97281c57","size":1073741824,"type":"DATAD ISK","storagePoolType":"NetworkFilesystem","storagePoolUuid":"7338d550-281e-3613-af42-82809c2888ab","deviceId":2},
{"id":108,"name":"debian6#web#","size":0,"type":"ISO","storagePoolType":"ISO","deviceId":3}],"nics"
:[
,
{"deviceId":0,"networkRateMbps":200,"defaultNic":false ,"uuid":"8bff62d8-2bc2-4862-a8ac-0ac729271b59","ip":"10.200.240.20","netmask":"255.255.255.224","gateway":"10.200.240.1","mac":"06:ec:fe:00:00:6e","dns1":"10.200.193.1","dns2":"10.94.53.3","broadcastType":"Vlan"," type":"Guest","broadcastUri":"vlan://2000","isolationUri":"vlan://2000","isSecurityGroupEnabled":false},
{"deviceId":2,"networkRateMbps":200,"defaultNic":false,"uuid":"9c4930a7-0f0f-4193-a01e-a2c212c4d877","ip":"10 .200.248.29","netmask":"255.255.255.224","gateway":"10.200.248.1","mac":"06:7f:9a:00:00:a3","dns1":"10.200.193.1","dns2":"10.94.53.3","broadcastType":"Vlan","type":"Guest","broadcastUri":"vlan://2002","isolationUr i":"vlan://2002","isSecurityGroupEnabled":false}]},"hostIp":"10.200.194.15","wait":0}
2013-06-07 15:25:03,871 DEBUG [vmware.resource.VmwareResource] (DirectAgent-54:cloud-hyper15c-prp.bop.cloud.mbs) VM i-3-108-VM will be started with NIC device type: E1000
2013-06-07 15:25:03,871 DEBUG [vmware.resource.VmwareResource] (DirectAgent-54:cloud-hyper15c-prp.bop.cloud.mbs) Drop invalid disk option, volumeTO:
2013-06-07 15:25:05,146 DEBUG [vmware.mo.HostMO] (DirectAgent-54:cloud-hyper15c-prp.bop.cloud.mbs) find VM i-3-108-VM on host
2013-06-07 15:25:05,146 DEBUG [vmware.mo.HostMO] (DirectAgent-54:cloud-hyper15c-prp.bop.cloud.mbs) load VM cache on host
2013-06-07 15:25:05,358 INFO [vmware.resource.VmwareResource] (DirectAgent-54:cloud-hyper15c-prp.bop.cloud.mbs) VM i-3-108-VM already exists, tear down devices for reconfiguration
2013-06-07 15:25:09,339 DEBUG [vmware.resource.VmwareResource] (DirectAgent-54:cloud-hyper15c-prp.bop.cloud.mbs) Prepare ISO volume at existing device {"__hashCodeCalc":false,"key":3000,"deviceInfo":
,"backing":
{"exclusive":false,"__hashCodeCalc":false,"deviceName":""},"connectable":
{"startConnected":true,"allowGuestControl":false,"connected ":true,"__hashCodeCalc":false},"controllerKey":200,"unitNumber":0}
2013-06-07 15:25:09,549 DEBUG [vmware.resource.VmwareResource] (DirectAgent-54:cloud-hyper15c-prp.bop.cloud.mbs) Prepare volume at new device {"capacityInKB":0,"__hashCodeCalc":false,"key":-2,"backing":{"diskMode"
:"persistent","_hashCodeCalc":false,"fileName":"[7338d550-281e-3613-af42-82809c2888ab] ROOT-108-149.vmdk","datastore":{"_value":"datastore-1375","type":"Datastore","_hashCodeCalc":false}},"connectable":
,"controllerKey":1000,"unitNumber":1}
2013-06-07 15:25:09,550 DEBUG [vmware.resource.VmwareResource] (DirectAgent-54:cloud-hyper15c-prp.bop.cloud.mbs) Prepare volume at new device {"capacityInKB":0,"__hashCodeCalc":false,"key":-3,"backing":{"diskMode"
:"persistent","_hashCodeCalc":false,"fileName":"[7338d550-281e-3613-af42-82809c2888ab] 5ea7e674b1324876985a6572fd40b72c.vmdk","datastore":{"_value":"datastore-1375","type":"Datastore","_hashCodeCalc":false}},"co
nnectable":
,"controllerKey":1000,"unitNumber":2}
2013-06-07 15:25:09,550 DEBUG [vmware.resource.VmwareResource] (DirectAgent-54:cloud-hyper15c-prp.bop.cloud.mbs) Prepare volume at new device {"capacityInKB":0,"__hashCodeCalc":false,"key":-4,"backing":{"diskMode"
:"persistent","_hashCodeCalc":false,"fileName":"[7338d550-281e-3613-af42-82809c2888ab] 29e04b4363194c45a72638ac97281c57.vmdk","datastore":{"_value":"datastore-1375","type":"Datastore","_hashCodeCalc":false}},"co
nnectable":
,"controllerKey":1000,"unitNumber":3}
2013-06-07 15:25:09,550 DEBUG [vmware.resource.VmwareResource] (DirectAgent-54:cloud-hyper15c-prp.bop.cloud.mbs) Prepare volume at new device {"capacityInKB":0,"__hashCodeCalc":false,"key":-5,"backing":{"diskMode"
:"persistent","_hashCodeCalc":false,"fileName":"[7338d550-281e-3613-af42-82809c2888ab] 615d905d145e4af3b284e935e754422e.vmdk","datastore":{"_value":"datastore-1375","type":"Datastore","_hashCodeCalc":false}},"co
nnectable":
,"controllerKey":1000,"unitNumber":4}
2013-06-07 15:25:09,551 INFO [vmware.resource.VmwareResource] (DirectAgent-54:cloud-hyper15c-prp.bop.cloud.mbs) Prepare NIC device based on NicTO:
2013-06-07 15:25:09,762 INFO [vmware.resource.VmwareResource] (DirectAgent-54:cloud-hyper15c-prp.bop.cloud.mbs) Prepare network on vSwitch: P[vSwitch0:untagged] with name prefix: cloud.guest
2013-06-07 15:25:11,106 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-103:null) Ping from 2
2013-06-07 15:25:11,776 DEBUG [vmware.mo.HypervisorHostHelper] (DirectAgent-54:cloud-hyper15c-prp.bop.cloud.mbs) Prepare network on other host, vlan: 2000, host: cloud-hyper12c-prp.bop.cloud.mbs
2013-06-07 15:25:13,169 INFO [vmware.mo.HypervisorHostHelper] (DirectAgent-54:cloud-hyper15c-prp.bop.cloud.mbs) Network cloud.guest.2000.200.1-vSwitch0 is ready on vSwitch vSwitch0
2013-06-07 15:25:13,170 INFO [vmware.mo.HypervisorHostHelper] (DirectAgent-54:cloud-hyper15c-prp.bop.cloud.mbs) Network cloud.guest.2000.200.1-vSwitch0 is ready on vSwitch vSwitch0
2013-06-07 15:25:13,170 INFO [vmware.resource.VmwareResource] (DirectAgent-54:cloud-hyper15c-prp.bop.cloud.mbs) Preparing NIC device on network cloud.guest.2000.200.1-vSwitch0
2013-06-07 15:25:13,170 DEBUG [vmware.resource.VmwareResource] (DirectAgent-54:cloud-hyper15c-prp.bop.cloud.mbs) Prepare NIC at new device {"operation":
,"device":{"__hashCodeCalc":false,"addressTy
pe":"Manual","macAddress":"06:ec:fe:00:00:6e","key":-6,"backing":{"network":
,"__hashCodeCalc":false,"deviceName":"cloud.guest.2000.200.1-vSwitch0"},
"connectable":
,"unitNumber":5},"__hashCodeCalc":false}
2013-06-07 15:25:13,171 INFO [vmware.resource.VmwareResource] (DirectAgent-54:cloud-hyper15c-prp.bop.cloud.mbs) Prepare NIC device based on NicTO:
2013-06-07 15:25:13,382 INFO [vmware.resource.VmwareResource] (DirectAgent-54:cloud-hyper15c-prp.bop.cloud.mbs) Prepare network on vSwitch: P[vSwitch0:untagged] with name prefix: cloud.guest
2013-06-07 15:25:15,405 DEBUG [vmware.mo.HypervisorHostHelper] (DirectAgent-54:cloud-hyper15c-prp.bop.cloud.mbs) Prepare network on other host, vlan: 2001, host: cloud-hyper12c-prp.bop.cloud.mbs
2013-06-07 15:25:15,479 DEBUG [storage.secondary.SecondaryStorageManagerImpl] (secstorage-1:null) Zone 1 is ready to launch secondary storage VM
2013-06-07 15:25:15,865 DEBUG [cloud.consoleproxy.ConsoleProxyManagerImpl] (consoleproxy-1:null) Zone 1 is ready to launch console proxy
2013-06-07 15:25:16,236 DEBUG [network.router.VirtualNetworkApplianceManagerImpl] (RouterStatusMonitor-1:null) Found 0 routers to update status.
2013-06-07 15:25:16,238 DEBUG [network.router.VirtualNetworkApplianceManagerImpl] (RouterStatusMonitor-1:null) Found 0 networks to update RvR status.
2013-06-07 15:25:16,268 DEBUG [network.router.VirtualNetworkApplianceManagerImpl] (RouterStatusMonitor-1:null) Found 0 routers to update status.
2013-06-07 15:25:16,270 DEBUG [network.router.VirtualNetworkApplianceManagerImpl] (RouterStatusMonitor-1:null) Found 0 networks to update RvR status.
2013-06-07 15:25:16,790 INFO [vmware.mo.HypervisorHostHelper] (DirectAgent-54:cloud-hyper15c-prp.bop.cloud.mbs) Network cloud.guest.2001.200.1-vSwitch0 is ready on vSwitch vSwitch0
2013-06-07 15:25:16,791 INFO [vmware.mo.HypervisorHostHelper] (DirectAgent-54:cloud-hyper15c-prp.bop.cloud.mbs) Network cloud.guest.2001.200.1-vSwitch0 is ready on vSwitch vSwitch0
2013-06-07 15:25:16,791 INFO [vmware.resource.VmwareResource] (DirectAgent-54:cloud-hyper15c-prp.bop.cloud.mbs) Preparing NIC device on network cloud.guest.2001.200.1-vSwitch0
2013-06-07 15:25:16,792 DEBUG [vmware.resource.VmwareResource] (DirectAgent-54:cloud-hyper15c-prp.bop.cloud.mbs) Prepare NIC at new device {"operation":
,"device":{"__hashCodeCalc":false,"addressTy
pe":"Manual","macAddress":"06:32:ec:00:00:87","key":-7,"backing":{"network":
,"__hashCodeCalc":false,"deviceName":"cloud.guest.2001.200.1-vSwitch0"},
"connectable":
,"unitNumber":6},"__hashCodeCalc":false}
2013-06-07 15:25:16,792 INFO [vmware.resource.VmwareResource] (DirectAgent-54:cloud-hyper15c-prp.bop.cloud.mbs) Prepare NIC device based on NicTO:
2013-06-07 15:25:17,004 INFO [vmware.resource.VmwareResource] (DirectAgent-54:cloud-hyper15c-prp.bop.cloud.mbs) Prepare network on vSwitch: P[vSwitch0:untagged] with name prefix: cloud.guest
2013-06-07 15:25:18,361 DEBUG [cloud.server.StatsCollector] (StatsCollector-1:null) VmStatsCollector is running...
2013-06-07 15:25:18,434 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-389:null) Seq 2-999300615: Executing request
2013-06-07 15:25:18,986 DEBUG [vmware.mo.HypervisorHostHelper] (DirectAgent-54:cloud-hyper15c-prp.bop.cloud.mbs) Prepare network on other host, vlan: 2002, host: cloud-hyper12c-prp.bop.cloud.mbs
2013-06-07 15:25:19,291 DEBUG [vmware.mo.HostMO] (DirectAgent-389:cloud-hyper12c-prp.bop.cloud.mbs) find VM i-4-14-VM on host
2013-06-07 15:25:19,291 DEBUG [vmware.mo.HostMO] (DirectAgent-389:cloud-hyper12c-prp.bop.cloud.mbs) load VM cache on host
2013-06-07 15:25:20,228 DEBUG [vmware.mo.HostMO] (DirectAgent-389:cloud-hyper12c-prp.bop.cloud.mbs) find VM i-10-46-VM on host
2013-06-07 15:25:20,228 DEBUG [vmware.mo.HostMO] (DirectAgent-389:cloud-hyper12c-prp.bop.cloud.mbs) VM i-10-46-VM found in host cache
2013-06-07 15:25:20,448 DEBUG [vmware.mo.HostMO] (DirectAgent-389:cloud-hyper12c-prp.bop.cloud.mbs) find VM i-7-91-VM on host
2013-06-07 15:25:20,449 DEBUG [vmware.mo.HostMO] (DirectAgent-389:cloud-hyper12c-prp.bop.cloud.mbs) VM i-7-91-VM found in host cache
2013-06-07 15:25:20,672 DEBUG [vmware.mo.HostMO] (DirectAgent-389:cloud-hyper12c-prp.bop.cloud.mbs) find VM i-7-32-VM on host
2013-06-07 15:25:20,672 DEBUG [vmware.mo.HostMO] (DirectAgent-389:cloud-hyper12c-prp.bop.cloud.mbs) VM i-7-32-VM found in host cache
2013-06-07 15:25:20,888 DEBUG [vmware.mo.HostMO] (DirectAgent-389:cloud-hyper12c-prp.bop.cloud.mbs) find VM i-3-83-VM on host
2013-06-07 15:25:20,888 DEBUG [vmware.mo.HostMO] (DirectAgent-389:cloud-hyper12c-prp.bop.cloud.mbs) VM i-3-83-VM found in host cache
2013-06-07 15:25:20,899 INFO [vmware.mo.HypervisorHostHelper] (DirectAgent-54:cloud-hyper15c-prp.bop.cloud.mbs) Network cloud.guest.2002.200.1-vSwitch0 is ready on vSwitch vSwitch0
2013-06-07 15:25:20,899 INFO [vmware.mo.HypervisorHostHelper] (DirectAgent-54:cloud-hyper15c-prp.bop.cloud.mbs) Network cloud.guest.2002.200.1-vSwitch0 is ready on vSwitch vSwitch0
2013-06-07 15:25:20,900 INFO [vmware.resource.VmwareResource] (DirectAgent-54:cloud-hyper15c-prp.bop.cloud.mbs) Preparing NIC device on network cloud.guest.2002.200.1-vSwitch0
2013-06-07 15:25:20,900 DEBUG [vmware.resource.VmwareResource] (DirectAgent-54:cloud-hyper15c-prp.bop.cloud.mbs) Prepare NIC at new device {"operation":
,"device":{"__hashCodeCalc":false,"addressTy
pe":"Manual","macAddress":"06:7f:9a:00:00:a3","key":-8,"backing":{"network":
,"__hashCodeCalc":false,"deviceName":"cloud.guest.2002.200.1-vSwitch0"},
"connectable":
,"unitNumber":7},"__hashCodeCalc":false}
2013-06-07 15:25:20,900 DEBUG [vmware.mo.HostMO] (DirectAgent-54:cloud-hyper15c-prp.bop.cloud.mbs) find VM i-3-108-VM on host
2013-06-07 15:25:20,900 DEBUG [vmware.mo.HostMO] (DirectAgent-54:cloud-hyper15c-prp.bop.cloud.mbs) VM i-3-108-VM found in host cache
2013-06-07 15:25:21,105 DEBUG [vmware.mo.HostMO] (DirectAgent-389:cloud-hyper12c-prp.bop.cloud.mbs) find VM i-3-111-VM on host
2013-06-07 15:25:21,105 DEBUG [vmware.mo.HostMO] (DirectAgent-389:cloud-hyper12c-prp.bop.cloud.mbs) VM i-3-111-VM found in host cache
2013-06-07 15:25:21,320 DEBUG [vmware.mo.HostMO] (DirectAgent-389:cloud-hyper12c-prp.bop.cloud.mbs) find VM i-3-102-VM on host
2013-06-07 15:25:21,320 DEBUG [vmware.mo.HostMO] (DirectAgent-389:cloud-hyper12c-prp.bop.cloud.mbs) VM i-3-102-VM found in host cache
2013-06-07 15:25:21,543 DEBUG [vmware.mo.HostMO] (DirectAgent-389:cloud-hyper12c-prp.bop.cloud.mbs) find VM i-3-84-VM on host
2013-06-07 15:25:21,544 DEBUG [vmware.mo.HostMO] (DirectAgent-389:cloud-hyper12c-prp.bop.cloud.mbs) VM i-3-84-VM found in host cache
2013-06-07 15:25:21,817 DEBUG [vmware.mo.HostMO] (DirectAgent-389:cloud-hyper12c-prp.bop.cloud.mbs) find VM i-10-43-VM on host
2013-06-07 15:25:21,817 DEBUG [vmware.mo.HostMO] (DirectAgent-389:cloud-hyper12c-prp.bop.cloud.mbs) VM i-10-43-VM found in host cache
2013-06-07 15:25:21,821 INFO [vmware.resource.VmwareResource] (DirectAgent-54:cloud-hyper15c-prp.bop.cloud.mbs) Configure VNC port for VM i-3-108-VM, port: 5936, host: cloud-hyper15c-prp.bop.cloud.mbs
2013-06-07 15:25:22,029 DEBUG [vmware.mo.HostMO] (DirectAgent-389:cloud-hyper12c-prp.bop.cloud.mbs) find VM i-4-25-VM on host
2013-06-07 15:25:22,029 DEBUG [vmware.mo.HostMO] (DirectAgent-389:cloud-hyper12c-prp.bop.cloud.mbs) VM i-4-25-VM found in host cache
2013-06-07 15:25:22,245 DEBUG [vmware.mo.HostMO] (DirectAgent-389:cloud-hyper12c-prp.bop.cloud.mbs) find VM i-16-107-VM on host
2013-06-07 15:25:22,245 DEBUG [vmware.mo.HostMO] (DirectAgent-389:cloud-hyper12c-prp.bop.cloud.mbs) VM i-16-107-VM found in host cache
2013-06-07 15:25:22,460 DEBUG [vmware.mo.HostMO] (DirectAgent-389:cloud-hyper12c-prp.bop.cloud.mbs) find VM i-13-95-VM on host
2013-06-07 15:25:22,460 DEBUG [vmware.mo.HostMO] (DirectAgent-389:cloud-hyper12c-prp.bop.cloud.mbs) VM i-13-95-VM found in host cache
2013-06-07 15:25:22,681 DEBUG [vmware.mo.HostMO] (DirectAgent-389:cloud-hyper12c-prp.bop.cloud.mbs) find VM i-16-103-VM on host
2013-06-07 15:25:22,681 DEBUG [vmware.mo.HostMO] (DirectAgent-389:cloud-hyper12c-prp.bop.cloud.mbs) VM i-16-103-VM found in host cache
2013-06-07 15:25:22,902 DEBUG [vmware.mo.HostMO] (DirectAgent-389:cloud-hyper12c-prp.bop.cloud.mbs) find VM i-3-22-VM on host
2013-06-07 15:25:22,902 DEBUG [vmware.mo.HostMO] (DirectAgent-389:cloud-hyper12c-prp.bop.cloud.mbs) VM i-3-22-VM found in host cache
2013-06-07 15:25:23,117 DEBUG [vmware.mo.HostMO] (DirectAgent-389:cloud-hyper12c-prp.bop.cloud.mbs) find VM i-9-49-VM on host
2013-06-07 15:25:23,117 DEBUG [vmware.mo.HostMO] (DirectAgent-389:cloud-hyper12c-prp.bop.cloud.mbs) VM i-9-49-VM found in host cache
2013-06-07 15:25:23,331 DEBUG [vmware.mo.HostMO] (DirectAgent-389:cloud-hyper12c-prp.bop.cloud.mbs) find VM i-3-13-VM on host
2013-06-07 15:25:23,331 DEBUG [vmware.mo.HostMO] (DirectAgent-389:cloud-hyper12c-prp.bop.cloud.mbs) VM i-3-13-VM found in host cache
2013-06-07 15:25:23,544 DEBUG [vmware.mo.HostMO] (DirectAgent-389:cloud-hyper12c-prp.bop.cloud.mbs) find VM i-3-90-VM on host
2013-06-07 15:25:23,544 DEBUG [vmware.mo.HostMO] (DirectAgent-389:cloud-hyper12c-prp.bop.cloud.mbs) VM i-3-90-VM found in host cache
2013-06-07 15:25:23,762 DEBUG [vmware.mo.HostMO] (DirectAgent-389:cloud-hyper12c-prp.bop.cloud.mbs) find VM i-3-61-VM on host
2013-06-07 15:25:23,762 DEBUG [vmware.mo.HostMO] (DirectAgent-389:cloud-hyper12c-prp.bop.cloud.mbs) VM i-3-61-VM found in host cache
2013-06-07 15:25:23,964 ERROR [vmware.mo.VirtualMachineMO] (DirectAgent-54:cloud-hyper15c-prp.bop.cloud.mbs) VMware reconfigVM_Task failed due to Un paramètre spécifié était incorrect.
com.vmware.vim25.InvalidArgument
2013-06-07 15:25:23,964 WARN [vmware.resource.VmwareResource] (DirectAgent-54:cloud-hyper15c-prp.bop.cloud.mbs) StartCommand failed due to Exception: java.lang.Exception
Message: Failed to configure VM before start. vmName: i-3-108-VM
java.lang.Exception: Failed to configure VM before start. vmName: i-3-108-VM
at com.cloud.hypervisor.vmware.resource.VmwareResource.execute(VmwareResource.java:2315)
at com.cloud.hypervisor.vmware.resource.VmwareResource.executeRequest(VmwareResource.java:419)
at com.cloud.agent.manager.DirectAgentAttache$Task.run(DirectAgentAttache.java:186)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
at java.util.concurrent.FutureTask.run(FutureTask.java:138)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:98)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:206)
at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
at java.lang.Thread.run(Thread.java:662)
2013-06-07 15:25:23,965 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-54:null) Seq 12-1996690158: Response Received:
2013-06-07 15:25:23,966 DEBUG [agent.transport.Request] (DirectAgent-54:null) Seq 12-1996690158: Processing: { Ans: , MgmtId: 345051320502, via: 12, Ver: v1, Flags: 110, [{"StartAnswer":{"vm":{"id":108,"name":"i-
3-108-VM","bootloader":"HVM","type":"User","cpus":1,"speed":500,"minRam":536870912,"maxRam":536870912,"arch":"x86_64","os":"Debian GNU/Linux 6(64-bit)","bootArgs":"","rebootOnCrash":false,"enableHA":false,"limitCp
uUse":false,"vncPassword":"1e5b6f481cb3d18a","params":
,"uuid":"cbe505d3-bd8b-4927-a275-9e999eb516ec","disks":[
{"id":102,"name":"volNico","mountPoint":"/ifs/cloud/chevilly/clustervmw-prp/prima rystorage","path":"615d905d145e4af3b284e935e754422e","size":13958643712,"type":"DATADISK","storagePoolType":"NetworkFilesystem","storagePoolUuid":"7338d550-281e-3613-af42-82809c2888ab","deviceId":4},
{"id":149,"nam e":"ROOT-108","mountPoint":"/ifs/cloud/chevilly/clustervmw-prp/primarystorage","path":"ROOT-108-149","size":9663676416,"type":"ROOT","storagePoolType":"NetworkFilesystem","storagePoolUuid":"7338d550-281e-3613-af42 -82809c2888ab","deviceId":0},
{"id":150,"name":"mat1","mountPoint":"/ifs/cloud/chevilly/clustervmw-prp/primarystorage","path":"5ea7e674b1324876985a6572fd40b72c","size":1073741824,"type":"DATADISK","storagePoolType" :"NetworkFilesystem","storagePoolUuid":"7338d550-281e-3613-af42-82809c2888ab","deviceId":1},
{"id":151,"name":"mat2","mountPoint":"/ifs/cloud/chevilly/clustervmw-prp/primarystorage","path":"29e04b4363194c45a72638ac 97281c57","size":1073741824,"type":"DATADISK","storagePoolType":"NetworkFilesystem","storagePoolUuid":"7338d550-281e-3613-af42-82809c2888ab","deviceId":2},
{"id":108,"name":"debian6#web#","size":0,"type":"ISO","sto ragePoolType":"ISO","deviceId":3}],"nics":[
{"deviceId":1,"networkRateMbps":200,"defaultNic":true,"uuid":"a3d1e187-8020-4eb8-b883-a3c3ec836875","ip":"10.200.244.18","netmask":"255.255.255.224","gateway":"10.200.244 .1","mac":"06:32:ec:00:00:87","dns1":"10.200.193.1","dns2":"10.94.53.3","broadcastType":"Vlan","type":"Guest","broadcastUri":"vlan://2001","isolationUri":"vlan://2001","isSecurityGroupEnabled":false},
{"deviceId":0 ,"networkRateMbps":200,"defaultNic":false,"uuid":"8bff62d8-2bc2-4862-a8ac-0ac729271b59","ip":"10.200.240.20","netmask":"255.255.255.224","gateway":"10.200.240.1","mac":"06:ec:fe:00:00:6e","dns1":"10.200.193.1","dn s2":"10.94.53.3","broadcastType":"Vlan","type":"Guest","broadcastUri":"vlan://2000","isolationUri":"vlan://2000","isSecurityGroupEnabled":false},
{"deviceId":2,"networkRateMbps":200,"defaultNic":false,"uuid":"9c493 0a7-0f0f-4193-a01e-a2c212c4d877","ip":"10.200.248.29","netmask":"255.255.255.224","gateway":"10.200.248.1","mac":"06:7f:9a:00:00:a3","dns1":"10.200.193.1","dns2":"10.94.53.3","broadcastType":"Vlan","type":"Guest", "broadcastUri":"vlan://2002","isolationUri":"vlan://2002","isSecurityGroupEnabled":false}]},"result":false,"details":"StartCommand failed due to Exception: java.lang.Exception\nMessage: Failed to configure VM befo
re start. vmName: i-3-108-VM\n","wait":0}}] }
2013-06-07 15:25:23,966 DEBUG [agent.transport.Request] (Job-Executor-43:job-335) Seq 12-1996690158: Received: { Ans: , MgmtId: 345051320502, via: 12, Ver: v1, Flags: 110,
}
2013-06-07 15:25:23,967 DEBUG [agent.manager.AgentAttache] (DirectAgent-54:null) Seq 12-1996690158: No more commands found
With same VM with 2 volumes, we can start it from CS.