cloudstack-issues mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From "ilya musayev (JIRA)" <j...@apache.org>
Subject [jira] [Commented] (CLOUDSTACK-2895) Can't start a VM with 3 volumes attached [VMWare]
Date Wed, 14 Aug 2013 15:49:48 GMT

    [ https://issues.apache.org/jira/browse/CLOUDSTACK-2895?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=13739793#comment-13739793 ] 

ilya musayev commented on CLOUDSTACK-2895:
------------------------------------------

Nicolas and Guillaume,

I've spent a bit of time looking at this, unfortunately i dont have a vmware lab with NFS servers to try this on, but i tried reading the issue through logs you've posted. I took a blob of output and parsed it with json.tool to make it more readable. You can see the start command passes something like the content below.

Unfortunatelly, the VMware log provides nothing useful. Specifically, it would not say exactly where the issue occurred (as it had in past for me with other vmware issues and ACS, it would pinpoint which hash pair had an issue) and that makes identifying the problem very difficult.

Please do the following:
0) write down the start time
1) Enable trace logging on vsphere
2) Create a VM with two disks and start  (note the name)
3) Create a VM with 3 disks and start (note the name)
For 2 and 3, everything must be identical except for number of disks. I also notice that you were using Debian Wheezy ISO, please refrain from using ISO at the moment to narrow down the scope. Both 2 and 3 must be on the same done on the same ESXi host.
4) submit the logs for both ESXi and ACS to this issue

The end goal is to extract an output you can see below and see whats different and if we can pinpoint the issue. If we can have vSphere give us the proper InvalidProperty - it would simplify troubleshooting by far, hence better logging is needed.

 

[root@minigiant5 ~]# cat /tmp/c | python -mjson.tool
{
    "StartCommand": {
        "hostIp": "10.200.200.18",
        "vm": {
            "arch": "x86_64",
            "bootArgs": "",
            "bootloader": "HVM",
            "cpus": 1,
            "disks": [
                {
                    "deviceId": 0,
                    "id": 2273,
                    "mountPoint": "/ifs/cloud/chevilly/clustervmw-prod/primarystorage",
                    "name": "ROOT-1713",
                    "path": "ROOT-1713-2273",
                    "size": 9663676416,
                    "storagePoolType": "NetworkFilesystem",
                    "storagePoolUuid": "d9ddfc82-c3a8-311f-b8c6-57b765af0630",
                    "type": "ROOT"
                },
                {
                    "deviceId": 1,
                    "id": 2336,
                    "mountPoint": "/ifs/cloud/chevilly/clustervmw-prod/primarystorage",
                    "name": "CSCloud1",
                    "path": "47e7b6fe81dd41fcaddb813f6a798990",
                    "size": 1073741824,
                    "storagePoolType": "NetworkFilesystem",
                    "storagePoolUuid": "d9ddfc82-c3a8-311f-b8c6-57b765af0630",
                    "type": "DATADISK"
                },
                {
                    "deviceId": 1,
                    "id": 2337,
                    "mountPoint": "/ifs/cloud/chevilly/clustervmw-prod/primarystorage",
                    "name": "CSCloud2",
                    "path": "724e0f08af1f494ea5bd885c26fce530",
                    "size": 1073741824,
                    "storagePoolType": "NetworkFilesystem",
                    "storagePoolUuid": "d9ddfc82-c3a8-311f-b8c6-57b765af0630",
                    "type": "DATADISK"
                },
                {
                    "deviceId": 1,
                    "id": 2338,
                    "mountPoint": "/ifs/cloud/chevilly/clustervmw-prod/primarystorage",
                    "name": "CSCloud3",
                    "path": "953369cbb0d4431c92898ef8c69d2979",
                    "size": 1073741824,
                    "storagePoolType": "NetworkFilesystem",
                    "storagePoolUuid": "d9ddfc82-c3a8-311f-b8c6-57b765af0630",
                    "type": "DATADISK"
                },
                {
                    "deviceId": 3,
                    "id": 1713,
                    "name": "Debian 7 (wheezy) 64b #wasfo#",
                    "size": 0,
                    "storagePoolType": "ISO",
                    "type": "ISO"
                }
            ],
            "enableHA": false,
            "id": 1713,
            "limitCpuUse": false,
            "maxRam": 1073741824,
            "minRam": 1073741824,
            "name": "i-26-1713-VM",
            "nics": [
                {
                    "broadcastType": "Vlan",
                    "broadcastUri": "vlan://3061",
                    "defaultNic": true,
                    "deviceId": 2,
                    "dns1": "10.200.193.1",
                    "dns2": "10.94.53.3",
                    "gateway": "10.200.64.193",
                    "ip": "10.200.64.206",
                    "isSecurityGroupEnabled": false,
                    "isolationUri": "vlan://3061",
                    "mac": "06:32:82:00:0d:78",
                    "netmask": "255.255.255.192",
                    "networkRateMbps": 200,
                    "type": "Guest",
                    "uuid": "4cf5f738-7848-49b2-96b6-8e28a557a377"
                },
                {
                    "broadcastType": "Vlan",
                    "broadcastUri": "vlan://3062",
                    "defaultNic": false,
                    "deviceId": 0,
                    "dns1": "10.200.193.1",
                    "dns2": "10.94.53.3",
                    "gateway": "10.200.128.193",
                    "ip": "10.200.128.214",
                    "isSecurityGroupEnabled": false,
                    "isolationUri": "vlan://3062",
                    "mac": "06:8c:4a:00:0d:91",
                    "netmask": "255.255.255.128",
                    "networkRateMbps": 200,
                    "type": "Guest",
                    "uuid": "03ae96ab-5e14-4e23-9be0-f9bac9c4f980"
                },
                {
                    "broadcastType": "Vlan",
                    "broadcastUri": "vlan://3060",
                    "defaultNic": false,
                    "deviceId": 1,
                    "dns1": "10.200.193.1",
                    "dns2": "10.94.53.3",
                    "gateway": "10.200.0.193",
                    "ip": "10.200.0.205",
                    "isSecurityGroupEnabled": false,
                    "isolationUri": "vlan://3060",
                    "mac": "06:37:86:00:0d:5c",
                    "netmask": "255.255.255.192",
                    "networkRateMbps": 200,
                    "type": "Guest",
                    "uuid": "e192ad91-60a1-446b-81f2-e0ede8558094"
                }
            ],
            "os": "None",
            "params": {
                "nicAdapter": "E1000"
            },
            "rebootOnCrash": false,
            "speed": 1000,
            "type": "User",
            "uuid": "33754795-21a1-47bd-bbc2-030182e9f8db",
            "vncPassword": "e424882dfe18ad65"
        },
        "wait": 0
    }
}

Regards
ilya

PS: I share your frustration and understand your situation, I've had similar issues too, and so did many others. I'm also certain you realize that this is an open source project and people contribute their time at their will to best of their ability. I had to switch my mentality and go from reporter to a debugger - i found it could speed up the resolution of the issues and you get to understand the product better.

                
> Can't start a VM with 3 volumes attached [VMWare]
> -------------------------------------------------
>
>                 Key: CLOUDSTACK-2895
>                 URL: https://issues.apache.org/jira/browse/CLOUDSTACK-2895
>             Project: CloudStack
>          Issue Type: Bug
>      Security Level: Public(Anyone can view this level - this is the default.) 
>    Affects Versions: 4.1.0, 4.2.0
>            Reporter: Nicolas Lamirault
>             Fix For: 4.1.1
>
>         Attachments: CloudStack_VM_Volumes_Error.png, CloudStack_VM_Volumes.png, CloudStack_VM_Volumes_Starting.png, CloudStack_VM_Volumes_VSPhere.png, i-26-1713-VM.vmx
>
>
> 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) {
> -->       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) {
> -->                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) {
> -->                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 = "5940",
> -->       }
> -->    ],
> -->    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":{"nicAdapter":"E1000"},"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":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","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: {"id":108,"name":"debian6#web#","size":0,"type":"ISO","storagePo
> olType":"ISO","deviceId":3}
> 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":{"label":"Lect
> eur CD/DVD 1","summary":"Périphérique distant","__hashCodeCalc":false},"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":{"startCo
> nnected":true,"allowGuestControl":false,"connected":true,"__hashCodeCalc":false},"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":{"startConnected":true,"allowGuestControl":false,"connected":true,"__hashCodeCalc":false},"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":{"startConnected":true,"allowGuestControl":false,"connected":true,"__hashCodeCalc":false},"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":{"startConnected":true,"allowGuestControl":false,"connected":true,"__hashCodeCalc":false},"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: {"deviceId":0,"networkRateMbps":200,"defaultNic":false,"uuid":"8b
> ff62d8-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":"Gues
> t","broadcastUri":"vlan://2000","isolationUri":"vlan://2000","isSecurityGroupEnabled":false}
> 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":{"_value_":"add"},"device":{"__hashCodeCalc":false,"addressTy
> pe":"Manual","macAddress":"06:ec:fe:00:00:6e","key":-6,"backing":{"network":{"_value":"network-1392","type":"Network","__hashCodeCalc":false},"__hashCodeCalc":false,"deviceName":"cloud.guest.2000.200.1-vSwitch0"},
> "connectable":{"startConnected":true,"allowGuestControl":true,"connected":true,"__hashCodeCalc":false},"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: {"deviceId":1,"networkRateMbps":200,"defaultNic":true,"uuid":"a3d
> 1e187-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}
> 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":{"_value_":"add"},"device":{"__hashCodeCalc":false,"addressTy
> pe":"Manual","macAddress":"06:32:ec:00:00:87","key":-7,"backing":{"network":{"_value":"network-1386","type":"Network","__hashCodeCalc":false},"__hashCodeCalc":false,"deviceName":"cloud.guest.2001.200.1-vSwitch0"},
> "connectable":{"startConnected":true,"allowGuestControl":true,"connected":true,"__hashCodeCalc":false},"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: {"deviceId":2,"networkRateMbps":200,"defaultNic":false,"uuid":"9c
> 4930a7-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":"Gues
> t","broadcastUri":"vlan://2002","isolationUri":"vlan://2002","isSecurityGroupEnabled":false}
> 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":{"_value_":"add"},"device":{"__hashCodeCalc":false,"addressTy
> pe":"Manual","macAddress":"06:7f:9a:00:00:a3","key":-8,"backing":{"network":{"_value":"network-1389","type":"Network","__hashCodeCalc":false},"__hashCodeCalc":false,"deviceName":"cloud.guest.2002.200.1-vSwitch0"},
> "connectable":{"startConnected":true,"allowGuestControl":true,"connected":true,"__hashCodeCalc":false},"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":{"nicAdapter":"E1000"},"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, { StartAnswer } }
> 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. 

--
This message is automatically generated by JIRA.
If you think it was sent incorrectly, please contact your JIRA administrators
For more information on JIRA, see: http://www.atlassian.com/software/jira

Mime
View raw message