Hello, I just build a fresh install of Cloudstack 4.4, using XenServer and Centos Management server. I was able to create a advance zone, Systems VMs were created without issues. when I try to build an instance for the first time, it created a router. I was able to log in to router ping google. but building the instance failed.
Error "Status" Job failed due to exception Unable to create a deployment for VM[User|i-2-7-VM]
2014-08-13 11:07:00,073 DEBUG [c.c.v.VirtualMachineManagerImpl] (catalina-exec-12:ctx-216da1e8 ctx-962dced4) Allocating entries for VM: VM[User|i-2-7-VM] 2014-08-13 11:07:00,074 DEBUG [c.c.v.VirtualMachineManagerImpl] (catalina-exec-12:ctx-216da1e8 ctx-962dced4) Allocating nics for VM[User|i-2-7-VM] 2014-08-13 11:07:00,074 DEBUG [o.a.c.e.o.NetworkOrchestrator] (catalina-exec-12:ctx-216da1e8 ctx-962dced4) Allocating nic for vm VM[User|i-2-7-VM] in network Ntwk[e8b8f8a7-a1a0-4a43-aef4-5b57b542a0b3|Guest|8] with requested profile NicProfile[0-0-null-null-null 2014-08-13 11:07:00,142 DEBUG [c.c.v.VirtualMachineManagerImpl] (catalina-exec-12:ctx-216da1e8 ctx-962dced4) Allocating disks for VM[User|i-2-7-VM] 2014-08-13 11:07:00,151 DEBUG [c.c.v.VirtualMachineManagerImpl] (catalina-exec-12:ctx-216da1e8 ctx-962dced4) Allocation completed for VM: VM[User|i-2-7-VM] 2014-08-13 11:07:00,151 DEBUG [c.c.v.UserVmManagerImpl] (catalina-exec-12:ctx-216da1e8 ctx-962dced4) Successfully allocated DB entry for VM[User|i-2-7-VM] 2014-08-13 11:07:02,415 DEBUG [c.c.v.VirtualMachineManagerImpl] (Work-Job-Executor-16:ctx-81009c35 job-60/job-61 ctx-20448d5c) Successfully transitioned to start state for VM[User|i-2-7-VM] reservation id = 323beb1f-ee27-4b5c-a3d3-b86be5aa10bf 2014-08-13 11:07:02,483 DEBUG [c.c.v.VirtualMachineManagerImpl] (Work-Job-Executor-16:ctx-81009c35 job-60/job-61 ctx-20448d5c) Deployment found - P0=VM[User|i-2-7-VM], P0=Dest[Zone(Id)-Pod(Id)-Cluster(Id)-Host(Id)-Storage(Volume(Id|Type-->Pool(Id))] : Dest[Zone(1)-Pod(1)-Cluster(1)-Host(3)-Storage(Volume(7|ROOT-->Pool(1))] 2014-08-13 11:07:04,473 DEBUG [o.a.c.e.o.VolumeOrchestrator] (Work-Job-Executor-16:ctx-81009c35 job-60/job-61 ctx-20448d5c) Checking if we need to prepare 1 volumes for VM[User|i-2-7-VM] 2014-08-13 11:07:04,616 DEBUG [c.c.a.t.Request] (Work-Job-Executor-16:ctx-81009c35 job-60/job-61 ctx-20448d5c) Seq 2-4135711832809668663: Sending { Cmd , MgmtId: 113356693032, via: 2(xen1), Ver: v1, Flags: 100011, [{"org.apache.cloudstack.storage.command.CreateObjectCommand":{"data":{"org.apache.cloudstack.storage.to.VolumeObjectTO":{"uuid":"87e3cf39-18f5-488a-969a-94cf3dc7f668","volumeType":"ROOT","dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"xen-1","id":1,"poolType":"PreSetup","host":"localhost","path":"/xen-1","port":0,"url":"PreSetup://localhost/xen-1/?ROLE=Primary&STOREUUID=xen-1"}},"name":"ROOT-7","size":5368709120,"volumeId":7,"vmName":"i-2-7-VM","accountId":2,"format":"VHD","id":7,"deviceId":0,"hypervisorType":"XenServer"}},"wait":0}}] } 2014-08-13 11:07:04,616 DEBUG [c.c.a.t.Request] (Work-Job-Executor-16:ctx-81009c35 job-60/job-61 ctx-20448d5c) Seq 2-4135711832809668663: Executing: { Cmd , MgmtId: 113356693032, via: 2(xen1), Ver: v1, Flags: 100011, [{"org.apache.cloudstack.storage.command.CreateObjectCommand":{"data":{"org.apache.cloudstack.storage.to.VolumeObjectTO":{"uuid":"87e3cf39-18f5-488a-969a-94cf3dc7f668","volumeType":"ROOT","dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"xen-1","id":1,"poolType":"PreSetup","host":"localhost","path":"/xen-1","port":0,"url":"PreSetup://localhost/xen-1/?ROLE=Primary&STOREUUID=xen-1"}},"name":"ROOT-7","size":5368709120,"volumeId":7,"vmName":"i-2-7-VM","accountId":2,"format":"VHD","id":7,"deviceId":0,"hypervisorType":"XenServer"}},"wait":0}}] } 2014-08-13 11:07:08,041 DEBUG [c.c.a.t.Request] (Work-Job-Executor-16:ctx-81009c35 job-60/job-61 ctx-20448d5c) Seq 3-2752262322276794416: Sending { Cmd , MgmtId: 113356693032, via: 3(xen3), Ver: v1, Flags: 100011, [{"com.cloud.agent.api.StartCommand":{"vm":{"id":7,"name":"i-2-7-VM","bootloader":"CD","type":"User","cpus":1,"minSpeed":1000,"maxSpeed":1000,"minRam":1073741824,"maxRam":1073741824,"arch":"x86_64","os":"CentOS 6.5 (64-bit)","bootArgs":"","rebootOnCrash":false,"enableHA":false,"limitCpuUse":false,"enableDynamicallyScaleVm":false,"vncPassword":"2d6edfaf38aa272","params":{},"uuid":"e92e339e-d5a8-44c8-89ce-98c2e9cc9192","disks":[{"data":{"org.apache.cloudstack.storage.to.VolumeObjectTO":{"uuid":"87e3cf39-18f5-488a-969a-94cf3dc7f668","volumeType":"ROOT","dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"xen-1","id":1,"poolType":"PreSetup","host":"localhost","path":"/xen-1","port":0,"url":"PreSetup://localhost/xen-1/?ROLE=Primary&STOREUUID=xen-1"}},"name":"ROOT-7","size":5368709120,"path":"5249db5f-16d9-4883-b86c-ad0ca6e6f690","volumeId":7,"vmName":"i-2-7-VM","accountId":2,"format":"VHD","id":7,"deviceId":0,"hypervisorType":"XenServer"}},"diskSeq":0,"path":"5249db5f-16d9-4883-b86c-ad0ca6e6f690","type":"ROOT","_details":{"managed":"false","storagePort":"0","storageHost":"localhost","volumeSize":"5368709120"}},{"data":{"org.apache.cloudstack.storage.to.TemplateObjectTO":{"path":"template/tmpl/2/203/203-2-b181ffd4-81b7-39c4-874d-a86747f2ca48.iso","origUrl":"http://mirror.hmc.edu/centos/6.5/isos/x86_64/CentOS-6.5-x86_64-minimal.iso","uuid":"15ba8ace-7d30-4d2d-bef9-28d882600780","id":203,"format":"ISO","accountId":2,"checksum":"0d9dc37b5dd4befa1c440d2174e88a87","hvm":true,"displayText":"Centos6.5 64bit ISO","imageDataStore":{"com.cloud.agent.api.to.NfsTO":{"_url":"nfs://10.107.0.6/export/secondary","_role":"Image"}},"name":"203-2-b181ffd4-81b7-39c4-874d-a86747f2ca48","guestOsType":"CentOS 6.5 (64-bit)","hypervisorType":"None"}},"diskSeq":3,"type":"ISO"}],"nics":[{"deviceId":0,"networkRateMbps":200,"defaultNic":true,"uuid":"e8b8f8a7-a1a0-4a43-aef4-5b57b542a0b3","ip":"10.10.1.122","netmask":"255.255.255.0","gateway":"10.10.1.1","mac":"02:00:39:23:00:04","dns1":"207.68.36.2","dns2":"207.68.37.2","broadcastType":"Vlan","type":"Guest","broadcastUri":"vlan://502","isolationUri":"vlan://502","isSecurityGroupEnabled":false,"name":"cloudstack1"}]},"hostIp":"10.107.0.13","executeInSequence":false,"wait":0}}] } 2014-08-13 11:07:08,041 DEBUG [c.c.a.t.Request] (Work-Job-Executor-16:ctx-81009c35 job-60/job-61 ctx-20448d5c) Seq 3-2752262322276794416: Executing: { Cmd , MgmtId: 113356693032, via: 3(xen3), Ver: v1, Flags: 100011, [{"com.cloud.agent.api.StartCommand":{"vm":{"id":7,"name":"i-2-7-VM","bootloader":"CD","type":"User","cpus":1,"minSpeed":1000,"maxSpeed":1000,"minRam":1073741824,"maxRam":1073741824,"arch":"x86_64","os":"CentOS 6.5 (64-bit)","bootArgs":"","rebootOnCrash":false,"enableHA":false,"limitCpuUse":false,"enableDynamicallyScaleVm":false,"vncPassword":"2d6edfaf38aa272","params":{},"uuid":"e92e339e-d5a8-44c8-89ce-98c2e9cc9192","disks":[{"data":{"org.apache.cloudstack.storage.to.VolumeObjectTO":{"uuid":"87e3cf39-18f5-488a-969a-94cf3dc7f668","volumeType":"ROOT","dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"xen-1","id":1,"poolType":"PreSetup","host":"localhost","path":"/xen-1","port":0,"url":"PreSetup://localhost/xen-1/?ROLE=Primary&STOREUUID=xen-1"}},"name":"ROOT-7","size":5368709120,"path":"5249db5f-16d9-4883-b86c-ad0ca6e6f690","volumeId":7,"vmName":"i-2-7-VM","accountId":2,"format":"VHD","id":7,"deviceId":0,"hypervisorType":"XenServer"}},"diskSeq":0,"path":"5249db5f-16d9-4883-b86c-ad0ca6e6f690","type":"ROOT","_details":{"managed":"false","storagePort":"0","storageHost":"localhost","volumeSize":"5368709120"}},{"data":{"org.apache.cloudstack.storage.to.TemplateObjectTO":{"path":"template/tmpl/2/203/203-2-b181ffd4-81b7-39c4-874d-a86747f2ca48.iso","origUrl":"http://mirror.hmc.edu/centos/6.5/isos/x86_64/CentOS-6.5-x86_64-minimal.iso","uuid":"15ba8ace-7d30-4d2d-bef9-28d882600780","id":203,"format":"ISO","accountId":2,"checksum":"0d9dc37b5dd4befa1c440d2174e88a87","hvm":true,"displayText":"Centos6.5 64bit ISO","imageDataStore":{"com.cloud.agent.api.to.NfsTO":{"_url":"nfs://10.107.0.6/export/secondary","_role":"Image"}},"name":"203-2-b181ffd4-81b7-39c4-874d-a86747f2ca48","guestOsType":"CentOS 6.5 (64-bit)","hypervisorType":"None"}},"diskSeq":3,"type":"ISO"}],"nics":[{"deviceId":0,"networkRateMbps":200,"defaultNic":true,"uuid":"e8b8f8a7-a1a0-4a43-aef4-5b57b542a0b3","ip":"10.10.1.122","netmask":"255.255.255.0","gateway":"10.10.1.1","mac":"02:00:39:23:00:04","dns1":"207.68.36.2","dns2":"207.68.37.2","broadcastType":"Vlan","type":"Guest","broadcastUri":"vlan://502","isolationUri":"vlan://502","isSecurityGroupEnabled":false,"name":"cloudstack1"}]},"hostIp":"10.107.0.13","executeInSequence":false,"wait":0}}] } 2014-08-13 11:07:08,050 DEBUG [c.c.h.x.r.CitrixResourceBase] (DirectAgent-157:ctx-3053cad5) 1. The VM i-2-7-VM is in Starting state. 2014-08-13 11:07:08,055 WARN [c.c.h.x.r.CitrixResourceBase] (DirectAgent-157:ctx-3053cad5) Unable to start i-2-7-VM due to 2014-08-13 11:07:08,056 DEBUG [c.c.h.x.r.CitrixResourceBase] (DirectAgent-157:ctx-3053cad5) The VM is in stopped state, detected problem during startup : i-2-7-VM 2014-08-13 11:07:08,057 DEBUG [c.c.a.t.Request] (DirectAgent-157:ctx-3053cad5) Seq 3-2752262322276794416: Processing: { Ans: , MgmtId: 113356693032, via: 3, Ver: v1, Flags: 10, [{"com.cloud.agent.api.StartAnswer":{"vm":{"id":7,"name":"i-2-7-VM","bootloader":"CD","type":"User","cpus":1,"minSpeed":1000,"maxSpeed":1000,"minRam":1073741824,"maxRam":1073741824,"arch":"x86_64","os":"CentOS 6.5 (64-bit)","bootArgs":"","rebootOnCrash":false,"enableHA":false,"limitCpuUse":false,"enableDynamicallyScaleVm":false,"vncPassword":"2d6edfaf38aa272","params":{},"uuid":"e92e339e-d5a8-44c8-89ce-98c2e9cc9192","disks":[{"data":{"org.apache.cloudstack.storage.to.VolumeObjectTO":{"uuid":"87e3cf39-18f5-488a-969a-94cf3dc7f668","volumeType":"ROOT","dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"xen-1","id":1,"poolType":"PreSetup","host":"localhost","path":"/xen-1","port":0,"url":"PreSetup://localhost/xen-1/?ROLE=Primary&STOREUUID=xen-1"}},"name":"ROOT-7","size":5368709120,"path":"5249db5f-16d9-4883-b86c-ad0ca6e6f690","volumeId":7,"vmName":"i-2-7-VM","accountId":2,"format":"VHD","id":7,"deviceId":0,"hypervisorType":"XenServer"}},"diskSeq":0,"path":"5249db5f-16d9-4883-b86c-ad0ca6e6f690","type":"ROOT","_details":{"managed":"false","storagePort":"0","storageHost":"localhost","volumeSize":"5368709120"}},{"data":{"org.apache.cloudstack.storage.to.TemplateObjectTO":{"path":"template/tmpl/2/203/203-2-b181ffd4-81b7-39c4-874d-a86747f2ca48.iso","origUrl":"http://mirror.hmc.edu/centos/6.5/isos/x86_64/CentOS-6.5-x86_64-minimal.iso","uuid":"15ba8ace-7d30-4d2d-bef9-28d882600780","id":203,"format":"ISO","accountId":2,"checksum":"0d9dc37b5dd4befa1c440d2174e88a87","hvm":true,"displayText":"Centos6.5 64bit ISO","imageDataStore":{"com.cloud.agent.api.to.NfsTO":{"_url":"nfs://10.107.0.6/export/secondary","_role":"Image"}},"name":"203-2-b181ffd4-81b7-39c4-874d-a86747f2ca48","guestOsType":"CentOS 6.5 (64-bit)","hypervisorType":"None"}},"diskSeq":3,"type":"ISO"}],"nics":[{"deviceId":0,"networkRateMbps":200,"defaultNic":true,"uuid":"e8b8f8a7-a1a0-4a43-aef4-5b57b542a0b3","ip":"10.10.1.122","netmask":"255.255.255.0","gateway":"10.10.1.1","mac":"02:00:39:23:00:04","dns1":"207.68.36.2","dns2":"207.68.37.2","broadcastType":"Vlan","type":"Guest","broadcastUri":"vlan://502","isolationUri":"vlan://502","isSecurityGroupEnabled":false,"name":"cloudstack1"}]},"_iqnToPath":{},"result":false,"details":"Unable to start i-2-7-VM due to ","wait":0}}] } 2014-08-13 11:07:08,097 INFO [c.c.v.VirtualMachineManagerImpl] (Work-Job-Executor-16:ctx-81009c35 job-60/job-61 ctx-20448d5c) Unable to start VM on Host[-3-Routing] due to Unable to start i-2-7-VM due to 2014-08-13 11:07:08,137 DEBUG [c.c.v.VirtualMachineManagerImpl] (Work-Job-Executor-16:ctx-81009c35 job-60/job-61 ctx-20448d5c) Cleaning up resources for the vm VM[User|i-2-7-VM] in Starting state 2014-08-13 11:07:08,140 DEBUG [c.c.a.t.Request] (Work-Job-Executor-16:ctx-81009c35 job-60/job-61 ctx-20448d5c) Seq 3-2752262322276794417: Sending { Cmd , MgmtId: 113356693032, via: 3(xen3), Ver: v1, Flags: 100011, [{"com.cloud.agent.api.StopCommand":{"isProxy":false,"executeInSequence":false,"checkBeforeCleanup":false,"vmName":"i-2-7-VM","wait":0}}] } 2014-08-13 11:07:08,141 DEBUG [c.c.a.t.Request] (Work-Job-Executor-16:ctx-81009c35 job-60/job-61 ctx-20448d5c) Seq 3-2752262322276794417: Executing: { Cmd , MgmtId: 113356693032, via: 3(xen3), Ver: v1, Flags: 100011, [{"com.cloud.agent.api.StopCommand":{"isProxy":false,"executeInSequence":false,"checkBeforeCleanup":false,"vmName":"i-2-7-VM","wait":0}}] } 2014-08-13 11:07:08,221 DEBUG [c.c.v.VirtualMachineManagerImpl] (Work-Job-Executor-16:ctx-81009c35 job-60/job-61 ctx-20448d5c) Successfully released network resources for the vm VM[User|i-2-7-VM] 2014-08-13 11:07:08,221 DEBUG [c.c.v.VirtualMachineManagerImpl] (Work-Job-Executor-16:ctx-81009c35 job-60/job-61 ctx-20448d5c) Successfully cleanued up resources for the vm VM[User|i-2-7-VM] in Starting state 2014-08-13 11:07:08,459 ERROR [c.c.v.VmWorkJobHandlerProxy] (Work-Job-Executor-16:ctx-81009c35 job-60/job-61 ctx-20448d5c) Invocation exception, caused by: com.cloud.exception.InsufficientServerCapacityException: Unable to create a deployment for VM[User|i-2-7-VM]Scope=interface com.cloud.dc.DataCenter; id=1 2014-08-13 11:07:08,459 INFO [c.c.v.VmWorkJobHandlerProxy] (Work-Job-Executor-16:ctx-81009c35 job-60/job-61 ctx-20448d5c) Rethrow exception com.cloud.exception.InsufficientServerCapacityException: Unable to create a deployment for VM[User|i-2-7-VM]Scope=interface com.cloud.dc.DataCenter; id=1 com.cloud.exception.InsufficientServerCapacityException: Unable to create a deployment for VM[User|i-2-7-VM]Scope=interface com.cloud.dc.DataCenter; id=1 2014-08-13 11:07:10,536 DEBUG [c.c.v.VirtualMachineManagerImpl] (Work-Job-Executor-17:ctx-901a2102 job-60/job-62 ctx-93952e24) Successfully transitioned to start state for VM[User|i-2-7-VM] reservation id = a45274c0-7d55-4df9-8ec2-691b4aa9a4ec 2014-08-13 11:07:10,647 DEBUG [c.c.v.VirtualMachineManagerImpl] (Work-Job-Executor-17:ctx-901a2102 job-60/job-62 ctx-93952e24) Deployment found - P0=VM[User|i-2-7-VM], P0=Dest[Zone(Id)-Pod(Id)-Cluster(Id)-Host(Id)-Storage(Volume(Id|Type-->Pool(Id))] : Dest[Zone(1)-Pod(1)-Cluster(1)-Host(3)-Storage()] 2014-08-13 11:07:12,539 DEBUG [o.a.c.e.o.VolumeOrchestrator] (Work-Job-Executor-17:ctx-901a2102 job-60/job-62 ctx-93952e24) Checking if we need to prepare 1 volumes for VM[User|i-2-7-VM] 2014-08-13 11:07:12,647 DEBUG [c.c.a.t.Request] (Work-Job-Executor-17:ctx-901a2102 job-60/job-62 ctx-93952e24) Seq 3-2752262322276794418: Sending { Cmd , MgmtId: 113356693032, via: 3(xen3), Ver: v1, Flags: 100011, [{"com.cloud.agent.api.StartCommand":{"vm":{"id":7,"name":"i-2-7-VM","bootloader":"CD","type":"User","cpus":1,"minSpeed":1000,"maxSpeed":1000,"minRam":1073741824,"maxRam":1073741824,"arch":"x86_64","os":"CentOS 6.5 (64-bit)","bootArgs":"","rebootOnCrash":false,"enableHA":false,"limitCpuUse":false,"enableDynamicallyScaleVm":false,"vncPassword":"2d6edfaf38aa272","params":{"Message.ReservedCapacityFreed.Flag":"false"},"uuid":"e92e339e-d5a8-44c8-89ce-98c2e9cc9192","disks":[{"data":{"org.apache.cloudstack.storage.to.VolumeObjectTO":{"uuid":"87e3cf39-18f5-488a-969a-94cf3dc7f668","volumeType":"ROOT","dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"xen-1","id":1,"poolType":"PreSetup","host":"localhost","path":"/xen-1","port":0,"url":"PreSetup://localhost/xen-1/?ROLE=Primary&STOREUUID=xen-1"}},"name":"ROOT-7","size":5368709120,"path":"5249db5f-16d9-4883-b86c-ad0ca6e6f690","volumeId":7,"vmName":"i-2-7-VM","accountId":2,"format":"VHD","id":7,"deviceId":0,"hypervisorType":"XenServer"}},"diskSeq":0,"path":"5249db5f-16d9-4883-b86c-ad0ca6e6f690","type":"ROOT","_details":{"managed":"false","storagePort":"0","storageHost":"localhost","volumeSize":"5368709120"}},{"data":{"org.apache.cloudstack.storage.to.TemplateObjectTO":{"path":"template/tmpl/2/203/203-2-b181ffd4-81b7-39c4-874d-a86747f2ca48.iso","origUrl":"http://mirror.hmc.edu/centos/6.5/isos/x86_64/CentOS-6.5-x86_64-minimal.iso","uuid":"15ba8ace-7d30-4d2d-bef9-28d882600780","id":203,"format":"ISO","accountId":2,"checksum":"0d9dc37b5dd4befa1c440d2174e88a87","hvm":true,"displayText":"Centos6.5 64bit ISO","imageDataStore":{"com.cloud.agent.api.to.NfsTO":{"_url":"nfs://10.107.0.6/export/secondary","_role":"Image"}},"name":"203-2-b181ffd4-81b7-39c4-874d-a86747f2ca48","guestOsType":"CentOS 6.5 (64-bit)","hypervisorType":"None"}},"diskSeq":3,"type":"ISO"}],"nics":[{"deviceId":0,"networkRateMbps":200,"defaultNic":true,"uuid":"e8b8f8a7-a1a0-4a43-aef4-5b57b542a0b3","ip":"10.10.1.122","netmask":"255.255.255.0","gateway":"10.10.1.1","mac":"02:00:39:23:00:04","dns1":"207.68.36.2","dns2":"207.68.37.2","broadcastType":"Vlan","type":"Guest","broadcastUri":"vlan://502","isolationUri":"vlan://502","isSecurityGroupEnabled":false,"name":"cloudstack1"}]},"hostIp":"10.107.0.13","executeInSequence":false,"wait":0}}] } 2014-08-13 11:07:12,648 DEBUG [c.c.a.t.Request] (Work-Job-Executor-17:ctx-901a2102 job-60/job-62 ctx-93952e24) Seq 3-2752262322276794418: Executing: { Cmd , MgmtId: 113356693032, via: 3(xen3), Ver: v1, Flags: 100011, [{"com.cloud.agent.api.StartCommand":{"vm":{"id":7,"name":"i-2-7-VM","bootloader":"CD","type":"User","cpus":1,"minSpeed":1000,"maxSpeed":1000,"minRam":1073741824,"maxRam":1073741824,"arch":"x86_64","os":"CentOS 6.5 (64-bit)","bootArgs":"","rebootOnCrash":false,"enableHA":false,"limitCpuUse":false,"enableDynamicallyScaleVm":false,"vncPassword":"2d6edfaf38aa272","params":{"Message.ReservedCapacityFreed.Flag":"false"},"uuid":"e92e339e-d5a8-44c8-89ce-98c2e9cc9192","disks":[{"data":{"org.apache.cloudstack.storage.to.VolumeObjectTO":{"uuid":"87e3cf39-18f5-488a-969a-94cf3dc7f668","volumeType":"ROOT","dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"xen-1","id":1,"poolType":"PreSetup","host":"localhost","path":"/xen-1","port":0,"url":"PreSetup://localhost/xen-1/?ROLE=Primary&STOREUUID=xen-1"}},"name":"ROOT-7","size":5368709120,"path":"5249db5f-16d9-4883-b86c-ad0ca6e6f690","volumeId":7,"vmName":"i-2-7-VM","accountId":2,"format":"VHD","id":7,"deviceId":0,"hypervisorType":"XenServer"}},"diskSeq":0,"path":"5249db5f-16d9-4883-b86c-ad0ca6e6f690","type":"ROOT","_details":{"managed":"false","storagePort":"0","storageHost":"localhost","volumeSize":"5368709120"}},{"data":{"org.apache.cloudstack.storage.to.TemplateObjectTO":{"path":"template/tmpl/2/203/203-2-b181ffd4-81b7-39c4-874d-a86747f2ca48.iso","origUrl":"http://mirror.hmc.edu/centos/6.5/isos/x86_64/CentOS-6.5-x86_64-minimal.iso","uuid":"15ba8ace-7d30-4d2d-bef9-28d882600780","id":203,"format":"ISO","accountId":2,"checksum":"0d9dc37b5dd4befa1c440d2174e88a87","hvm":true,"displayText":"Centos6.5 64bit ISO","imageDataStore":{"com.cloud.agent.api.to.NfsTO":{"_url":"nfs://10.107.0.6/export/secondary","_role":"Image"}},"name":"203-2-b181ffd4-81b7-39c4-874d-a86747f2ca48","guestOsType":"CentOS 6.5 (64-bit)","hypervisorType":"None"}},"diskSeq":3,"type":"ISO"}],"nics":[{"deviceId":0,"networkRateMbps":200,"defaultNic":true,"uuid":"e8b8f8a7-a1a0-4a43-aef4-5b57b542a0b3","ip":"10.10.1.122","netmask":"255.255.255.0","gateway":"10.10.1.1","mac":"02:00:39:23:00:04","dns1":"207.68.36.2","dns2":"207.68.37.2","broadcastType":"Vlan","type":"Guest","broadcastUri":"vlan://502","isolationUri":"vlan://502","isSecurityGroupEnabled":false,"name":"cloudstack1"}]},"hostIp":"10.107.0.13","executeInSequence":false,"wait":0}}] } 2014-08-13 11:07:12,654 DEBUG [c.c.h.x.r.CitrixResourceBase] (DirectAgent-161:ctx-06261a3d) 1. The VM i-2-7-VM is in Starting state. 2014-08-13 11:07:12,665 WARN [c.c.h.x.r.CitrixResourceBase] (DirectAgent-161:ctx-06261a3d) Unable to start i-2-7-VM due to 2014-08-13 11:07:12,665 DEBUG [c.c.h.x.r.CitrixResourceBase] (DirectAgent-161:ctx-06261a3d) The VM is in stopped state, detected problem during startup : i-2-7-VM 2014-08-13 11:07:12,666 DEBUG [c.c.a.t.Request] (DirectAgent-161:ctx-06261a3d) Seq 3-2752262322276794418: Processing: { Ans: , MgmtId: 113356693032, via: 3, Ver: v1, Flags: 10, [{"com.cloud.agent.api.StartAnswer":{"vm":{"id":7,"name":"i-2-7-VM","bootloader":"CD","type":"User","cpus":1,"minSpeed":1000,"maxSpeed":1000,"minRam":1073741824,"maxRam":1073741824,"arch":"x86_64","os":"CentOS 6.5 (64-bit)","bootArgs":"","rebootOnCrash":false,"enableHA":false,"limitCpuUse":false,"enableDynamicallyScaleVm":false,"vncPassword":"2d6edfaf38aa272","params":{"Message.ReservedCapacityFreed.Flag":"false"},"uuid":"e92e339e-d5a8-44c8-89ce-98c2e9cc9192","disks":[{"data":{"org.apache.cloudstack.storage.to.VolumeObjectTO":{"uuid":"87e3cf39-18f5-488a-969a-94cf3dc7f668","volumeType":"ROOT","dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"xen-1","id":1,"poolType":"PreSetup","host":"localhost","path":"/xen-1","port":0,"url":"PreSetup://localhost/xen-1/?ROLE=Primary&STOREUUID=xen-1"}},"name":"ROOT-7","size":5368709120,"path":"5249db5f-16d9-4883-b86c-ad0ca6e6f690","volumeId":7,"vmName":"i-2-7-VM","accountId":2,"format":"VHD","id":7,"deviceId":0,"hypervisorType":"XenServer"}},"diskSeq":0,"path":"5249db5f-16d9-4883-b86c-ad0ca6e6f690","type":"ROOT","_details":{"managed":"false","storagePort":"0","storageHost":"localhost","volumeSize":"5368709120"}},{"data":{"org.apache.cloudstack.storage.to.TemplateObjectTO":{"path":"template/tmpl/2/203/203-2-b181ffd4-81b7-39c4-874d-a86747f2ca48.iso","origUrl":"http://mirror.hmc.edu/centos/6.5/isos/x86_64/CentOS-6.5-x86_64-minimal.iso","uuid":"15ba8ace-7d30-4d2d-bef9-28d882600780","id":203,"format":"ISO","accountId":2,"checksum":"0d9dc37b5dd4befa1c440d2174e88a87","hvm":true,"displayText":"Centos6.5 64bit ISO","imageDataStore":{"com.cloud.agent.api.to.NfsTO":{"_url":"nfs://10.107.0.6/export/secondary","_role":"Image"}},"name":"203-2-b181ffd4-81b7-39c4-874d-a86747f2ca48","guestOsType":"CentOS 6.5 (64-bit)","hypervisorType":"None"}},"diskSeq":3,"type":"ISO"}],"nics":[{"deviceId":0,"networkRateMbps":200,"defaultNic":true,"uuid":"e8b8f8a7-a1a0-4a43-aef4-5b57b542a0b3","ip":"10.10.1.122","netmask":"255.255.255.0","gateway":"10.10.1.1","mac":"02:00:39:23:00:04","dns1":"207.68.36.2","dns2":"207.68.37.2","broadcastType":"Vlan","type":"Guest","broadcastUri":"vlan://502","isolationUri":"vlan://502","isSecurityGroupEnabled":false,"name":"cloudstack1"}]},"_iqnToPath":{},"result":false,"details":"Unable to start i-2-7-VM due to ","wait":0}}] } 2014-08-13 11:07:12,723 INFO [c.c.v.VirtualMachineManagerImpl] (Work-Job-Executor-17:ctx-901a2102 job-60/job-62 ctx-93952e24) Unable to start VM on Host[-3-Routing] due to Unable to start i-2-7-VM due to 2014-08-13 11:07:12,765 DEBUG [c.c.v.VirtualMachineManagerImpl] (Work-Job-Executor-17:ctx-901a2102 job-60/job-62 ctx-93952e24) Cleaning up resources for the vm VM[User|i-2-7-VM] in Starting state 2014-08-13 11:07:12,768 DEBUG [c.c.a.t.Request] (Work-Job-Executor-17:ctx-901a2102 job-60/job-62 ctx-93952e24) Seq 3-2752262322276794419: Sending { Cmd , MgmtId: 113356693032, via: 3(xen3), Ver: v1, Flags: 100011, [{"com.cloud.agent.api.StopCommand":{"isProxy":false,"executeInSequence":false,"checkBeforeCleanup":false,"vmName":"i-2-7-VM","wait":0}}] } 2014-08-13 11:07:12,769 DEBUG [c.c.a.t.Request] (Work-Job-Executor-17:ctx-901a2102 job-60/job-62 ctx-93952e24) Seq 3-2752262322276794419: Executing: { Cmd , MgmtId: 113356693032, via: 3(xen3), Ver: v1, Flags: 100011, [{"com.cloud.agent.api.StopCommand":{"isProxy":false,"executeInSequence":false,"checkBeforeCleanup":false,"vmName":"i-2-7-VM","wait":0}}] } 2014-08-13 11:07:12,837 DEBUG [c.c.v.VirtualMachineManagerImpl] (Work-Job-Executor-17:ctx-901a2102 job-60/job-62 ctx-93952e24) Successfully released network resources for the vm VM[User|i-2-7-VM] 2014-08-13 11:07:12,837 DEBUG [c.c.v.VirtualMachineManagerImpl] (Work-Job-Executor-17:ctx-901a2102 job-60/job-62 ctx-93952e24) Successfully cleanued up resources for the vm VM[User|i-2-7-VM] in Starting state 2014-08-13 11:07:12,892 DEBUG [c.c.v.VirtualMachineManagerImpl] (Work-Job-Executor-17:ctx-901a2102 job-60/job-62 ctx-93952e24) Deployment found - P0=VM[User|i-2-7-VM], P0=Dest[Zone(Id)-Pod(Id)-Cluster(Id)-Host(Id)-Storage(Volume(Id|Type-->Pool(Id))] : Dest[Zone(1)-Pod(1)-Cluster(1)-Host(1)-Storage()] 2014-08-13 11:07:15,041 DEBUG [o.a.c.e.o.VolumeOrchestrator] (Work-Job-Executor-17:ctx-901a2102 job-60/job-62 ctx-93952e24) Checking if we need to prepare 1 volumes for VM[User|i-2-7-VM] 2014-08-13 11:07:15,148 DEBUG [c.c.a.t.Request] (Work-Job-Executor-17:ctx-901a2102 job-60/job-62 ctx-93952e24) Seq 1-2224496740944314441: Sending { Cmd , MgmtId: 113356693032, via: 1(xen2), Ver: v1, Flags: 100011, [{"com.cloud.agent.api.StartCommand":{"vm":{"id":7,"name":"i-2-7-VM","bootloader":"CD","type":"User","cpus":1,"minSpeed":1000,"maxSpeed":1000,"minRam":1073741824,"maxRam":1073741824,"arch":"x86_64","os":"CentOS 6.5 (64-bit)","bootArgs":"","rebootOnCrash":false,"enableHA":false,"limitCpuUse":false,"enableDynamicallyScaleVm":false,"vncPassword":"2d6edfaf38aa272","params":{"Message.ReservedCapacityFreed.Flag":"false"},"uuid":"e92e339e-d5a8-44c8-89ce-98c2e9cc9192","disks":[{"data":{"org.apache.cloudstack.storage.to.VolumeObjectTO":{"uuid":"87e3cf39-18f5-488a-969a-94cf3dc7f668","volumeType":"ROOT","dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"xen-1","id":1,"poolType":"PreSetup","host":"localhost","path":"/xen-1","port":0,"url":"PreSetup://localhost/xen-1/?ROLE=Primary&STOREUUID=xen-1"}},"name":"ROOT-7","size":5368709120,"path":"5249db5f-16d9-4883-b86c-ad0ca6e6f690","volumeId":7,"vmName":"i-2-7-VM","accountId":2,"format":"VHD","id":7,"deviceId":0,"hypervisorType":"XenServer"}},"diskSeq":0,"path":"5249db5f-16d9-4883-b86c-ad0ca6e6f690","type":"ROOT","_details":{"managed":"false","storagePort":"0","storageHost":"localhost","volumeSize":"5368709120"}},{"data":{"org.apache.cloudstack.storage.to.TemplateObjectTO":{"path":"template/tmpl/2/203/203-2-b181ffd4-81b7-39c4-874d-a86747f2ca48.iso","origUrl":"http://mirror.hmc.edu/centos/6.5/isos/x86_64/CentOS-6.5-x86_64-minimal.iso","uuid":"15ba8ace-7d30-4d2d-bef9-28d882600780","id":203,"format":"ISO","accountId":2,"checksum":"0d9dc37b5dd4befa1c440d2174e88a87","hvm":true,"displayText":"Centos6.5 64bit ISO","imageDataStore":{"com.cloud.agent.api.to.NfsTO":{"_url":"nfs://10.107.0.6/export/secondary","_role":"Image"}},"name":"203-2-b181ffd4-81b7-39c4-874d-a86747f2ca48","guestOsType":"CentOS 6.5 (64-bit)","hypervisorType":"None"}},"diskSeq":3,"type":"ISO"}],"nics":[{"deviceId":0,"networkRateMbps":200,"defaultNic":true,"uuid":"e8b8f8a7-a1a0-4a43-aef4-5b57b542a0b3","ip":"10.10.1.122","netmask":"255.255.255.0","gateway":"10.10.1.1","mac":"02:00:39:23:00:04","dns1":"207.68.36.2","dns2":"207.68.37.2","broadcastType":"Vlan","type":"Guest","broadcastUri":"vlan://502","isolationUri":"vlan://502","isSecurityGroupEnabled":false,"name":"cloudstack1"}]},"hostIp":"10.107.0.12","executeInSequence":false,"wait":0}}] } 2014-08-13 11:07:15,149 DEBUG [c.c.a.t.Request] (Work-Job-Executor-17:ctx-901a2102 job-60/job-62 ctx-93952e24) Seq 1-2224496740944314441: Executing: { Cmd , MgmtId: 113356693032, via: 1(xen2), Ver: v1, Flags: 100011, [{"com.cloud.agent.api.StartCommand":{"vm":{"id":7,"name":"i-2-7-VM","bootloader":"CD","type":"User","cpus":1,"minSpeed":1000,"maxSpeed":1000,"minRam":1073741824,"maxRam":1073741824,"arch":"x86_64","os":"CentOS 6.5 (64-bit)","bootArgs":"","rebootOnCrash":false,"enableHA":false,"limitCpuUse":false,"enableDynamicallyScaleVm":false,"vncPassword":"2d6edfaf38aa272","params":{"Message.ReservedCapacityFreed.Flag":"false"},"uuid":"e92e339e-d5a8-44c8-89ce-98c2e9cc9192","disks":[{"data":{"org.apache.cloudstack.storage.to.VolumeObjectTO":{"uuid":"87e3cf39-18f5-488a-969a-94cf3dc7f668","volumeType":"ROOT","dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"xen-1","id":1,"poolType":"PreSetup","host":"localhost","path":"/xen-1","port":0,"url":"PreSetup://localhost/xen-1/?ROLE=Primary&STOREUUID=xen-1"}},"name":"ROOT-7","size":5368709120,"path":"5249db5f-16d9-4883-b86c-ad0ca6e6f690","volumeId":7,"vmName":"i-2-7-VM","accountId":2,"format":"VHD","id":7,"deviceId":0,"hypervisorType":"XenServer"}},"diskSeq":0,"path":"5249db5f-16d9-4883-b86c-ad0ca6e6f690","type":"ROOT","_details":{"managed":"false","storagePort":"0","storageHost":"localhost","volumeSize":"5368709120"}},{"data":{"org.apache.cloudstack.storage.to.TemplateObjectTO":{"path":"template/tmpl/2/203/203-2-b181ffd4-81b7-39c4-874d-a86747f2ca48.iso","origUrl":"http://mirror.hmc.edu/centos/6.5/isos/x86_64/CentOS-6.5-x86_64-minimal.iso","uuid":"15ba8ace-7d30-4d2d-bef9-28d882600780","id":203,"format":"ISO","accountId":2,"checksum":"0d9dc37b5dd4befa1c440d2174e88a87","hvm":true,"displayText":"Centos6.5 64bit ISO","imageDataStore":{"com.cloud.agent.api.to.NfsTO":{"_url":"nfs://10.107.0.6/export/secondary","_role":"Image"}},"name":"203-2-b181ffd4-81b7-39c4-874d-a86747f2ca48","guestOsType":"CentOS 6.5 (64-bit)","hypervisorType":"None"}},"diskSeq":3,"type":"ISO"}],"nics":[{"deviceId":0,"networkRateMbps":200,"defaultNic":true,"uuid":"e8b8f8a7-a1a0-4a43-aef4-5b57b542a0b3","ip":"10.10.1.122","netmask":"255.255.255.0","gateway":"10.10.1.1","mac":"02:00:39:23:00:04","dns1":"207.68.36.2","dns2":"207.68.37.2","broadcastType":"Vlan","type":"Guest","broadcastUri":"vlan://502","isolationUri":"vlan://502","isSecurityGroupEnabled":false,"name":"cloudstack1"}]},"hostIp":"10.107.0.12","executeInSequence":false,"wait":0}}] } 2014-08-13 11:07:15,156 DEBUG [c.c.h.x.r.CitrixResourceBase] (DirectAgent-97:ctx-bbf22f7e) 1. The VM i-2-7-VM is in Starting state. 2014-08-13 11:07:15,162 WARN [c.c.h.x.r.CitrixResourceBase] (DirectAgent-97:ctx-bbf22f7e) Unable to start i-2-7-VM due to 2014-08-13 11:07:15,163 DEBUG [c.c.h.x.r.CitrixResourceBase] (DirectAgent-97:ctx-bbf22f7e) The VM is in stopped state, detected problem during startup : i-2-7-VM 2014-08-13 11:07:15,164 DEBUG [c.c.a.t.Request] (DirectAgent-97:ctx-bbf22f7e) Seq 1-2224496740944314441: Processing: { Ans: , MgmtId: 113356693032, via: 1, Ver: v1, Flags: 10, [{"com.cloud.agent.api.StartAnswer":{"vm":{"id":7,"name":"i-2-7-VM","bootloader":"CD","type":"User","cpus":1,"minSpeed":1000,"maxSpeed":1000,"minRam":1073741824,"maxRam":1073741824,"arch":"x86_64","os":"CentOS 6.5 (64-bit)","bootArgs":"","rebootOnCrash":false,"enableHA":false,"limitCpuUse":false,"enableDynamicallyScaleVm":false,"vncPassword":"2d6edfaf38aa272","params":{"Message.ReservedCapacityFreed.Flag":"false"},"uuid":"e92e339e-d5a8-44c8-89ce-98c2e9cc9192","disks":[{"data":{"org.apache.cloudstack.storage.to.VolumeObjectTO":{"uuid":"87e3cf39-18f5-488a-969a-94cf3dc7f668","volumeType":"ROOT","dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"xen-1","id":1,"poolType":"PreSetup","host":"localhost","path":"/xen-1","port":0,"url":"PreSetup://localhost/xen-1/?ROLE=Primary&STOREUUID=xen-1"}},"name":"ROOT-7","size":5368709120,"path":"5249db5f-16d9-4883-b86c-ad0ca6e6f690","volumeId":7,"vmName":"i-2-7-VM","accountId":2,"format":"VHD","id":7,"deviceId":0,"hypervisorType":"XenServer"}},"diskSeq":0,"path":"5249db5f-16d9-4883-b86c-ad0ca6e6f690","type":"ROOT","_details":{"managed":"false","storagePort":"0","storageHost":"localhost","volumeSize":"5368709120"}},{"data":{"org.apache.cloudstack.storage.to.TemplateObjectTO":{"path":"template/tmpl/2/203/203-2-b181ffd4-81b7-39c4-874d-a86747f2ca48.iso","origUrl":"http://mirror.hmc.edu/centos/6.5/isos/x86_64/CentOS-6.5-x86_64-minimal.iso","uuid":"15ba8ace-7d30-4d2d-bef9-28d882600780","id":203,"format":"ISO","accountId":2,"checksum":"0d9dc37b5dd4befa1c440d2174e88a87","hvm":true,"displayText":"Centos6.5 64bit ISO","imageDataStore":{"com.cloud.agent.api.to.NfsTO":{"_url":"nfs://10.107.0.6/export/secondary","_role":"Image"}},"name":"203-2-b181ffd4-81b7-39c4-874d-a86747f2ca48","guestOsType":"CentOS 6.5 (64-bit)","hypervisorType":"None"}},"diskSeq":3,"type":"ISO"}],"nics":[{"deviceId":0,"networkRateMbps":200,"defaultNic":true,"uuid":"e8b8f8a7-a1a0-4a43-aef4-5b57b542a0b3","ip":"10.10.1.122","netmask":"255.255.255.0","gateway":"10.10.1.1","mac":"02:00:39:23:00:04","dns1":"207.68.36.2","dns2":"207.68.37.2","broadcastType":"Vlan","type":"Guest","broadcastUri":"vlan://502","isolationUri":"vlan://502","isSecurityGroupEnabled":false,"name":"cloudstack1"}]},"_iqnToPath":{},"result":false,"details":"Unable to start i-2-7-VM due to ","wait":0}}] } 2014-08-13 11:07:15,204 INFO [c.c.v.VirtualMachineManagerImpl] (Work-Job-Executor-17:ctx-901a2102 job-60/job-62 ctx-93952e24) Unable to start VM on Host[-1-Routing] due to Unable to start i-2-7-VM due to 2014-08-13 11:07:15,248 DEBUG [c.c.v.VirtualMachineManagerImpl] (Work-Job-Executor-17:ctx-901a2102 job-60/job-62 ctx-93952e24) Cleaning up resources for the vm VM[User|i-2-7-VM] in Starting state 2014-08-13 11:07:15,252 DEBUG [c.c.a.t.Request] (Work-Job-Executor-17:ctx-901a2102 job-60/job-62 ctx-93952e24) Seq 1-2224496740944314442: Sending { Cmd , MgmtId: 113356693032, via: 1(xen2), Ver: v1, Flags: 100011, [{"com.cloud.agent.api.StopCommand":{"isProxy":false,"executeInSequence":false,"checkBeforeCleanup":false,"vmName":"i-2-7-VM","wait":0}}] } 2014-08-13 11:07:15,252 DEBUG [c.c.a.t.Request] (Work-Job-Executor-17:ctx-901a2102 job-60/job-62 ctx-93952e24) Seq 1-2224496740944314442: Executing: { Cmd , MgmtId: 113356693032, via: 1(xen2), Ver: v1, Flags: 100011, [{"com.cloud.agent.api.StopCommand":{"isProxy":false,"executeInSequence":false,"checkBeforeCleanup":false,"vmName":"i-2-7-VM","wait":0}}] } 2014-08-13 11:07:15,316 DEBUG [c.c.v.VirtualMachineManagerImpl] (Work-Job-Executor-17:ctx-901a2102 job-60/job-62 ctx-93952e24) Successfully released network resources for the vm VM[User|i-2-7-VM] 2014-08-13 11:07:15,316 DEBUG [c.c.v.VirtualMachineManagerImpl] (Work-Job-Executor-17:ctx-901a2102 job-60/job-62 ctx-93952e24) Successfully cleanued up resources for the vm VM[User|i-2-7-VM] in Starting state 2014-08-13 11:07:15,361 DEBUG [c.c.v.VirtualMachineManagerImpl] (Work-Job-Executor-17:ctx-901a2102 job-60/job-62 ctx-93952e24) Deployment found - P0=VM[User|i-2-7-VM], P0=Dest[Zone(Id)-Pod(Id)-Cluster(Id)-Host(Id)-Storage(Volume(Id|Type-->Pool(Id))] : Dest[Zone(1)-Pod(1)-Cluster(1)-Host(2)-Storage()] 2014-08-13 11:07:17,560 DEBUG [o.a.c.e.o.VolumeOrchestrator] (Work-Job-Executor-17:ctx-901a2102 job-60/job-62 ctx-93952e24) Checking if we need to prepare 1 volumes for VM[User|i-2-7-VM] 2014-08-13 11:07:17,667 DEBUG [c.c.a.t.Request] (Work-Job-Executor-17:ctx-901a2102 job-60/job-62 ctx-93952e24) Seq 2-4135711832809668664: Sending { Cmd , MgmtId: 113356693032, via: 2(xen1), Ver: v1, Flags: 100011, [{"com.cloud.agent.api.StartCommand":{"vm":{"id":7,"name":"i-2-7-VM","bootloader":"CD","type":"User","cpus":1,"minSpeed":1000,"maxSpeed":1000,"minRam":1073741824,"maxRam":1073741824,"arch":"x86_64","os":"CentOS 6.5 (64-bit)","bootArgs":"","rebootOnCrash":false,"enableHA":false,"limitCpuUse":false,"enableDynamicallyScaleVm":false,"vncPassword":"2d6edfaf38aa272","params":{"Message.ReservedCapacityFreed.Flag":"false"},"uuid":"e92e339e-d5a8-44c8-89ce-98c2e9cc9192","disks":[{"data":{"org.apache.cloudstack.storage.to.VolumeObjectTO":{"uuid":"87e3cf39-18f5-488a-969a-94cf3dc7f668","volumeType":"ROOT","dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"xen-1","id":1,"poolType":"PreSetup","host":"localhost","path":"/xen-1","port":0,"url":"PreSetup://localhost/xen-1/?ROLE=Primary&STOREUUID=xen-1"}},"name":"ROOT-7","size":5368709120,"path":"5249db5f-16d9-4883-b86c-ad0ca6e6f690","volumeId":7,"vmName":"i-2-7-VM","accountId":2,"format":"VHD","id":7,"deviceId":0,"hypervisorType":"XenServer"}},"diskSeq":0,"path":"5249db5f-16d9-4883-b86c-ad0ca6e6f690","type":"ROOT","_details":{"managed":"false","storagePort":"0","storageHost":"localhost","volumeSize":"5368709120"}},{"data":{"org.apache.cloudstack.storage.to.TemplateObjectTO":{"path":"template/tmpl/2/203/203-2-b181ffd4-81b7-39c4-874d-a86747f2ca48.iso","origUrl":"http://mirror.hmc.edu/centos/6.5/isos/x86_64/CentOS-6.5-x86_64-minimal.iso","uuid":"15ba8ace-7d30-4d2d-bef9-28d882600780","id":203,"format":"ISO","accountId":2,"checksum":"0d9dc37b5dd4befa1c440d2174e88a87","hvm":true,"displayText":"Centos6.5 64bit ISO","imageDataStore":{"com.cloud.agent.api.to.NfsTO":{"_url":"nfs://10.107.0.6/export/secondary","_role":"Image"}},"name":"203-2-b181ffd4-81b7-39c4-874d-a86747f2ca48","guestOsType":"CentOS 6.5 (64-bit)","hypervisorType":"None"}},"diskSeq":3,"type":"ISO"}],"nics":[{"deviceId":0,"networkRateMbps":200,"defaultNic":true,"uuid":"e8b8f8a7-a1a0-4a43-aef4-5b57b542a0b3","ip":"10.10.1.122","netmask":"255.255.255.0","gateway":"10.10.1.1","mac":"02:00:39:23:00:04","dns1":"207.68`.36.2","dns2":"207.68.37.2","broadcastType":"Vlan","type":"Guest","broadcastUri":"vlan://502","isolationUri":"vlan://502","isSecurityGroupEnabled":false,"name":"cloudstack1"}]},"hostIp":"10.107.0.11","executeInSequence":false,"wait":0}}] } 2014-08-13 11:07:17,668 DEBUG [c.c.a.t.Request] (Work-Job-Executor-17:ctx-901a2102 job-60/job-62 ctx-93952e24) Seq 2-4135711832809668664: Executing: { Cmd , MgmtId: 113356693032, via: 2(xen1), Ver: v1, Flags: 100011, [{"com.cloud.agent.api.StartCommand":{"vm":{"id":7,"name":"i-2-7-VM","bootloader":"CD","type":"User","cpus":1,"minSpeed":1000,"maxSpeed":1000,"minRam":1073741824,"maxRam":1073741824,"arch":"x86_64","os":"CentOS 6.5 (64-bit)","bootArgs":"","rebootOnCrash":false,"enableHA":false,"limitCpuUse":false,"enableDynamicallyScaleVm":false,"vncPassword":"2d6edfaf38aa272","params":{"Message.ReservedCapacityFreed.Flag":"false"},"uuid":"e92e339e-d5a8-44c8-89ce-98c2e9cc9192","disks":[{"data":{"org.apache.cloudstack.storage.to.VolumeObjectTO":{"uuid":"87e3cf39-18f5-488a-969a-94cf3dc7f668","volumeType":"ROOT","dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"xen-1","id":1,"poolType":"PreSetup","host":"localhost","path":"/xen-1","port":0,"url":"PreSetup://localhost/xen-1/?ROLE=Primary&STOREUUID=xen-1"}},"name":"ROOT-7","size":5368709120,"path":"5249db5f-16d9-4883-b86c-ad0ca6e6f690","volumeId":7,"vmName":"i-2-7-VM","accountId":2,"format":"VHD","id":7,"deviceId":0,"hypervisorType":"XenServer"}},"diskSeq":0,"path":"5249db5f-16d9-4883-b86c-ad0ca6e6f690","type":"ROOT","_details":{"managed":"false","storagePort":"0","storageHost":"localhost","volumeSize":"5368709120"}},{"data":{"org.apache.cloudstack.storage.to.TemplateObjectTO":{"path":"template/tmpl/2/203/203-2-b181ffd4-81b7-39c4-874d-a86747f2ca48.iso","origUrl":"http://mirror.hmc.edu/centos/6.5/isos/x86_64/CentOS-6.5-x86_64-minimal.iso","uuid":"15ba8ace-7d30-4d2d-bef9-28d882600780","id":203,"format":"ISO","accountId":2,"checksum":"0d9dc37b5dd4befa1c440d2174e88a87","hvm":true,"displayText":"Centos6.5 64bit ISO","imageDataStore":{"com.cloud.agent.api.to.NfsTO":{"_url":"nfs://10.107.0.6/export/secondary","_role":"Image"}},"name":"203-2-b181ffd4-81b7-39c4-874d-a86747f2ca48","guestOsType":"CentOS 6.5 (64-bit)","hypervisorType":"None"}},"diskSeq":3,"type":"ISO"}],"nics":[{"deviceId":0,"networkRateMbps":200,"defaultNic":true,"uuid":"e8b8f8a7-a1a0-4a43-aef4-5b57b542a0b3","ip":"10.10.1.122","netmask":"255.255.255.0","gateway":"10.10.1.1","mac":"02:00:39:23:00:04","dns1":"207.68.36.2","dns2":"207.68.37.2","broadcastType":"Vlan","type":"Guest","broadcastUri":"vlan://502","isolationUri":"vlan://502","isSecurityGroupEnabled":false,"name":"cloudstack1"}]},"hostIp":"10.107.0.11","executeInSequence":false,"wait":0}}] } 2014-08-13 11:07:17,675 DEBUG [c.c.h.x.r.CitrixResourceBase] (DirectAgent-167:ctx-e43b9be8) 1. The VM i-2-7-VM is in Starting state. 2014-08-13 11:07:17,680 WARN [c.c.h.x.r.CitrixResourceBase] (DirectAgent-167:ctx-e43b9be8) Unable to start i-2-7-VM due to 2014-08-13 11:07:17,681 DEBUG [c.c.h.x.r.CitrixResourceBase] (DirectAgent-167:ctx-e43b9be8) The VM is in stopped state, detected problem during startup : i-2-7-VM 2014-08-13 11:07:17,682 DEBUG [c.c.a.t.Request] (DirectAgent-167:ctx-e43b9be8) Seq 2-4135711832809668664: Processing: { Ans: , MgmtId: 113356693032, via: 2, Ver: v1, Flags: 10, [{"com.cloud.agent.api.StartAnswer":{"vm":{"id":7,"name":"i-2-7-VM","bootloader":"CD","type":"User","cpus":1,"minSpeed":1000,"maxSpeed":1000,"minRam":1073741824,"maxRam":1073741824,"arch":"x86_64","os":"CentOS 6.5 (64-bit)","bootArgs":"","rebootOnCrash":false,"enableHA":false,"limitCpuUse":false,"enableDynamicallyScaleVm":false,"vncPassword":"2d6edfaf38aa272","params":{"Message.ReservedCapacityFreed.Flag":"false"},"uuid":"e92e339e-d5a8-44c8-89ce-98c2e9cc9192","disks":[{"data":{"org.apache.cloudstack.storage.to.VolumeObjectTO":{"uuid":"87e3cf39-18f5-488a-969a-94cf3dc7f668","volumeType":"ROOT","dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"xen-1","id":1,"poolType":"PreSetup","host":"localhost","path":"/xen-1","port":0,"url":"PreSetup://localhost/xen-1/?ROLE=Primary&STOREUUID=xen-1"}},"name":"ROOT-7","size":5368709120,"path":"5249db5f-16d9-4883-b86c-ad0ca6e6f690","volumeId":7,"vmName":"i-2-7-VM","accountId":2,"format":"VHD","id":7,"deviceId":0,"hypervisorType":"XenServer"}},"diskSeq":0,"path":"5249db5f-16d9-4883-b86c-ad0ca6e6f690","type":"ROOT","_details":{"managed":"false","storagePort":"0","storageHost":"localhost","volumeSize":"5368709120"}},{"data":{"org.apache.cloudstack.storage.to.TemplateObjectTO":{"path":"template/tmpl/2/203/203-2-b181ffd4-81b7-39c4-874d-a86747f2ca48.iso","origUrl":"http://mirror.hmc.edu/centos/6.5/isos/x86_64/CentOS-6.5-x86_64-minimal.iso","uuid":"15ba8ace-7d30-4d2d-bef9-28d882600780","id":203,"format":"ISO","accountId":2,"checksum":"0d9dc37b5dd4befa1c440d2174e88a87","hvm":true,"displayText":"Centos6.5 64bit ISO","imageDataStore":{"com.cloud.agent.api.to.NfsTO":{"_url":"nfs://10.107.0.6/export/secondary","_role":"Image"}},"name":"203-2-b181ffd4-81b7-39c4-874d-a86747f2ca48","guestOsType":"CentOS 6.5 (64-bit)","hypervisorType":"None"}},"diskSeq":3,"type":"ISO"}],"nics":[{"deviceId":0,"networkRateMbps":200,"defaultNic":true,"uuid":"e8b8f8a7-a1a0-4a43-aef4-5b57b542a0b3","ip":"10.10.1.122","netmask":"255.255.255.0","gateway":"10.10.1.1","mac":"02:00:39:23:00:04","dns1":"207.68.36.2","dns2":"207.68.37.2","broadcastType":"Vlan","type":"Guest","broadcastUri":"vlan://502","isolationUri":"vlan://502","isSecurityGroupEnabled":false,"name":"cloudstack1"}]},"_iqnToPath":{},"result":false,"details":"Unable to start i-2-7-VM due to ","wait":0}}] } 2014-08-13 11:07:17,724 INFO [c.c.v.VirtualMachineManagerImpl] (Work-Job-Executor-17:ctx-901a2102 job-60/job-62 ctx-93952e24) Unable to start VM on Host[-2-Routing] due to Unable to start i-2-7-VM due to 2014-08-13 11:07:17,764 DEBUG [c.c.v.VirtualMachineManagerImpl] (Work-Job-Executor-17:ctx-901a2102 job-60/job-62 ctx-93952e24) Cleaning up resources for the vm VM[User|i-2-7-VM] in Starting state 2014-08-13 11:07:17,767 DEBUG [c.c.a.t.Request] (Work-Job-Executor-17:ctx-901a2102 job-60/job-62 ctx-93952e24) Seq 2-4135711832809668665: Sending { Cmd , MgmtId: 113356693032, via: 2(xen1), Ver: v1, Flags: 100011, [{"com.cloud.agent.api.StopCommand":{"isProxy":false,"executeInSequence":false,"checkBeforeCleanup":false,"vmName":"i-2-7-VM","wait":0}}] } 2014-08-13 11:07:17,767 DEBUG [c.c.a.t.Request] (Work-Job-Executor-17:ctx-901a2102 job-60/job-62 ctx-93952e24) Seq 2-4135711832809668665: Executing: { Cmd , MgmtId: 113356693032, via: 2(xen1), Ver: v1, Flags: 100011, [{"com.cloud.agent.api.StopCommand":{"isProxy":false,"executeInSequence":false,"checkBeforeCleanup":false,"vmName":"i-2-7-VM","wait":0}}] } 2014-08-13 11:07:17,828 DEBUG [c.c.v.VirtualMachineManagerImpl] (Work-Job-Executor-17:ctx-901a2102 job-60/job-62 ctx-93952e24) Successfully released network resources for the vm VM[User|i-2-7-VM] 2014-08-13 11:07:17,828 DEBUG [c.c.v.VirtualMachineManagerImpl] (Work-Job-Executor-17:ctx-901a2102 job-60/job-62 ctx-93952e24) Successfully cleanued up resources for the vm VM[User|i-2-7-VM] in Starting state 2014-08-13 11:07:18,030 ERROR [c.c.v.VmWorkJobHandlerProxy] (Work-Job-Executor-17:ctx-901a2102 job-60/job-62 ctx-93952e24) Invocation exception, caused by: com.cloud.exception.InsufficientServerCapacityException: Unable to create a deployment for VM[User|i-2-7-VM]Scope=interface com.cloud.dc.DataCenter; id=1 2014-08-13 11:07:18,030 INFO [c.c.v.VmWorkJobHandlerProxy] (Work-Job-Executor-17:ctx-901a2102 job-60/job-62 ctx-93952e24) Rethrow exception com.cloud.exception.InsufficientServerCapacityException: Unable to create a deployment for VM[User|i-2-7-VM]Scope=interface com.cloud.dc.DataCenter; id=1 com.cloud.exception.InsufficientServerCapacityException: Unable to create a deployment for VM[User|i-2-7-VM]Scope=interface com.cloud.dc.DataCenter; id=1 2014-08-13 11:07:18,159 DEBUG [c.c.v.UserVmManagerImpl] (API-Job-Executor-40:ctx-1253e595 job-60 ctx-879a334d) Destroying vm VM[User|i-2-7-VM] as it failed to create on Host with Id:null java.lang.RuntimeException: Job failed due to exception Unable to create a deployment for VM[User|i-2-7-VM] 2014-08-13 11:07:18,634 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (API-Job-Executor-40:ctx-1253e595 job-60) Complete async job-60, jobStatus: FAILED, resultCode: 530, result: org.apache.cloudstack.api.response.ExceptionResponse/null/{"uuidList":[],"errorcode":530,"errortext":"Job failed due to exception Unable to create a deployment for VM[User|i-2-7-VM]"}