shweta agarwal created CLOUDSTACK-2786:
------------------------------------------
Summary: System VM on vmware setup is not coming up
Key: CLOUDSTACK-2786
URL: https://issues.apache.org/jira/browse/CLOUDSTACK-2786
Project: CloudStack
Issue Type: Bug
Security Level: Public (Anyone can view this level - this is the default.)
Components: Management Server, VMware
Affects Versions: 4.2.0
Environment: build:
CloudStack-non-OSS-MASTER-426-rhel6.3.tar.gz
ESXI5.1 host
NFS Storage
Reporter: shweta agarwal
Priority: Blocker
Fix For: 4.2.0
Repro steps:
1. Create a VMware zone
2. Enable it
Bug:
I am hitting exception
2013-05-31 10:59:13,178 INFO [vmware.manager.VmwareStorageManagerImpl]
(DirectAgent-1:10.147.40.27) Template routing-8 is not setup yet, setup
template from secondary storage with uuid name: d5beee04cb3e3a8593e41cb574cc0e9f
2013-05-31 10:59:13,193 INFO [vmware.manager.VmwareStorageManagerImpl]
(DirectAgent-1:10.147.40.27) Executing copyTemplateFromSecondaryToPrimary.
secondaryStorage: nfs://10.147.28.7/export/home/shweta/vmwaresecondary.premium,
templatePathAtSecondaryStorage: template/tmpl/1/8/, templateName: routing-8
2013-05-31 10:59:13,203 DEBUG [vmware.manager.VmwareManagerImpl]
(DirectAgent-1:10.147.40.27) Executing: sudo mount -t nfs
10.147.28.7:/export/home/shweta/vmwaresecondary.premium
/var/cloudstack/mnt/VM/6909931290812.606fba60
2013-05-31 10:59:13,217 WARN [vmware.manager.VmwareManagerImpl]
(DirectAgent-1:10.147.40.27) Exception: sudo mount -t nfs
10.147.28.7:/export/home/shweta/vmwaresecondary.premium
/var/cloudstack/mnt/VM/6909931290812.606fba60
java.io.IOException: Cannot run program "sudo": java.io.IOException: error=12,
Cannot allocate memory
at java.lang.ProcessBuilder.start(ProcessBuilder.java:475)
at com.cloud.utils.script.Script.execute(Script.java:183)
at com.cloud.utils.script.Script.execute(Script.java:161)
at
com.cloud.hypervisor.vmware.manager.VmwareManagerImpl.mount(VmwareManagerImpl.java:690)
at
com.cloud.hypervisor.vmware.manager.VmwareManagerImpl.getMountPoint(VmwareManagerImpl.java:598)
at
com.cloud.hypervisor.vmware.manager.VmwareStorageManagerImpl.copyTemplateFromSecondaryToPrimary(VmwareStorageManagerImpl.java:559)
at
com.cloud.hypervisor.vmware.manager.VmwareStorageManagerImpl.execute(VmwareStorageManagerImpl.java:262)
at
com.cloud.hypervisor.vmware.resource.VmwareResource.execute(VmwareResource.java:3939)
at
com.cloud.hypervisor.vmware.resource.VmwareResource.executeRequest(VmwareResource.java:436)
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:1146)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:679)
Caused by: java.io.IOException: java.io.IOException: error=12, Cannot allocate
memory
at java.lang.UNIXProcess.<init>(UNIXProcess.java:164)
at java.lang.ProcessImpl.start(ProcessImpl.java:81)
at java.lang.ProcessBuilder.start(ProcessBuilder.java:468)
... 17 more
2013-05-31 10:59:13,218 WARN [vmware.manager.VmwareManagerImpl]
(DirectAgent-1:10.147.40.27) Unable to mount
10.147.28.7:/export/home/shweta/vmwaresecondary.premium due to
java.io.IOException: Cannot run program "sudo": java.io.IOException: error=12,
Cannot allocate memory
at java.lang.ProcessBuilder.start(ProcessBuilder.java:475)
at com.cloud.utils.script.Script.execute(Script.java:183)
at com.cloud.utils.script.Script.execute(Script.java:161)
at com.cloud.utils.script.Script.execute(Script.java:161)
at
com.cloud.hypervisor.vmware.manager.VmwareManagerImpl.mount(VmwareManagerImpl.java:690)
at
com.cloud.hypervisor.vmware.manager.VmwareManagerImpl.getMountPoint(VmwareManagerImpl.java:598)
at
com.cloud.hypervisor.vmware.manager.VmwareStorageManagerImpl.copyTemplateFromSecondaryToPrimary(VmwareStorageManagerImpl.java:559)
at
com.cloud.hypervisor.vmware.manager.VmwareStorageManagerImpl.execute(VmwareStorageManagerImpl.java:262)
at
com.cloud.hypervisor.vmware.resource.VmwareResource.execute(VmwareResource.java:3939)
at
com.cloud.hypervisor.vmware.resource.VmwareResource.executeRequest(VmwareResource.java:436)
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:1146)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:679)
Caused by: java.io.IOException: java.io.IOException: error=12, Cannot allocate
memory
at java.lang.UNIXProcess.<init>(UNIXProcess.java:164)
at java.lang.ProcessImpl.start(ProcessImpl.java:81)
at java.lang.ProcessBuilder.start(ProcessBuilder.java:468)
... 17 more
2013-05-31 10:59:13,220 ERROR [vmware.manager.VmwareManagerImpl]
(DirectAgent-1:10.147.40.27) Unable to create mount point for
nfs://10.147.28.7/export/home/shweta/vmwaresecondary.premium
2013-05-31 10:59:13,220 INFO [vmware.manager.VmwareStorageManagerImpl]
(DirectAgent-1:10.147.40.27) Secondary storage mount point: /mnt/sec
2013-05-31 10:59:15,895 DEBUG
[network.router.VirtualNetworkApplianceManagerImpl]
(RouterStatusMonitor-1:null) Found 0 routers to update status.
2013-05-31 10:59:15,898 DEBUG
[network.router.VirtualNetworkApplianceManagerImpl]
(RouterStatusMonitor-1:null) Found 0 networks to update RvR status.
2013-05-31 10:59:16,073 DEBUG
[network.router.VirtualNetworkApplianceManagerImpl]
(RouterStatusMonitor-1:null) Found 0 routers to update status.
2013-05-31 10:59:16,079 DEBUG
[network.router.VirtualNetworkApplianceManagerImpl]
(RouterStatusMonitor-1:null) Found 0 networks to update RvR status.
2013-05-31 10:59:17,792 DEBUG [cloud.network.NetworkManagerImpl]
(secstorage-1:null) Lock is acquired for network id 200 as a part of network
implement
2013-05-31 10:59:17,797 DEBUG [cloud.network.NetworkManagerImpl]
(secstorage-1:null) Network id=200 is already implemented
2013-05-31 10:59:17,798 DEBUG [cloud.network.NetworkManagerImpl]
(secstorage-1:null) Lock is released for network id 200 as a part of network
implement
2013-05-31 10:59:17,827 DEBUG [cloud.network.NetworkManagerImpl]
(secstorage-1:null) Asking JuniperSRX to prepare for Nic[1-1-null-10.147.51.10]
2013-05-31 10:59:17,827 DEBUG [cloud.network.NetworkManagerImpl]
(secstorage-1:null) Asking Netscaler to prepare for Nic[1-1-null-10.147.51.10]
2013-05-31 10:59:17,827 DEBUG [cloud.network.NetworkManagerImpl]
(secstorage-1:null) Asking F5BigIP to prepare for Nic[1-1-null-10.147.51.10]
2013-05-31 10:59:17,827 DEBUG [cloud.network.NetworkManagerImpl]
(secstorage-1:null) Asking CiscoNexus1000vVSM to prepare for
Nic[1-1-null-10.147.51.10]
2013-05-31 10:59:17,828 DEBUG [cloud.network.NetworkManagerImpl]
(secstorage-1:null) Asking CiscoVNMC to prepare for Ni
I have tried installing this setup several times and hitting this exception
everytime.
--
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
