[
https://issues.apache.org/jira/browse/CLOUDSTACK-2064?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=14263817#comment-14263817
]
ChunFeng commented on CLOUDSTACK-2064:
--------------------------------------
I meet this issue again in : cloudstack 4.4.2 with esxi 5.5
LOG================================BEGIN
[c.c.v.VirtualMachineManagerImpl] (secstorage-1:ctx-9a812bb7) Cleaning up
hypervisor data structures (ex. SRs in XenServer) for managed storage
[o.a.c.e.o.VolumeOrchestrator] (secstorage-1:ctx-9a812bb7) Cleaning storage for
vm: 25
[o.a.c.s.v.VolumeServiceImpl] (secstorage-1:ctx-9a812bb7) Marking volume that
was never created as destroyed: Vol[25|vm=25|ROOT]
[c.c.v.VirtualMachineManagerImpl] (secstorage-1:ctx-9a812bb7) Expunged
VM[SecondaryStorageVm|s-25-VM]
[o.a.c.s.PremiumSecondaryStorageManagerImpl] (secstorage-1:ctx-9a812bb7)
Primary secondary storage is not even started, wait until next turn
[c.c.h.v.m.HypervisorHostHelper] (DirectAgent-444:ctx-c93d903d 10.8.1.9)
Resolving host name in url through vCenter, url:
https://10.8.1.9/nfc/52a13bd0-724d-333d-4198-6c94afcaefb0/disk-0.vmdk
[c.c.h.v.m.HypervisorHostHelper] (DirectAgent-444:ctx-c93d903d 10.8.1.9) host
name in url is already in IP address, url:
https://10.8.1.9/nfc/52a13bd0-724d-333d-4198-6c94afcaefb0/disk-0.vmdk
[c.c.h.v.u.VmwareContext] (DirectAgent-444:ctx-c93d903d 10.8.1.9) Connected,
conn:
sun.net.www.protocol.https.DelegateHttpsURLConnection:https://10.8.1.9/nfc/52a13bd0-724d-333d-4198-6c94afcaefb0/disk-0.vmdk,
retry: 0
[c.c.h.v.m.HypervisorHostHelper] (DirectAgent-444:ctx-c93d903d 10.8.1.9) File
upload task failed to complete due to:
/var/cloudstack/mnt/VM/345049821065.1519e0f5/template/tmpl/1/8/systemvm64template-2014-11-04-4.3.1-vmware-disk3.vmdk
(Permission denied)
[c.c.h.v.m.HttpNfcLeaseMO] (DirectAgent-444:ctx-c93d903d 10.8.1.9) close
ProgressReporter, interrupt reporter runner to let it quit
[c.c.h.v.m.HypervisorHostHelper] (DirectAgent-444:ctx-c93d903d 10.8.1.9)
Aborting the lease on 67a86af50af83c9189a4426062a79bfb after import operation
failed.
[c.c.h.v.m.HttpNfcLeaseMO] (Thread-114:null) ProgressReporter is interrupted,
quiting
[c.c.h.v.m.HttpNfcLeaseMO] (Thread-114:null) ProgressReporter stopped
[c.c.s.r.VmwareStorageProcessor] (DirectAgent-444:ctx-c93d903d 10.8.1.9) Unable
to copy template to primary storage due to exception:Exception:
java.lang.Exception
Message: File upload task failed to complete due to:
/var/cloudstack/mnt/VM/345049821065.1519e0f5/template/tmpl/1/8/systemvm64template-2014-11-04-4.3.1-vmware-disk3.vmdk
(Permission denied)
java.lang.Exception: File upload task failed to complete due to:
/var/cloudstack/mnt/VM/345049821065.1519e0f5/template/tmpl/1/8/systemvm64template-2014-11-04-4.3.1-vmware-disk3.vmdk
(Permission denied)
at
com.cloud.hypervisor.vmware.mo.HypervisorHostHelper.importVmFromOVF(HypervisorHostHelper.java:1357)
at
com.cloud.hypervisor.vmware.mo.HostMO.importVmFromOVF(HostMO.java:732)
at
com.cloud.storage.resource.VmwareStorageProcessor.copyTemplateFromSecondaryToPrimary(VmwareStorageProcessor.java:178)
at
com.cloud.storage.resource.VmwareStorageProcessor.copyTemplateToPrimaryStorage(VmwareStorageProcessor.java:317)
at
com.cloud.storage.resource.StorageSubsystemCommandHandlerBase.execute(StorageSubsystemCommandHandlerBase.java:77)
at
com.cloud.storage.resource.VmwareStorageSubsystemCommandHandler.execute(VmwareStorageSubsystemCommandHandler.java:168)
at
com.cloud.storage.resource.StorageSubsystemCommandHandlerBase.handleStorageCommands(StorageSubsystemCommandHandlerBase.java:52)
at
com.cloud.hypervisor.vmware.resource.VmwareResource.executeRequest(VmwareResource.java:468)
at
com.cloud.agent.manager.DirectAgentAttache$Task.runInContext(DirectAgentAttache.java:307)
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.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:1145)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:745)
[c.c.a.m.DirectAgentAttache] (DirectAgent-444:ctx-c93d903d) Seq
2-393220542464786653: Response Received:
[c.c.a.t.Request] (DirectAgent-444:ctx-c93d903d) Seq 2-393220542464786653:
Processing: { Ans: , MgmtId: 345049821065, via: 2, Ver: v1, Flags: 10,
[{"org.apache.cloudstack.storage.command.CopyCmdAnswer":{"result":false,"details":"Unable
to copy template to primary storage due to exception:Exception:
java.lang.Exception\nMessage: File upload task failed to complete due to:
/var/cloudstack/mnt/VM/345049821065.1519e0f5/template/tmpl/1/8/systemvm64template-2014-11-04-4.3.1-vmware-disk3.vmdk
(Permission denied)\n","wait":0}}] }
[c.c.a.t.Request] (Work-Job-Executor-118:ctx-dbf7f348 job-1/job-166
ctx-d1f83a55) Seq 2-393220542464786653: Received: { Ans: , MgmtId:
345049821065, via: 2, Ver: v1, Flags: 10, { CopyCmdAnswer } }
[o.a.c.s.v.VolumeServiceImpl] (Work-Job-Executor-118:ctx-dbf7f348 job-1/job-166
ctx-d1f83a55) releasing lock for VMTemplateStoragePool 107
[c.c.u.d.Merovingian2] (Work-Job-Executor-118:ctx-dbf7f348 job-1/job-166
ctx-d1f83a55) Was unable to find lock for the key template_spool_ref107 and
thread id 604108968
[o.a.c.e.o.VolumeOrchestrator] (Work-Job-Executor-118:ctx-dbf7f348
job-1/job-166 ctx-d1f83a55) Unable to create Vol[1|vm=1|ROOT]:Unable to copy
template to primary storage due to exception:Exception: java.lang.Exception
Message: File upload task failed to complete due to:
/var/cloudstack/mnt/VM/345049821065.1519e0f5/template/tmpl/1/8/systemvm64template-2014-11-04-4.3.1-vmware-disk3.vmdk
(Permission denied)
2015-01-04 17:25:24,161 INFO [c.c.v.VirtualMachineManagerImpl]
(Work-Job-Executor-118:ctx-dbf7f348 job-1/job-166 ctx-d1f83a55) Unable to
contact resource.
com.cloud.exception.StorageUnavailableException: Resource [StoragePool:1] is
unreachable: Unable to create Vol[1|vm=1|ROOT]:Unable to copy template to
primary storage due to exception:Exception: java.lang.Exception
Message: File upload task failed to complete due to:
/var/cloudstack/mnt/VM/345049821065.1519e0f5/template/tmpl/1/8/systemvm64template-2014-11-04-4.3.1-vmware-disk3.vmdk
(Permission denied)
at
org.apache.cloudstack.engine.orchestration.VolumeOrchestrator.recreateVolume(VolumeOrchestrator.java:1205)
at
org.apache.cloudstack.engine.orchestration.VolumeOrchestrator.prepare(VolumeOrchestrator.java:1257)
at
com.cloud.vm.VirtualMachineManagerImpl.orchestrateStart(VirtualMachineManagerImpl.java:988)
at
com.cloud.vm.VirtualMachineManagerImpl.orchestrateStart(VirtualMachineManagerImpl.java:5195)
at sun.reflect.GeneratedMethodAccessor258.invoke(Unknown Source)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at
com.cloud.vm.VmWorkJobHandlerProxy.handleVmWorkJob(VmWorkJobHandlerProxy.java:107)
at
com.cloud.vm.VirtualMachineManagerImpl.handleVmWorkJob(VirtualMachineManagerImpl.java:5340)
at com.cloud.vm.VmWorkJobDispatcher.runJob(VmWorkJobDispatcher.java:102)
at
org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.runInContext(AsyncJobManagerImpl.java:503)
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
org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.run(AsyncJobManagerImpl.java:460)
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:745)
[c.c.v.VirtualMachineManagerImpl] (Work-Job-Executor-118:ctx-dbf7f348
job-1/job-166 ctx-d1f83a55) Cleaning up resources for the vm
VM[ConsoleProxy|v-1-VM] in Starting state
[c.c.a.t.Request] (Work-Job-Executor-118:ctx-dbf7f348 job-1/job-166
ctx-d1f83a55) Seq 1-4396920611197157602: Sending { Cmd , MgmtId: 345049821065,
via: 1(10.8.1.10), Ver: v1, Flags: 100011,
[{"com.cloud.agent.api.StopCommand":{"isProxy":false,"executeInSequence":false,"checkBeforeCleanup":false,"vmName":"v-1-VM","wait":0}}]
}
[c.c.a.t.Request] (Work-Job-Executor-118:ctx-dbf7f348 job-1/job-166
ctx-d1f83a55) Seq 1-4396920611197157602: Executing: { Cmd , MgmtId:
345049821065, via: 1(10.8.1.10), Ver: v1, Flags: 100011,
[{"com.cloud.agent.api.StopCommand":{"isProxy":false,"executeInSequence":false,"checkBeforeCleanup":false,"vmName":"v-1-VM","wait":0}}]
}
[c.c.a.m.DirectAgentAttache] (DirectAgent-446:ctx-84e3e5d5) Seq
1-4396920611197157602: Executing request
[c.c.h.v.r.VmwareResource] (DirectAgent-446:ctx-84e3e5d5 10.8.1.10) Executing
resource StopCommand:
{"isProxy":false,"executeInSequence":false,"checkBeforeCleanup":false,"vmName":"v-1-VM","wait":0}
[c.c.h.v.m.HostMO] (DirectAgent-446:ctx-84e3e5d5 10.8.1.10) find VM v-1-VM on
host
[c.c.h.v.m.HostMO] (DirectAgent-446:ctx-84e3e5d5 10.8.1.10) VM v-1-VM not
found in host cache
[c.c.h.v.m.HostMO] (DirectAgent-446:ctx-84e3e5d5 10.8.1.10) load VM cache on
host
[c.c.h.v.r.VmwareResource] (DirectAgent-446:ctx-84e3e5d5 10.8.1.10) VM v-1-VM
is no longer in vSphere
[c.c.a.m.DirectAgentAttache] (DirectAgent-446:ctx-84e3e5d5) Seq
1-4396920611197157602: Response Received:
[c.c.a.t.Request] (DirectAgent-446:ctx-84e3e5d5) Seq 1-4396920611197157602:
Processing: { Ans: , MgmtId: 345049821065, via: 1, Ver: v1, Flags: 10,
[{"com.cloud.agent.api.StopAnswer":{"result":true,"details":"VM v-1-VM is no
longer in vSphere","wait":0}}] }
LOG================================END
> The Vmware template dosent have permissions to be copied from secondary
> storage.
> --------------------------------------------------------------------------------
>
> Key: CLOUDSTACK-2064
> URL: https://issues.apache.org/jira/browse/CLOUDSTACK-2064
> Project: CloudStack
> Issue Type: Bug
> Security Level: Public(Anyone can view this level - this is the
> default.)
> Components: Install and Setup
> Affects Versions: 4.1.0, 4.2.0
> Reporter: Kiran Koneti
> Assignee: Hugo Trippaers
> Priority: Critical
> Fix For: 4.1.0, 4.2.0
>
>
> 0When the VMware template is seeded to the secondary storage and while trying
> to create the system Vm's there is a error message saying no permission to
> tar the routing-8.ova
> The error message is as below.
> "2013-04-17 11:33:18,074 ERROR [vmware.manager.VmwareStorageManagerImpl]
> (DirectAgent-4:10.102.192.18) Unable to execute PrimaryStorageDownloadCommand
> due to exception
> java.io.FileNotFoundException:
> /var/cloudstack/mnt/VM/222273143235720.4a5f0cef/template/tmpl/1/8/systemvmtemplate-2013-04-15-master-vmware.ovf
> (Permission denied)
>
> [root@rhel63 management]# ll /var/cloudstack/mnt/VM/
> total 20
> drwxrwxrwx. 2 cloud cloud 4096 Apr 17 10:34 222273143235720.154199bd
> drwxrwxrwx. 5 root bin 4096 Apr 17 11:35 222273143235720.4a5f0cef
> drwxrwxrwx. 2 cloud cloud 4096 Apr 16 11:29 222273143235720.4c8848c4
> drwxrwxrwx. 2 cloud cloud 4096 Apr 16 11:54 222273143235720.525f3d5f
> drwxrwxrwx. 2 cloud cloud 4096 Apr 17 10:44 222273143235720.526d73ac
> [root@rhel63 management]# ll /var/cloudstack/mnt/VM/222273143235720.4a5f0cef/
> drwxrwxr-x. 2 cloud cloud 4096 Apr 17 11:35 systemvm
> drwxr-xr-x. 3 root root 4096 Apr 17 09:41 template
> [root@rhel63 management]# ll
> /var/cloudstack/mnt/VM/222273143235720.4a5f0cef/template/
> drwxr-xr-x. 3 root root 4096 Apr 17 09:41 tmpl
> -rw-r--r--. 1 root root 260070912 Apr 17 09:56
> 56058ae3-12ea-4bbc-838c-f2e25ceba314.ova
> -rw-------. 1 root root 260057600 Apr 16 09:49
> systemvmtemplate-2013-04-15-master-vmware-disk1.vmdk
> -rw-------. 1 root root 12178 Apr 16 09:49
> systemvmtemplate-2013-04-15-master-vmware.ovf
> -rw-r--r--. 1 root root 283 Apr 17 10:00 template.properties"
> There is a workaround for the same.
> After seeding the template if we change the permissions of the template in
> the secondary storage (i.e give read/write permission) then the template is
> seeded properly.
--
This message was sent by Atlassian JIRA
(v6.3.4#6332)
