cloudstack-issues mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From "Rohit Yadav (JIRA)" <j...@apache.org>
Subject [jira] [Commented] (CLOUDSTACK-7327) Failed to deploy instance when using an IP from freshly added IP pool
Date Wed, 20 Aug 2014 12:57:26 GMT

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

Rohit Yadav commented on CLOUDSTACK-7327:
-----------------------------------------

Hi, can you comment how you deployed your zone and if you select any offering or parameter
which set the vlan id to ec:// in the first place; in basic zone it uses untagged by default.
I'll ask if any of the KVM gurus can comment.

> Failed to deploy instance when using an IP from freshly added IP pool
> ---------------------------------------------------------------------
>
>                 Key: CLOUDSTACK-7327
>                 URL: https://issues.apache.org/jira/browse/CLOUDSTACK-7327
>             Project: CloudStack
>          Issue Type: Bug
>      Security Level: Public(Anyone can view this level - this is the default.) 
>          Components: KVM
>    Affects Versions: 4.3.0
>         Environment: Cloudstack 4.3, Basic networking, KVM on ubuntu 12.04
>            Reporter: Loic Lambiel
>
> Hi,
> We have a case where an instance failed to deploy when it takes an IP from a freshly
added IP pool range.
> Our setup: Cloudstack 4.3, Basic networking, KVM on Ubuntu 12.04. Our setup is running
since 4.0.0.
> The workaround is to change the vlan_id field of the ip pool in the cloud.vlan table
from "EC2://untagged" to "untagged"
> Below the logs:
> *Management server:*
> {quote}
> ERROR [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-13:ctx-3e34bc70 ctx-b69247df)
Failed to start instance VM[User|VM-fe3812d7-9d3d-49d8-9692-d9a8c976
> 6c6f]
> com.cloud.utils.exception.CloudRuntimeException: Unable to get answer that is of class
com.cloud.agent.api.StartAnswer
>         at com.cloud.agent.manager.Commands.getAnswer(Commands.java:80)
>         at com.cloud.vm.VirtualMachineManagerImpl.orchestrateStart(VirtualMachineManagerImpl.java:992)
>         at com.cloud.vm.VirtualMachineManagerImpl.advanceStart(VirtualMachineManagerImpl.java:761)
>         at com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:601)
>         at org.apache.cloudstack.engine.cloud.entity.api.VMEntityManagerImpl.deployVirtualMachine(VMEntityManagerImpl.java:228)
>         at org.apache.cloudstack.engine.cloud.entity.api.VirtualMachineEntityImpl.deploy(VirtualMachineEntityImpl.java:207)
>         at com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:3581)
>         at com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:3161)
>         at com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:3147)
>         at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
>         at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
>         at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
>         at java.lang.reflect.Method.invoke(Method.java:606)
>         at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:317)
>         at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:183)
>         at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:150)
>         at com.cloud.event.ActionEventInterceptor.invoke(ActionEventInterceptor.java:50)
>         at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:161)
>         at org.springframework.aop.interceptor.ExposeInvocationInterceptor.invoke(ExposeInvocationInterceptor.java:91)
>         at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172)
>         at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:204)
>         at com.sun.proxy.$Proxy169.startVirtualMachine(Unknown Source)
>         at org.apache.cloudstack.api.command.user.vm.DeployVMCmd.execute(DeployVMCmd.java:443)
>         at com.cloud.api.ApiDispatcher.dispatch(ApiDispatcher.java:161)
>         at com.cloud.api.ApiAsyncJobDispatcher.runJobInContext(ApiAsyncJobDispatcher.java:109)
>         at com.cloud.api.ApiAsyncJobDispatcher$1.run(ApiAsyncJobDispatcher.java:66)
>         at org.apache.cloudstack.managed.context.impl.DefaultManagedContext$1.call(DefaultManagedContext.java:56)
>         at org.apache.cloudstack.managed.context.impl.DefaultManagedContext.callWithContext(DefaultManagedContext.java:103)
>         at org.apache.cloudstack.managed.context.impl.DefaultManagedContext.runWithContext(DefaultManagedContext.java:53)
>         at com.cloud.api.ApiAsyncJobDispatcher.runJob(ApiAsyncJobDispatcher.java:63)
>         at org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.runInContext(AsyncJobManagerImpl.java:509)
>         at org.apache.cloudstack.managed.context.ManagedContextRunnable$1.run(ManagedContextRunnable.java:49)
>         at org.apache.cloudstack.managed.context.impl.DefaultManagedContext$1.call(DefaultManagedContext.java:56)
>         at org.apache.cloudstack.managed.context.impl.DefaultManagedContext.callWithContext(DefaultManagedContext.java:103)
>         at org.apache.cloudstack.managed.context.impl.DefaultManagedContext.runWithContext(DefaultManagedContext.java:53)
>         at org.apache.cloudstack.managed.context.ManagedContextRunnable.run(ManagedContextRunnable.java:46)
>         at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
>         at java.util.concurrent.FutureTask.run(FutureTask.java:262)
>         at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
>         at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
>         at java.lang.Thread.run(Thread.java:744)
> {quote}
> *Agent:*
> {quote}
> [DEBUG] [2014-08-12T00:06:25.516+02:00] - Agent.java:450 - Request:Seq 48-518389783:
 { Cmd , MgmtId: 90520742695270, via: 48, Ver: v1, Flags: 100011, [{"com.cloud.agent.api.StartCommand":{"vm":{"id":11397,"name":"i-161-11397-VM","type":"User","cpus":1,"minSpeed":732,"maxSpeed":2198,"minRam":536870912,"maxRam":536870912,"arch":"x86_64","os":"Other
PV (64-bit)","bootArgs":"","rebootOnCrash":false,"enableHA":false,"limitCpuUse":false,"enableDynamicallyScaleVm":false,"vncPassword":"4dd550e02a904de5","params":{"memoryOvercommitRatio":"1","SSH.PublicKey":"ssh-rsa
blabla","cpuOvercommitRatio":"3","Encrypted.Password":"blabla"},"uuid":"519d6ff0-f32d-4d44-8a0e-61116d7cf2bb","disks":[{"data":{"org.apache.cloudstack.storage.to.VolumeObjectTO":{"uuid":"1c6d5378-30da-4172-8cb0-e790a9175745","volumeType":"ROOT","dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"a9585123-829c-4972-a449-8b7f911c88ec","id":290,"poolType":"Filesystem","host":"10.16.36.49","path":"/var/lib/libvirt/images","port":0,"url":"Filesystem://10.16.36.49//var/lib/libvirt/images/?ROLE=Primary&STOREUUID=a9585123-829c-4972-a449-8b7f911c88ec"}},"name":"ROOT-11397","size":10737418240,"path":"1c6d5378-30da-4172-8cb0-e790a9175745","volumeId":11369,"vmName":"i-161-11397-VM","accountId":161,"format":"QCOW2","id":11369,"deviceId":0,"hypervisorType":"KVM"}},"diskSeq":0,"path":"1c6d5378-30da-4172-8cb0-e790a9175745","type":"ROOT","_details":{"managed":"false","storagePort":"0","storageHost":"10.16.36.49","volumeSize":"10737418240"}},{"data":{"org.apache.cloudstack.storage.to.TemplateObjectTO":{"id":0,"format":"ISO","accountId":0,"hvm":false}},"diskSeq":3,"type":"ISO"}],"nics":[{"deviceId":0,"networkRateMbps":-1,"defaultNic":true,"uuid":"a08d866b-732c-4a3f-8ddf-b6cb57fcb086","ip":"185.19.30.250","netmask":"255.255.252.0","gateway":"185.19.28.1","mac":"06:d4:6a:00:00:52","dns1":"80.245.17.229","dns2":"80.245.17.230","broadcastType":"Vlan","type":"Guest","isSecurityGroupEnabled":true,"name":"public"}]},"hostIp":"10.16.36.49","executeInSequence":false,"wait":0}}]
}
> [DEBUG] [2014-08-12T00:06:25.516+02:00] - Agent.java:454 - Processing command: com.cloud.agent.api.StartCommand
> [DEBUG] [2014-08-12T00:06:25.551+02:00] - BridgeVifDriver.java:91 - nic=[Nic:Guest-185.19.30.250-null]
> [DEBUG] [2014-08-12T00:06:25.552+02:00] - KVMStoragePoolManager.java:174 - Disconnecting
disk 1c6d5378-30da-4172-8cb0-e790a9175745
> [WARN] [2014-08-12T00:06:25.562+02:00] - Agent.java:508 - Caught:
> [DEBUG] [2014-08-12T00:06:25.568+02:00] - Agent.java:527 - Seq 48-518389783:  { Ans:
, MgmtId: 90520742695270, via: 48, Ver: v1, Flags: 10, [{"com.cloud.agent.api.Answer":{"result":false,"details":"java.lang.NullPointerException\n\tat
com.cloud.network.Networks$BroadcastDomainType.getSchemeValue(Networks.java:173)\n\tat com.cloud.network.Networks$BroadcastDomainType.getValue(Networks.java:228)\n\tat
com.cloud.hypervisor.kvm.resource.BridgeVifDriver.plug(BridgeVifDriver.java:99)\n\tat com.cloud.hypervisor.kvm.resource.LibvirtComputingResource.createVif(LibvirtComputingResource.java:3882)\n\tat
com.cloud.hypervisor.kvm.resource.LibvirtComputingResource.createVifs(LibvirtComputingResource.java:3633)\n\tat
com.cloud.hypervisor.kvm.resource.LibvirtComputingResource.execute(LibvirtComputingResource.java:3660)\n\tat
com.cloud.hypervisor.kvm.resource.LibvirtComputingResource.executeRequest(LibvirtComputingResource.java:1307)\n\tat
com.cloud.agent.Agent.processRequest(Agent.java:498)\n\tat com.cloud.agent.Agent$AgentRequestHandler.doTask(Agent.java:806)\n\tat
com.cloud.utils.nio.Task.run(Task.java:83)\n\tat java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)\n\tat
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)\n\tat java.lang.Thread.run(Thread.java:744)\n","wait":0}}]
}
> [DEBUG] [2014-08-12T00:06:25.590+02:00] - Agent.java:450 - Request:Seq 48-518389784:
 { Cmd , MgmtId: 90520742695270, via: 48, Ver: v1, Flags: 100011, [{"com.cloud.agent.api.StopCommand":{"isProxy":false,"executeInSequence":false,"vmName":"i-161-11397-VM","wait":0}}]
}
> [DEBUG] [2014-08-12T00:06:25.590+02:00] - Agent.java:454 - Processing command: com.cloud.agent.api.StopCommand
> [DEBUG] [2014-08-12T00:06:25.597+02:00] - LibvirtConnection.java:69 - can't find connection:
KVM, for vm: i-161-11397-VM, continue
> [DEBUG] [2014-08-12T00:06:25.601+02:00] - LibvirtConnection.java:69 - can't find connection:
LXC, for vm: i-161-11397-VM, continue
> [DEBUG] [2014-08-12T00:06:25.601+02:00] - LibvirtConnection.java:73 - can't find which
hypervisor the vm used , then use the default hypervisor
> [DEBUG] [2014-08-12T00:06:25.603+02:00] - LibvirtComputingResource.java:4938 - Failed
to get dom xml: org.libvirt.LibvirtException: Domain not found: no domain with matching name
'i-161-11397-VM'
> [DEBUG] [2014-08-12T00:06:25.605+02:00] - LibvirtComputingResource.java:4916 - Failed
to get dom xml: org.libvirt.LibvirtException: Domain not found: no domain with matching name
'i-161-11397-VM'
> [DEBUG] [2014-08-12T00:06:25.606+02:00] - LibvirtComputingResource.java:4916 - Failed
to get dom xml: org.libvirt.LibvirtException: Domain not found: no domain with matching name
'i-161-11397-VM'
> [DEBUG] [2014-08-12T00:06:25.607+02:00] - Script.java:168 - Executing: /usr/share/cloudstack-common/scripts/vm/network/security_group.py
destroy_network_rules_for_vm --vmname i-161-11397-VM
> DEBUG] [2014-08-12T00:06:29.308+02:00] - Script.java:200 - Execution is successful.
> [DEBUG] [2014-08-12T00:06:29.309+02:00] - LibvirtComputingResource.java:4666 - Try to
stop the vm at first
> [DEBUG] [2014-08-12T00:06:29.311+02:00] - LibvirtComputingResource.java:4757 - VM i-161-11397-VM
doesn't exist, no need to stop it
> [DEBUG] [2014-08-12T00:06:29.313+02:00] - Agent.java:527 - Seq 48-518389784:  { Ans:
, MgmtId: 90520742695270, via: 48, Ver: v1, Flags: 10, [{"com.cloud.agent.api.StopAnswer":{"result":true,"wait":0}}]
}
> [DEBUG] [2014-08-12T00:07:04.219+02:00] - Script.java:168 - Executing: /usr/share/cloudstack-common/scripts/vm/network/security_group.py
get_rule_logs_for_vms
> [DEBUG] [2014-08-12T00:07:04.536+02:00] - Agent.java:454 - Processing command: com.cloud.agent.api.GetHostStatsCommand
> [DEBUG] [2014-08-12T00:07:04.536+02:00] - Script.java:168 - Executing: /bin/bash -c idle=$(top
-b -n 1|grep Cpu\(s\):|cut -d% -f4|cut -d, -f2);echo $idle
> [DEBUG] [2014-08-12T00:07:05.076+02:00] - Script.java:200 - Execution is successful.
> [DEBUG] [2014-08-12T00:07:05.077+02:00] - Script.java:168 - Executing: /bin/bash -c freeMem=$(free|grep
cache:|awk '{print $4}');echo $freeMem
> [DEBUG] [2014-08-12T00:07:05.084+02:00] - Script.java:200 - Execution is successful.
> [DEBUG] [2014-08-12T00:07:05.084+02:00] - Script.java:168 - Executing: /bin/bash -c free|grep
Mem:|awk '{print $2}'
> [DEBUG] [2014-08-12T00:07:05.090+02:00] - Script.java:200 - Execution is successful.
> [DEBUG] [2014-08-12T00:07:07.825+02:00] - Script.java:200 - Execution is successful.
> {quote}



--
This message was sent by Atlassian JIRA
(v6.2#6252)

Mime
View raw message