[
https://issues.apache.org/jira/browse/CLOUDSTACK-5883?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=14170865#comment-14170865
]
prashant kumar mishra commented on CLOUDSTACK-5883:
---------------------------------------------------
facing same issue :
==============
014-10-14 19:03:40,774 DEBUG
[network.router.VirtualNetworkApplianceManagerImpl]
(RouterStatusMonitor-1:null) Found 0 networks to update RvR status.
2014-10-14 19:03:40,779 DEBUG [storage.image.TemplateDataFactoryImpl]
(consoleproxy-1:null) template 8 is already in store:2, type:Image
2014-10-14 19:03:40,780 DEBUG [cloud.storage.VolumeManagerImpl]
(consoleproxy-1:null) Creating volume from template 8in the zone 1
2014-10-14 19:03:40,793 DEBUG [agent.transport.Request] (secstorage-1:null) Seq
1-1018036365: Sending { Cmd , MgmtId: 7204337877055, via: 1, Ver: v1, Flags:
100111,
[{"org.apache.cloudstack.storage.command.CopyCommand":{"srcTO":{"org.apache.cloudstack.storage.to.TemplateObjectTO":{"path":"template/tmpl/1/8/","origUrl":"http://download.cloud.com/templates/4.2/systemvmtemplate-4.2-vh7.ova","uuid":"7f576ed0-53bf-11e4-ab93-068d6400003f","id":8,"format":"OVA","accountId":1,"checksum":"8fde62b1089e5844a9cd3b9b953f9596","hvm":false,"displayText":"SystemVM
Template
(vSphere)","imageDataStore":{"com.cloud.agent.api.to.NfsTO":{"_url":"nfs://10.147.28.7/export/home/prashant/4.2.1.6_vmware","_role":"Image"}},"name":"routing-8","hypervisorType":"VMware"}},"destTO":{"org.apache.cloudstack.storage.to.TemplateObjectTO":{"origUrl":"http://download.cloud.com/templates/4.2/systemvmtemplate-4.2-vh7.ova","uuid":"7f576ed0-53bf-11e4-ab93-068d6400003f","id":8,"format":"OVA","accountId":1,"checksum":"8fde62b1089e5844a9cd3b9b953f9596","hvm":false,"displayText":"SystemVM
Template
(vSphere)","imageDataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"4ebfb2e7-9c62-31a1-a94f-43e285f334c8","id":2,"poolType":"NetworkFilesystem","host":"10.147.28.7","path":"/export/home/prashant/pm1","port":2049}},"name":"routing-8","hypervisorType":"VMware"}},"executeInSequence":true,"wait":10800}}]
}
2014-10-14 19:03:40,799 DEBUG [agent.transport.Request] (secstorage-1:null) Seq
1-1018036365: Executing: { Cmd , MgmtId: 7204337877055, via: 1, Ver: v1,
Flags: 100111,
[{"org.apache.cloudstack.storage.command.CopyCommand":{"srcTO":{"org.apache.cloudstack.storage.to.TemplateObjectTO":{"path":"template/tmpl/1/8/","origUrl":"http://download.cloud.com/templates/4.2/systemvmtemplate-4.2-vh7.ova","uuid":"7f576ed0-53bf-11e4-ab93-068d6400003f","id":8,"format":"OVA","accountId":1,"checksum":"8fde62b1089e5844a9cd3b9b953f9596","hvm":false,"displayText":"SystemVM
Template
(vSphere)","imageDataStore":{"com.cloud.agent.api.to.NfsTO":{"_url":"nfs://10.147.28.7/export/home/prashant/4.2.1.6_vmware","_role":"Image"}},"name":"routing-8","hypervisorType":"VMware"}},"destTO":{"org.apache.cloudstack.storage.to.TemplateObjectTO":{"origUrl":"http://download.cloud.com/templates/4.2/systemvmtemplate-4.2-vh7.ova","uuid":"7f576ed0-53bf-11e4-ab93-068d6400003f","id":8,"format":"OVA","accountId":1,"checksum":"8fde62b1089e5844a9cd3b9b953f9596","hvm":false,"displayText":"SystemVM
Template
(vSphere)","imageDataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"4ebfb2e7-9c62-31a1-a94f-43e285f334c8","id":2,"poolType":"NetworkFilesystem","host":"10.147.28.7","path":"/export/home/prashant/pm1","port":2049}},"name":"routing-8","hypervisorType":"VMware"}},"executeInSequence":true,"wait":10800}}]
}
2014-10-14 19:03:40,797 DEBUG [storage.image.TemplateDataFactoryImpl]
(consoleproxy-1:null) template 8 is already in store:2, type:Primary
2014-10-14 19:03:40,802 DEBUG [storage.volume.VolumeServiceImpl]
(consoleproxy-1:null) Found template routing-8 in storage pool 2 with
VMTemplateStoragePool id: 33
2014-10-14 19:03:40,803 DEBUG [agent.manager.DirectAgentAttache]
(DirectAgent-70:null) Seq 1-1018036365: Executing request
2014-10-14 19:03:40,804 INFO [storage.resource.VmwareStorageProcessor]
(DirectAgent-70:10.147.40.7, cmd: CopyCommand) Template mount point:
template/tmpl/1/8/, name: routing-8
2014-10-14 19:03:40,809 DEBUG [storage.volume.VolumeServiceImpl]
(consoleproxy-1:null) Acquire lock on VMTemplateStoragePool 33 with timeout
3600 seconds
2014-10-14 19:03:40,895 DEBUG
[network.router.VirtualNetworkApplianceManagerImpl]
(RouterStatusMonitor-1:null) Found 0 routers to update status.
2014-10-14 19:03:40,898 DEBUG
[network.router.VirtualNetworkApplianceManagerImpl]
(RouterStatusMonitor-1:null) Found 0 networks to update RvR status.
2014-10-14 19:03:40,932 INFO [storage.resource.VmwareStorageProcessor]
(DirectAgent-70:10.147.40.7, cmd: CopyCommand) Template routing-8 is not setup
yet, setup template from secondary storage with uuid name:
a125168264ee3509a169cf05964ec66c
2014-10-14 19:03:41,007 INFO [storage.resource.VmwareStorageProcessor]
(DirectAgent-70:10.147.40.7, cmd: CopyCommand) Executing
copyTemplateFromSecondaryToPrimary. secondaryStorage:
nfs://10.147.28.7/export/home/prashant/4.2.1.6_vmware,
templatePathAtSecondaryStorage: template/tmpl/1/8/, templateName: routing-8
2014-10-14 19:03:41,007 INFO [storage.resource.VmwareStorageProcessor]
(DirectAgent-70:10.147.40.7, cmd: CopyCommand) Secondary storage mount point:
/var/cloudstack/mnt/VM/7204337877055.17806abb, src OVA:
/var/cloudstack/mnt/VM/7204337877055.17806abb/template/tmpl/1/8//routing-8.ova
2014-10-14 19:03:41,010 INFO [storage.resource.VmwareStorageProcessor]
(DirectAgent-70:10.147.40.7, cmd: CopyCommand) Import OVF from secondary
storage into vCenter. OVF file:
/var/cloudstack/mnt/VM/7204337877055.17806abb/template/tmpl/1/8/systemvmtemplate-2014-10-07-master-vmware.ovf,
VM: a125168264ee3509a169cf05964ec66c
2014-10-14 19:03:41,079 ERROR [storage.resource.VmwareStorageProcessor]
(DirectAgent-70:10.147.40.7, cmd: CopyCommand) Unable to copy template to
primary storage due to exception:Exception: javax.xml.ws.soap.SOAPFaultException
Message:
Required parameter spec is missing
while parsing call information for method ImportVApp
at line 1, column 110
while parsing SOAP body
at line 1, column 102
while parsing SOAP envelope
at line 1, column 38
while parsing HTTP request for method importVApp
on object of type vim.ResourcePool
at line 1, column 0
javax.xml.ws.soap.SOAPFaultException:
Required parameter spec is missing
while parsing call information for method ImportVApp
at line 1, column 110
while parsing SOAP body
at line 1, column 102
while parsing SOAP envelope
at line 1, column 38
while parsing HTTP request for method importVApp
on object of type vim.ResourcePool
at line 1, column 0
at
com.sun.xml.internal.ws.fault.SOAP11Fault.getProtocolException(SOAP11Fault.java:178)
at
com.sun.xml.internal.ws.fault.SOAPFaultBuilder.createException(SOAPFaultBuilder.java:119)
at
com.sun.xml.internal.ws.client.sei.SyncMethodHandler.invoke(SyncMethodHandler.java:108)
at
com.sun.xml.internal.ws.client.sei.SyncMethodHandler.invoke(SyncMethodHandler.java:78)
at com.sun.xml.internal.ws.client.sei.SEIStub.invoke(SEIStub.java:129)
at $Proxy89.importVApp(Unknown Source)
at
com.cloud.hypervisor.vmware.mo.HypervisorHostHelper.importVmFromOVF(HypervisorHostHelper.java:1396)
at
com.cloud.hypervisor.vmware.mo.HostMO.importVmFromOVF(HostMO.java:750)
at
com.cloud.storage.resource.VmwareStorageProcessor.copyTemplateFromSecondaryToPrimary(VmwareStorageProcessor.java:172)
at
com.cloud.storage.resource.VmwareStorageProcessor.copyTemplateToPrimaryStorage(VmwareStorageProcessor.java:235)
at
com.cloud.storage.resource.StorageSubsystemCommandHandlerBase.execute(StorageSubsystemCommandHandlerBase.java:70)
at
com.cloud.storage.resource.VmwareStorageSubsystemCommandHandler.execute(VmwareStorageSubsystemCommandHandler.java:155)
at
com.cloud.storage.resource.StorageSubsystemCommandHandlerBase.handleStorageCommands(StorageSubsystemCommandHandlerBase.java:49)
at
com.cloud.hypervisor.vmware.resource.VmwareResource.executeRequest(VmwareResource.java:576)
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$201(ScheduledThreadPoolExecutor.java:178)
at
java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:292)
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:722)
2014-10-14 19:03:41,082 DEBUG [agent.manager.DirectAgentAttache]
(DirectAgent-70:null) Seq 1-1018036365: Response Received:
2014-10-14 19:03:41,083 DEBUG [agent.transport.Request] (DirectAgent-70:null)
Seq 1-1018036365: Processing: { Ans: , MgmtId: 7204337877055, via: 1, Ver: v1,
Flags: 110,
[{"org.apache.cloudstack.storage.command.CopyCmdAnswer":{"result":false,"details":"Unable
to copy template to primary storage due to exception:Exception:
javax.xml.ws.soap.SOAPFaultException\nMessage: \nRequired parameter spec is
missing\n\nwhile parsing call information for method ImportVApp\nat line 1,
column 110\n\nwhile parsing SOAP body\nat line 1, column 102\n\nwhile parsing
SOAP envelope\nat line 1, column 38\n\nwhile parsing HTTP request for method
importVApp\non object of type vim.ResourcePool\nat line 1, column
0\n","wait":0}}] }
2014-10-14 19:03:41,083 DEBUG [agent.transport.Request] (secstorage-1:null) Seq
1-1018036365: Received: { Ans: , MgmtId: 7204337877055, via: 1, Ver: v1,
Flags: 110, { CopyCmdAnswer } }
2014-10-14 19:03:41,087 DEBUG [agent.manager.AgentAttache]
(DirectAgent-70:null) Seq 1-1018036365: No more commands found
2014-10-14 19:03:41,108 INFO [storage.volume.VolumeServiceImpl]
(secstorage-1:null) releasing lock for VMTemplateStoragePool 33
2014-10-14 19:03:41,109 WARN [utils.db.Merovingian2] (secstorage-1:null) Was
unable to find lock for the key template_spool_ref33 and thread id 316457958
2014-10-14 19:03:41,109 DEBUG [cloud.storage.VolumeManagerImpl]
(secstorage-1:null) Unable to create Vol[19|vm=19|ROOT]:Unable to copy template
to primary storage due to exception:Exception:
javax.xml.ws.soap.SOAPFaultException
Message:
Required parameter spec is missing
while parsing call information for method ImportVApp
at line 1, column 110
while parsing SOAP body
at line 1, column 102
while parsing SOAP envelope
at line 1, column 38
while parsing HTTP request for method importVApp
on object of type vim.ResourcePool
at line 1, column 0
2014-10-14 19:03:41,110 INFO [cloud.vm.VirtualMachineManagerImpl]
(secstorage-1:null) Unable to contact resource.
com.cloud.exception.StorageUnavailableException: Resource [StoragePool:2] is
unreachable: Unable to create Vol[19|vm=19|ROOT]:Unable to copy template to
primary storage due to exception:Exception: javax.xml.ws.soap.SOAPFaultException
Message:
Required parameter spec is missing
while parsing call information for method ImportVApp
at line 1, column 110
while parsing SOAP body
at line 1, column 102
while parsing SOAP envelope
at line 1, column 38
while parsing HTTP request for method importVApp
on object of type vim.ResourcePool
at line 1, column 0
at
com.cloud.storage.VolumeManagerImpl.recreateVolume(VolumeManagerImpl.java:2712)
at
com.cloud.storage.VolumeManagerImpl.prepare(VolumeManagerImpl.java:2763)
at
com.cloud.vm.VirtualMachineManagerImpl.advanceStart(VirtualMachineManagerImpl.java:893)
at
com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:580)
at
com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:573)
at
com.cloud.storage.secondary.SecondaryStorageManagerImpl.startSecStorageVm(SecondaryStorageManagerImpl.java:267)
at
com.cloud.storage.secondary.SecondaryStorageManagerImpl.allocCapacity(SecondaryStorageManagerImpl.java:696)
at
com.cloud.storage.secondary.SecondaryStorageManagerImpl.expandPool(SecondaryStorageManagerImpl.java:1300)
at
com.cloud.secstorage.PremiumSecondaryStorageManagerImpl.scanPool(PremiumSecondaryStorageManagerImpl.java:123)
at
com.cloud.secstorage.PremiumSecondaryStorageManagerImpl.scanPool(PremiumSecondaryStorageManagerImpl.java:50)
at
com.cloud.vm.SystemVmLoadScanner.loadScan(SystemVmLoadScanner.java:104)
at
com.cloud.vm.SystemVmLoadScanner.access$100(SystemVmLoadScanner.java:33)
at
com.cloud.vm.SystemVmLoadScanner$1.reallyRun(SystemVmLoadScanner.java:81)
at com.cloud.vm.SystemVmLoadScanner$1.run(SystemVmLoadScanner.java:72)
at
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
at
java.util.concurrent.FutureTask$Sync.innerRunAndReset(FutureTask.java:351)
at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:178)
at
java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:178)
at
java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
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:722)
2014-10-14 19:03:41,120 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl]
(HostReservationReleaseChecker:null) Checking if any host reservation can be
released ...
2014-10-14 19:03:41,122 DEBUG [cloud.alert.AlertManagerImpl]
(CapacityChecker:null) Running Capacity Checker ...
2014-10-14 19:03:41,122 DEBUG [cloud.alert.AlertManagerImpl]
(CapacityChecker:null) recalculating system capacity
2014-10-14 19:03:41,122 DEBUG [cloud.alert.AlertManagerImpl]
(CapacityChecker:null) Executing cpu/ram capacity update
2014-10-14 19:03:41,130 DEBUG [cloud.vm.VirtualMachineManagerImpl]
(secstorage-1:null) Cleaning up resources for the vm
VM[SecondaryStorageVm|s-19-VM] in Starting state
2014-10-14 19:03:41,138 DEBUG [agent.transport.Request] (secstorage-1:null) Seq
1-1018036366: Sending { Cmd , MgmtId: 7204337877055, via: 1, Ver: v1, Flags:
100111,
[{"com.cloud.agent.api.StopCommand":{"isProxy":false,"executeInSequence":true,"vmName":"s-19-VM","wait":0}}]
}
2014-10-14 19:03:41,144 DEBUG [agent.transport.Request] (secstorage-1:null) Seq
1-1018036366: Executing: { Cmd , MgmtId: 7204337877055, via: 1, Ver: v1,
Flags: 100111,
[{"com.cloud.agent.api.StopCommand":{"isProxy":false,"executeInSequence":true,"vmName":"s-19-VM","wait":0}}]
}
2014-10-14 19:03:41,148 DEBUG [agent.manager.DirectAgentAttache]
(DirectAgent-32:null) Seq 1-1018036366: Executing request
2014-10-14 19:03:41,149 INFO [vmware.resource.VmwareResource]
(DirectAgent-32:10.147.40.7, cmd: StopCommand) Executing resource StopCommand:
{"isProxy":false,"executeInSequence":true,"vmName":"s-19-VM","wait":0}
2014-10-14 19:03:41,164 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl]
(HostReservationReleaseChecker:null) Cannot release reservation, Found 2 VMs
Running on host 1
2014-10-14 19:03:41,164 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl]
(HostReservationReleaseChecker:null) Done running HostReservationReleaseChecker
...
2014-10-14 19:03:41,166 DEBUG [cloud.capacity.CapacityManagerImpl]
(CapacityChecker:null) Found 2 VMs on host 1
> unable to copy vmware routing template to primary storage
> ---------------------------------------------------------
>
> Key: CLOUDSTACK-5883
> URL: https://issues.apache.org/jira/browse/CLOUDSTACK-5883
> Project: CloudStack
> Issue Type: Bug
> Security Level: Public(Anyone can view this level - this is the
> default.)
> Components: Management Server
> Affects Versions: 4.3.0
> Environment: CloudStack
> branch 4.3, 9ed4ab731fc5d722e3e0b819958ec8a2f4beccdb
> vCenter vApp: vSphere 5.1
> Hypervisor: VMware ESXi, 5.1.0, 799733
> Reporter: Hugo Trippaers
> Assignee: Hugo Trippaers
> Fix For: 4.4.0
>
>
> The following error is observed while doing a clean installation:
> 2014-01-16 10:22:00,521 ERROR [c.c.s.r.VmwareStorageProcessor]
> (DirectAgent-6:ctx-a6667180 10.200.23.49) Unable to copy templa
> te to primary storage due to exception:Exception:
> javax.xml.ws.soap.SOAPFaultException
> Message:
> Required parameter spec is missing
> while parsing call information for method ImportVApp
> at line 1, column 110
> while parsing SOAP body
> at line 1, column 102
> while parsing SOAP envelope
> at line 1, column 38
> while parsing HTTP request for method importVApp
> on object of type vim.ResourcePool
> at line 1, column 0
> javax.xml.ws.soap.SOAPFaultException:
> Required parameter spec is missing
> while parsing call information for method ImportVApp
> at line 1, column 110
> while parsing SOAP body
> at line 1, column 102
> while parsing SOAP envelope
> at line 1, column 38
> while parsing HTTP request for method importVApp
> on object of type vim.ResourcePool
> at line 1, column 0
> at
> com.sun.xml.internal.ws.fault.SOAP11Fault.getProtocolException(SOAP11Fault.java:178)
> at
> com.sun.xml.internal.ws.fault.SOAPFaultBuilder.createException(SOAPFaultBuilder.java:119)
> at
> com.sun.xml.internal.ws.client.sei.SyncMethodHandler.invoke(SyncMethodHandler.java:108)
>
--
This message was sent by Atlassian JIRA
(v6.3.4#6332)
