You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@cloudstack.apache.org by "Sangeetha Hariharan (JIRA)" <ji...@apache.org> on 2013/07/17 02:26:48 UTC

[jira] [Created] (CLOUDSTACK-3569) Parallel deployment - Vmware - When deploying 30 parallel Vms , we see few Vms failing in SavePasswordCommand,DhcpEntryCommand ,VmDataCommand.

Sangeetha Hariharan created CLOUDSTACK-3569:
-----------------------------------------------

             Summary: Parallel deployment - Vmware - When deploying 30 parallel Vms , we see few Vms failing in  SavePasswordCommand,DhcpEntryCommand ,VmDataCommand.
                 Key: CLOUDSTACK-3569
                 URL: https://issues.apache.org/jira/browse/CLOUDSTACK-3569
             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
         Environment: Build from 4.2.0
            Reporter: Sangeetha Hariharan
            Priority: Blocker
             Fix For: 4.2.0


Parallel deployment - Vmware - When deploying 30 parallel Vms , we see ~15 Vms fail in org.apache.cloudstack.storage.command.CopyCommand.

Steps to reproduce the problem:

Set up - Advanced zone with Vmware ESXI, 5.0.0 host.

Deploy 30 Vms in parallel in a network that is already implemented (router is already running).
Only 9 vms were successfully deployed.

~15 Vms failed due to issue reported in cloudstack-3568.

Rest of the Vm deplpoyment failed in  SavePasswordCommand,DhcpEntryCommand ,VmDataCommand where it encounters an IO Exception when trying to communicate with the router.

 mysql> select count(*),state,type from vm_instance where name like "hello%" group by state,type ;
+----------+---------+------+
| count(*) | state | type |
+----------+---------+------+
| 42 | Error | User |
| 9 | Running | User |
+----------+---------+------+
2 rows in set (0.00 sec)

Following exception seen in management server logs: 
2013-07-16 15:46:18,814 ERROR [vmware.resource.VmwareResource] (DirectAgent-44:10.223.57.66) VmDataCommand failed due to Exception: java.io.IOException
Message: There was a problem while connecting to 10.223.57.96:3922

java.io.IOException: There was a problem while connecting to 10.223.57.96:3922
        at com.trilead.ssh2.Connection.connect(Connection.java:792)
        at com.cloud.utils.ssh.SshHelper.sshExecute(SshHelper.java:132)
        at com.cloud.utils.ssh.SshHelper.sshExecute(SshHelper.java:37)
        at com.cloud.hypervisor.vmware.resource.VmwareResource.execute(VmwareResource.java:2345)
        at com.cloud.hypervisor.vmware.resource.VmwareResource.executeRequest(VmwareResource.java:441)
        at com.cloud.agent.manager.DirectAgentAttache$Task.run(DirectAgentAttache.java:186)
        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.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$101(ScheduledThreadPoolExecutor.java:165)
        at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:266)
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1110)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:603)
        at java.lang.Thread.run(Thread.java:679)
Caused by: java.io.IOException: Premature connection close
        at com.trilead.ssh2.transport.ClientServerHello.readLineRN(ClientServerHello.java:33)
        at com.trilead.ssh2.transport.ClientServerHello.<init>(ClientServerHello.java:68)
        at com.trilead.ssh2.transport.TransportManager.initialize(TransportManager.java:461)
        at com.trilead.ssh2.Connection.connect(Connection.java:732)
        ... 13 more
2013-07-16 15:46:18,815 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-44:null) Seq 1-227737678: Response Received:
2013-07-16 15:46:18,815 DEBUG [agent.transport.Request] (DirectAgent-44:null) Seq 1-227737678: Processing:  { Ans: , MgmtId: 7647994577963, via: 1, Ver: v1, Flags: 10, [{"com.cloud.agent.api.Answer":{"result":true,"wait":0}},{"com.cloud.agent.api.Answer":{"result":false,"details":"VmDataCommand failed due to Exception: java.io.IOException\nMessage: There was a problem while connecting to 10.223.57.96:3922\n","wait":0}}] }
2013-07-16 15:46:18,816 DEBUG [agent.transport.Request] (Job-Executor-16:job-109 = [ f31f7d1f-7f1e-453c-ba0a-5600ebe43487 ]) Seq 1-227737678: Received:  { Ans: , MgmtId: 7647994577963, via: 1, Ver: v1, Flags: 10, { Answer, Answer } }
2013-07-16 15:46:18,816 INFO  [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-16:job-109 = [ f31f7d1f-7f1e-453c-ba0a-5600ebe43487 ]) Unable to contact resource.
com.cloud.exception.ResourceUnavailableException: Resource [DataCenter:1] is unreachable: Unable to apply userdata and password entry on router
        at com.cloud.network.router.VirtualNetworkApplianceManagerImpl.applyRules(VirtualNetworkApplianceManagerImpl.java:3804)
        at com.cloud.network.router.VirtualNetworkApplianceManagerImpl.applyUserData(VirtualNetworkApplianceManagerImpl.java:2991)
        at com.cloud.network.element.VirtualRouterElement.addPasswordAndUserdata(VirtualRouterElement.java:944)
        at com.cloud.network.NetworkManagerImpl.prepareElement(NetworkManagerImpl.java:2015)
        at com.cloud.network.NetworkManagerImpl.prepareNic(NetworkManagerImpl.java:2121)
        at com.cloud.network.NetworkManagerImpl.prepare(NetworkManagerImpl.java:2062)
        at com.cloud.vm.VirtualMachineManagerImpl.advanceStart(VirtualMachineManagerImpl.java:858)
        at com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:566)
        at org.apache.cloudstack.engine.cloud.entity.api.VMEntityManagerImpl.deployVirtualMachine(VMEntityManagerImpl.java:239)
        at org.apache.cloudstack.engine.cloud.entity.api.VirtualMachineEntityImpl.deploy(VirtualMachineEntityImpl.java:209)
        at com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:3318)
        at com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:2878)
        at com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:2864)
        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:1110)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:603)
        at java.lang.Thread.run(Thread.java:679)


--
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