You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@cloudstack.apache.org by "ASF subversion and git services (JIRA)" <ji...@apache.org> on 2014/05/01 21:05:15 UTC
[jira] [Commented] (CLOUDSTACK-4549) ceph:deployvm from template
created from snapshot is failing
[ https://issues.apache.org/jira/browse/CLOUDSTACK-4549?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=13986876#comment-13986876 ]
ASF subversion and git services commented on CLOUDSTACK-4549:
-------------------------------------------------------------
Commit 3962577329ea2561fe8dd9db1281e7a6a2ea62cf in cloudstack's branch refs/heads/master from [~widodh]
[ https://git-wip-us.apache.org/repos/asf?p=cloudstack.git;h=3962577 ]
CLOUDSTACK-4549: Do not force RBD snapshot backups to RAW format
Since we use qemu-img to copy from RBD to Secondary Storage we no
longer have to force to RAW images, but can stick with QCOW2
When the snapshot backups are QCOW2 format they can easily be deployed
again when restoring from a backup
> ceph:deployvm from template created from snapshot is failing
> ------------------------------------------------------------
>
> Key: CLOUDSTACK-4549
> URL: https://issues.apache.org/jira/browse/CLOUDSTACK-4549
> Project: CloudStack
> Issue Type: Bug
> Security Level: Public(Anyone can view this level - this is the default.)
> Components: Management Server
> Affects Versions: 4.2.0
> Reporter: sadhu suresh
> Assignee: Wido den Hollander
> Priority: Critical
> Fix For: 4.4.0
>
> Attachments: management-server.rar
>
>
> VM deployment form template which is created form snapshot is failing where as VM deployment with uploaded template successful.
> created template form snapshot is storing in raw format(https://10-147-49-100.realhostip.com/userdata/0c826645-ec82-40f1-a1b0-38fc9ba1c76f.raw).. not sure are we converting again to QCwo2
> when we try to deploy a VM
> steps:
> 1.create a ceph instance(configure compute offering with RBD and deploy a vm)
> 2.Once it successful,select the root partition and perform snapshot
> 3.once snapshot successful,create a template from snapshot
> 4 try to create vm uning above VM
> actual result:
> deploy vm failing with exception
> -29 15:21:43,756 DEBUG [cloud.network.NetworkModelImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Service SecurityGroup is not supported in the network id=204
> 2013-08-29 15:21:43,762 DEBUG [network.router.VirtualNetworkApplianceManagerImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Applying userdata and password entry in network Ntwk[204|Guest|8]
> 2013-08-29 15:21:43,800 DEBUG [agent.transport.Request] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Seq 1-2089159931: Sending { Cmd , MgmtId: 7175246184473, via: 1, Ver: v1, Flags: 100111, [{"com.cloud.agent.api.routing.SavePasswordCommand":{"password":"fnirq_cnffjbeq","vmIpAddress":"10.1.1.140","vmName":"6e798618-8e4d-4305-94a1-642e5f3aad08","executeInSequence":true,"accessDetails":{"router.guest.ip":"10.1.1.1","zone.network.type":"Advanced","router.ip":"169.254.2.248","router.name":"r-15-VM"},"wait":0}},{"com.cloud.agent.api.routing.VmDataCommand":{"vmIpAddress":"10.1.1.140","vmName":"6e798618-8e4d-4305-94a1-642e5f3aad08","executeInSequence":true,"accessDetails":{"router.guest.ip":"10.1.1.1","zone.network.type":"Advanced","router.ip":"169.254.2.248","router.name":"r-15-VM"},"wait":0}}] }
> 2013-08-29 15:21:44,168 DEBUG [agent.transport.Request] (AgentManager-Handler-14:null) Seq 1-2089159931: Processing: { Ans: , MgmtId: 7175246184473, via: 1, Ver: v1, Flags: 110, [{"com.cloud.agent.api.Answer":{"result":true,"wait":0}},{"com.cloud.agent.api.Answer":{"result":true,"wait":0}}] }
> 2013-08-29 15:21:44,169 DEBUG [agent.manager.AgentAttache] (AgentManager-Handler-14:null) Seq 1-2089159931: No more commands found
> 2013-08-29 15:21:44,169 DEBUG [agent.transport.Request] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Seq 1-2089159931: Received: { Ans: , MgmtId: 7175246184473, via: 1, Ver: v1, Flags: 110, { Answer, Answer } }
> 2013-08-29 15:21:44,179 DEBUG [cloud.network.NetworkModelImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Service SecurityGroup is not supported in the network id=204
> 2013-08-29 15:21:44,182 DEBUG [cloud.storage.VolumeManagerImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Checking if we need to prepare 1 volumes for VM[User|6e798618-8e4d-4305-94a1-642e5f3aad08]
> 2013-08-29 15:21:44,207 DEBUG [storage.image.TemplateDataFactoryImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) template 202 is already in store:1, type:Image
> 2013-08-29 15:21:44,219 DEBUG [storage.datastore.PrimaryDataStoreImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Not found (templateId:202poolId:5) in template_spool_ref, persisting it
> 2013-08-29 15:21:44,234 DEBUG [storage.image.TemplateDataFactoryImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) template 202 is already in store:5, type:Primary
> 2013-08-29 15:21:44,237 DEBUG [storage.volume.VolumeServiceImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Found template 246c1e4ac-9fc0-3122-bcfb-77deff789f61 in storage pool 5 with VMTemplateStoragePool id: 5
> 2013-08-29 15:21:44,433 DEBUG [storage.volume.VolumeServiceImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Acquire lock on VMTemplateStoragePool 5 with timeout 3600 seconds
> 2013-08-29 15:21:44,438 INFO [storage.volume.VolumeServiceImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) lock is acquired for VMTemplateStoragePool 5
> 2013-08-29 15:21:44,466 DEBUG [storage.motion.AncientDataMotionStrategy] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) copyAsync inspecting src type TEMPLATE copyAsync inspecting dest type TEMPLATE
> 2013-08-29 15:21:44,547 DEBUG [agent.transport.Request] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Seq 1-2089159932: Sending { Cmd , MgmtId: 7175246184473, via: 1, Ver: v1, Flags: 100111, [{"org.apache.cloudstack.storage.command.CopyCommand":{"srcTO":{"org.apache.cloudstack.storage.to.TemplateObjectTO":{"path":"template/tmpl/2/202/54476705-667d-463d-b82b-a99aea739520.raw","uuid":"82d671d6-30ee-40d4-8ad1-f922bf055630","id":202,"format":"RAW","accountId":2,"hvm":true,"displayText":"tme","imageDataStore":{"com.cloud.agent.api.to.NfsTO":{"_url":"nfs://10.147.28.7/export/home/sadhu/asf/kvmsec","_role":"Image"}},"name":"246c1e4ac-9fc0-3122-bcfb-77deff789f61","hypervisorType":"KVM"}},"destTO":{"org.apache.cloudstack.storage.to.TemplateObjectTO":{"uuid":"82d671d6-30ee-40d4-8ad1-f922bf055630","id":202,"format":"RAW","accountId":2,"hvm":true,"displayText":"tme","imageDataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"9e422b10-88ae-3a56-96b3-6a7962c175cf","id":5,"poolType":"RBD","host":"10.147.41.3","path":"cloudstack2","port":6789}},"name":"246c1e4ac-9fc0-3122-bcfb-77deff789f61","hypervisorType":"KVM"}},"executeInSequence":true,"wait":10800}}] }
> 2013-08-29 15:21:44,801 DEBUG [agent.transport.Request] (AgentManager-Handler-1:null) Seq 1-2089159932: Processing: { Ans: , MgmtId: 7175246184473, via: 1, Ver: v1, Flags: 110, [{"org.apache.cloudstack.storage.command.CopyCmdAnswer":{"result":false,"details":"com.cloud.utils.exception.CloudRuntimeException: Failed to copy /mnt/81536f26-0b44-391e-a9b2-03c89eec2957/54476705-667d-463d-b82b-a99aea739520.raw to 634e63f2-c2fe-447d-bfab-c2b86a839589","wait":0}}] }
> 2013-08-29 15:21:44,801 DEBUG [agent.manager.AgentAttache] (AgentManager-Handler-1:null) Seq 1-2089159932: No more commands found
> 2013-08-29 15:21:44,802 DEBUG [agent.transport.Request] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Seq 1-2089159932: Received: { Ans: , MgmtId: 7175246184473, via: 1, Ver: v1, Flags: 110, { CopyCmdAnswer } }
> 2013-08-29 15:21:44,816 INFO [storage.volume.VolumeServiceImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) releasing lock for VMTemplateStoragePool 5
> 2013-08-29 15:21:44,817 WARN [utils.db.Merovingian2] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Was unable to find lock for the key template_spool_ref5 and thread id 1321874944
> 2013-08-29 15:21:44,818 DEBUG [cloud.storage.VolumeManagerImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Unable to create Vol[19|vm=18|ROOT]:com.cloud.utils.exception.CloudRuntimeException: Failed to copy /mnt/81536f26-0b44-391e-a9b2-03c89eec2957/54476705-667d-463d-b82b-a99aea739520.raw to 634e63f2-c2fe-447d-bfab-c2b86a839589
> 2013-08-29 15:21:44,821 INFO [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Unable to contact resource.
> com.cloud.exception.StorageUnavailableException: Resource [StoragePool:5] is unreachable: Unable to create Vol[19|vm=18|ROOT]:com.cloud.utils.exception.CloudRuntimeException: Failed to copy /mnt/81536f26-0b44-391e-a9b2-03c89eec2957/54476705-667d-463d-b82b-a99aea739520.raw to 634e63f2-c2fe-447d-bfab-c2b86a839589
> at com.cloud.storage.VolumeManagerImpl.recreateVolume(VolumeManagerImpl.java:2534)
> at com.cloud.storage.VolumeManagerImpl.prepare(VolumeManagerImpl.java:2582)
> at com.cloud.vm.VirtualMachineManagerImpl.advanceStart(VirtualMachineManagerImpl.java:888)
> at com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:578)
> at org.apache.cloudstack.engine.cloud.entity.api.VMEntityManagerImpl.deployVirtualMachine(VMEntityManagerImpl.java:227)
> at org.apache.cloudstack.engine.cloud.entity.api.VirtualMachineEntityImpl.deploy(VirtualMachineEntityImpl.java:209)
> at com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:3406)
> at com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:2966)
> at com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:2952)
> at com.cloud.utils.component.ComponentInstantiationPostProcessor$InterceptorDispatcher.intercept(ComponentInstantiationPostProcessor.java:125)
> at org.apache.cloudstack.api.command.user.vm.DeployVMCmd.execute(DeployVMCmd.java:420)
> at com.cloud.api.ApiDispatcher.dispatch(ApiDispatcher.java:158)
> at com.cloud.async.AsyncJobManagerImpl$1.run(AsyncJobManagerImpl.java:531)
> at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
> at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334)
> at java.util.concurrent.FutureTask.run(FutureTask.java:166)
> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146)
> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> at java.lang.Thread.run(Thread.java:679)
> 2013-08-29 15:21:44,849 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Cleaning up resources for the vm VM[User|6e798618-8e4d-4305-94a1-642e5f3aad08] in Starting state
> 2013-08-29 15:21:44,852 DEBUG [agent.transport.Request] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Seq 1-2089159933: Sending { Cmd , MgmtId: 7175246184473, via: 1, Ver: v1, Flags: 100111, [{"com.cloud.agent.api.StopCommand":{"isProxy":false,"executeInSequence":true,"vmName":"i-2-18-VM","wait":0}}] }
> 2013-08-29 15:21:44,973 DEBUG [agent.transport.Request] (AgentManager-Handler-2:null) Seq 1-2089159933: Processing: { Ans: , MgmtId: 7175246184473, via: 1, Ver: v1, Flags: 110, [{"com.cloud.agent.api.StopAnswer":{"vncPort":0,"result":true,"wait":0}}] }
> 2013-08-29 15:21:44,974 DEBUG [agent.manager.AgentAttache] (AgentManager-Handler-2:null) Seq 1-2089159933: No more commands found
> 2013-08-29 15:21:44,974 DEBUG [agent.transport.Request] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Seq 1-2089159933: Received: { Ans: , MgmtId: 7175246184473, via: 1, Ver: v1, Flags: 110, { StopAnswer } }
> 2013-08-29 15:21:44,996 DEBUG [cloud.network.NetworkModelImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Service SecurityGroup is not supported in the network id=204
> 2013-08-29 15:21:45,006 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Changing active number of nics for network id=204 on -1
> 2013-08-29 15:21:45,020 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Asking VirtualRouter to release Nic[39-18-8598ce9e-e36d-4fe7-8e5b-da21f62eae49-10.1.1.140]
> 2013-08-29 15:21:45,020 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Successfully released network resources for the vm VM[User|6e798618-8e4d-4305-94a1-642e5f3aad08]
> 2013-08-29 15:21:45,022 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Successfully cleanued up resources for the vm VM[User|6e798618-8e4d-4305-94a1-642e5f3aad08] in Starting state
> 2013-08-29 15:21:45,031 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Deploy avoids pods: [], clusters: [], hosts: [1]
> 2013-08-29 15:21:45,032 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) DeploymentPlanner allocation algorithm: com.cloud.deploy.FirstFitPlanner_EnhancerByCloudStack_86625c40@e625416
> 2013-08-29 15:21:45,032 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Trying to allocate a host and storage pools from dc:1, pod:1,cluster:1, requested cpu: 1, requested ram: 104857600
> 2013-08-29 15:21:45,032 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Is ROOT volume READY (pool already allocated)?: No
> 2013-08-29 15:21:45,033 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) DeploymentPlan has host_id specified, choosing this host and making no checks on this host: 1
> 2013-08-29 15:21:45,034 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) The specified host is in avoid set
> 2013-08-29 15:21:45,034 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Cannnot deploy to specified host, returning.
> 2013-08-29 15:21:45,047 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) VM state transitted from :Starting to Stopped with event: OperationFailedvm's original host id: null new host id: null host id before state transition: 1
> 2013-08-29 15:21:45,054 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Hosts's actual total CPU: 9572 and CPU after applying overprovisioning: 9572
> 2013-08-29 15:21:45,054 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Hosts's actual total RAM: 16816889856 and RAM after applying overprovisioning: 16816889856
> 2013-08-29 15:21:45,054 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) release cpu from host: 1, old used: 4503,reserved: 0, actual total: 9572, total with overprovisioning: 9572; new used: 4502,reserved:0; movedfromreserved: false,moveToReserveredfalse
> 2013-08-29 15:21:45,054 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) release mem from host: 1, old used: 3401580544,reserved: 0, total: 16816889856; new used: 3296722944,reserved:0; movedfromreserved: false,moveToReserveredfalse
> 2013-08-29 15:21:45,109 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) VM state transitted from :Stopped to Starting with event: StartRequestedvm's original host id: null new host id: null host id before state transition: null
> 2013-08-29 15:21:45,111 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Successfully transitioned to start state for VM[User|6e798618-8e4d-4305-94a1-642e5f3aad08] reservation id = 8a4c528a-3292-4ccf-9790-eaa703f23452
> 2013-08-29 15:21:45,128 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Trying to deploy VM, vm has dcId: 1 and podId: 1
> 2013-08-29 15:21:45,129 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Deploy avoids pods: [], clusters: [], hosts: [1]
> 2013-08-29 15:21:45,156 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Deploy avoids pods: [], clusters: [], hosts: [1]
> 2013-08-29 15:21:45,160 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) DeploymentPlanner allocation algorithm: com.cloud.deploy.FirstFitPlanner_EnhancerByCloudStack_86625c40@e625416
> 2013-08-29 15:21:45,160 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Trying to allocate a host and storage pools from dc:1, pod:1,cluster:null, requested cpu: 1, requested ram: 104857600
> 2013-08-29 15:21:45,161 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Is ROOT volume READY (pool already allocated)?: No
> 2013-08-29 15:21:45,161 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Searching resources only under specified Pod: 1
> 2013-08-29 15:21:45,162 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Listing clusters in order of aggregate capacity, that have (atleast one host with) enough CPU and RAM capacity under this Pod: 1
> 2013-08-29 15:21:45,172 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Removing from the clusterId list these clusters from avoid set: []
> 2013-08-29 15:21:45,284 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Checking resources in Cluster: 1 under Pod: 1
> 2013-08-29 15:21:45,284 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ] FirstFitRoutingAllocator) Looking for hosts in dc: 1 pod:1 cluster:1
> 2013-08-29 15:21:45,291 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ] FirstFitRoutingAllocator) FirstFitAllocator has 1 hosts to check for allocation: [Host[-1-Routing]]
> 2013-08-29 15:21:45,393 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ] FirstFitRoutingAllocator) Found 1 hosts for allocation after prioritization: [Host[-1-Routing]]
> 2013-08-29 15:21:45,394 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ] FirstFitRoutingAllocator) Looking for speed=1Mhz, Ram=100
> 2013-08-29 15:21:45,394 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ] FirstFitRoutingAllocator) Host name: Rack1Pod1Host12, hostId: 1 is in avoid set, skipping this and trying other available hosts
> 2013-08-29 15:21:45,394 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ] FirstFitRoutingAllocator) Host Allocator returning 0 suitable hosts
> 2013-08-29 15:21:45,394 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) No suitable hosts found
> 2013-08-29 15:21:45,394 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) No suitable hosts found under this Cluster: 1
> 2013-08-29 15:21:45,398 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Could not find suitable Deployment Destination for this VM under any clusters, returning.
> 2013-08-29 15:21:45,398 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Searching resources only under specified Pod: 1
> 2013-08-29 15:21:45,398 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Listing clusters in order of aggregate capacity, that have (atleast one host with) enough CPU and RAM capacity under this Pod: 1
> 2013-08-29 15:21:45,405 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Removing from the clusterId list these clusters from avoid set: [1]
> 2013-08-29 15:21:45,406 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) No clusters found after removing disabled clusters and clusters in avoid list, returning.
> 2013-08-29 15:21:45,463 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) VM state transitted from :Starting to Stopped with event: OperationFailedvm's original host id: null new host id: null host id before state transition: null
> 2013-08-29 15:21:45,471 DEBUG [cloud.api.ApiServlet] (catalina-exec-3:null) ===START=== 10.252.192.42 -- GET command=queryAsyncJobResult&jobId=3dcbbb22-d258-4859-bf3f-c8a620768e25&response=json&sessionkey=iYZwRL0CmiLGtiKuOVqbMz9cafo%3D&_=1377750462217
> 2013-08-29 15:21:45,525 DEBUG [cloud.vm.UserVmManagerImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) Destroying vm VM[User|6e798618-8e4d-4305-94a1-642e5f3aad08] as it failed to create on Host with Id:null
> 2013-08-29 15:21:46,360 DEBUG [cloud.api.ApiServlet] (catalina-exec-3:null) ===END=== 10.252.192.42 -- GET command=queryAsyncJobResult&jobId=3dcbbb22-d258-4859-bf3f-c8a620768e25&response=json&sessionkey=iYZwRL0CmiLGtiKuOVqbMz9cafo%3D&_=1377750462217
> 2013-08-29 15:21:46,372 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) VM state transitted from :Stopped to Error with event: OperationFailedToErrorvm's original host id: null new host id: null host id before state transition: null
> 2013-08-29 15:21:46,411 WARN [apache.cloudstack.alerts] (Job-Executor-14:job-42 = [ 3dcbbb22-d258-4859-bf3f-c8a620768e25 ]) alertType:: 8 // dataCenterId:: 1 // podId:: 1 // clusterId:: null // message:: Failed to deploy Vm with Id: 18, on Host with Id: null
> ^C
> id: 41
> user_id: 2
> account_id: 2
> session_key: NULL
> instance_type: NULL
> instance_id: NULL
> job_cmd: org.apache.cloudstack.api.command.user.vm.DeployVMCmd
> job_cmd_originator: NULL
> job_cmd_info: {"sessionkey":"iYZwRL0CmiLGtiKuOVqbMz9cafo\u003d","cmdEventType":"VM.CREATE","ctxUserId":"2","serviceOfferingId":"8f42daa3-37aa-48d2-b01d-903cfc19345b","httpmethod":"GET","zoneId":"3cc53a2d-6e2b-4ccb-8ccb-6fe2e7d9eb54","templateId":"d3b4b386-0fda-11e3-9982-06869e000019","response":"json","id":"17","networkIds":"05fea399-b39d-4428-85db-c09eb7815f94","hypervisor":"KVM","_":"1377750411786","ctxAccountId":"2","ctxStartEventId":"167"}
> job_cmd_ver: 0
> callback_type: 0
> callback_address: NULL
> job_status: 1
> job_process_status: 0
> job_result_code: 0
> job_result: org.apache.cloudstack.api.response.UserVmResponse/virtualmachine/{"id":"3c88b4ed-3da0-4808-a7f5-216478884303","name":"3c88b4ed-3da0-4808-a7f5-216478884303","account":"admin","domainid":"d3ac65c8-0fda-11e3-9982-06869e000019","domain":"ROOT","created":"2013-08-29T15:20:56+0530","state":"Running","haenable":false,"zoneid":"3cc53a2d-6e2b-4ccb-8ccb-6fe2e7d9eb54","zonename":"zone1","hostid":"8c647661-3a79-4da5-bc6a-b15d57193ca5","hostname":"Rack1Pod1Host12","templateid":"d3b4b386-0fda-11e3-9982-06869e000019","templatename":"CentOS 5.5(64-bit) no GUI (KVM)","templatedisplaytext":"CentOS 5.5(64-bit) no GUI (KVM)","passwordenabled":false,"serviceofferingid":"8f42daa3-37aa-48d2-b01d-903cfc19345b","serviceofferingname":"rbdcp","cpunumber":1,"cpuspeed":1,"memory":100,"guestosid":"d3f8475e-0fda-11e3-9982-06869e000019","rootdeviceid":0,"rootdevicetype":"ROOT","securitygroup":[],"nic":[{"id":"e8af7e43-be9b-4205-aed4-4746d1e3c65f","networkid":"05fea399-b39d-4428-85db-c09eb7815f94","networkname":"test","netmask":"255.255.255.0","gateway":"10.1.1.1","ipaddress":"10.1.1.176","isolationuri":"vlan://1012","broadcasturi":"vlan://1012","traffictype":"Guest","type":"Isolated","isdefault":true,"macaddress":"02:00:33:31:00:05"}],"hypervisor":"KVM","instancename":"i-2-17-VM","tags":[],"affinitygroup":[],"displayvm":true,"isdynamicallyscalable":false,"jobid":"10d88595-3191-4dff-a04c-38a5cac47a07","jobstatus":0}
> job_init_msid: 7175246184473
> job_complete_msid: 7175246184473
> created: 2013-08-29 09:50:56
> last_updated: 2013-08-29 09:51:02
> last_polled: 2013-08-29 09:51:02
> removed: NULL
> uuid: 10d88595-3191-4dff-a04c-38a5cac47a07
> *************************** 42. row ***************************
> id: 42
> user_id: 2
> account_id: 2
> session_key: NULL
> instance_type: NULL
> instance_id: NULL
> job_cmd: org.apache.cloudstack.api.command.user.vm.DeployVMCmd
> job_cmd_originator: NULL
> job_cmd_info: {"sessionkey":"iYZwRL0CmiLGtiKuOVqbMz9cafo\u003d","cmdEventType":"VM.CREATE","ctxUserId":"2","serviceOfferingId":"8f42daa3-37aa-48d2-b01d-903cfc19345b","httpmethod":"GET","zoneId":"3cc53a2d-6e2b-4ccb-8ccb-6fe2e7d9eb54","templateId":"82d671d6-30ee-40d4-8ad1-f922bf055630","response":"json","id":"18","networkIds":"05fea399-b39d-4428-85db-c09eb7815f94","hypervisor":"KVM","_":"1377750452631","ctxAccountId":"2","ctxStartEventId":"171"}
> job_cmd_ver: 0
> callback_type: 0
> callback_address: NULL
> job_status: 2
> job_process_status: 0
> job_result_code: 530
> job_result: org.apache.cloudstack.api.response.ExceptionResponse/null/{"uuidList":[],"errorcode":533,"errortext":"Unable to create a deployment for VM[User|6e798618-8e4d-4305-94a1-642e5f3aad08]"}
> job_init_msid: 7175246184473
> job_complete_msid: 7175246184473
> created: 2013-08-29 09:51:39
> last_updated: 2013-08-29 09:51:47
> last_polled: 2013-08-29 09:51:45
> removed: NULL
> uuid: 3dcbbb22-d258-4859-bf3f-c8a620768e25
> 42 rows in set (0.00 sec)
> ERROR:
> oot@Rack1Pod1Host21:~# ceph osd tree
> # id weight type name up/down reweight
> -1 0.14 root default
> -2 0.14 host ubuntu3
> 0 0.06999 osd.0 up 1
> 1 0.06999 osd.1 up 1
--
This message was sent by Atlassian JIRA
(v6.2#6252)