You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@cloudstack.apache.org by "Sanjeev N (JIRA)" <ji...@apache.org> on 2013/07/26 13:41:48 UTC
[jira] [Created] (CLOUDSTACK-3852) [Object_Store_Refactor] [VMWare]
Not able to download volume
Sanjeev N created CLOUDSTACK-3852:
-------------------------------------
Summary: [Object_Store_Refactor] [VMWare] Not able to download volume
Key: CLOUDSTACK-3852
URL: https://issues.apache.org/jira/browse/CLOUDSTACK-3852
Project: CloudStack
Issue Type: Bug
Security Level: Public (Anyone can view this level - this is the default.)
Components: Storage Controller, VMware, Volumes
Affects Versions: 4.2.0
Environment: Latest build from ACS 4.2 branch
Storage: NFS for both primary and secondary
Cluster: VMWare
Reporter: Sanjeev N
Priority: Critical
Fix For: 4.2.0
[Object_Store_Refactor] [VMWare] Not able to download volume
Steps to Reproduce:
================
1.Bringup CS in advanced zone with vmware cluster
2.Deploy guest vm with default cent of template
3.Create a snapshot from the root disk of the vm
4.Create volume from the snapshot created above.
5.Extract the volume
Expected Result:
==============
Volume download should succeed
Actual Result:
===========
Volume download failed with error " You don't have permission to access /userdata/cd0c2345-2b62-437a-b853-49adb4584fb5.ova/ on this server."
Observations:
============
When extract volume was called , the volume was copied from primary to secondary and following is the entry in volume_store_ref:
mysql> select * from volume_store_ref\G;
*************************** 1. row ***************************
id: 1
store_id: 2
volume_id: 14
zone_id: 0
created: 2013-07-26 10:55:46
last_updated: NULL
job_id: NULL
download_pct: 0
size: 0
physical_size: 0
download_state: NULL
checksum: NULL
error_str: NULL
local_path: NULL
install_path: volumes/2/14/71166f2c-1708-4205-be35-41bfdd474381
url: NULL
download_url: https://10-147-48-4.realhostip.com/userdata/cd0c2345-2b62-437a-b853-49adb4584fb5.ova
state: Ready
destroyed: 0
update_count: 2
ref_cnt: 0
updated: 2013-07-26 11:02:45
1 row in set (0.00 sec)
ERROR:
No query specified
On SSVM I could see the softlink cd0c2345-2b62-437a-b853-49adb4584fb5.ova in /var/ww/html/userdata and it is pointing to /mnt/SecStorage/21ac712e-6690-39a2-9c7b-cc3d5108db5f/volumes/2/14/71166f2c-1708-4205-be35-41bfdd474381
But the problem is the above mount point is a directory and the actual volume is present inside that directory. Hence the download using the given url "https://10-147-48-4.realhostip.com/userdata/cd0c2345-2b62-437a-b853-49adb4584fb5.ova/" failing with error: You don't have permission to access /userdata/cd0c2345-2b62-437a-b853-49adb4584fb5.ova/ on this server" even though permissions were given to volumes directory.
Also I see the following exception in the log file:
=====================================
2013-07-26 07:02:45,250 DEBUG [agent.transport.Request] (Job-Executor-38:job-38 = [ 387a21dd-bd4d-42af-b6cc-7c169141f868 ]) Seq 2-1034027794: Sending { Cmd , MgmtId: 6615759585382, via: 2, Ver: v1, Flags: 100111, [{"com.cloud.agent.api.storage.CreateVolumeOVACommand":{"secUrl":"nfs://10.147.28.7/export/home/sanjeev/sec_esx_os","volPath":"volumes/2/14/71166f2c-1708-4205-be35-41bfdd474381","volName":"71166f2c-1708-4205-be35-41bfdd474381","pool":{"id":2,"uuid":"468ecd4b-14a6-3b7d-8991-c9dd7427b94a","host":"10.147.28.7","path":"/export/home/sanjeev/pri_esx_os","port":2049,"type":"NetworkFilesystem"},"wait":10800}}] }
2013-07-26 07:02:45,250 DEBUG [agent.transport.Request] (Job-Executor-38:job-38 = [ 387a21dd-bd4d-42af-b6cc-7c169141f868 ]) Seq 2-1034027794: Executing: { Cmd , MgmtId: 6615759585382, via: 2, Ver: v1, Flags: 100111, [{"com.cloud.agent.api.storage.CreateVolumeOVACommand":{"secUrl":"nfs://10.147.28.7/export/home/sanjeev/sec_esx_os","volPath":"volumes/2/14/71166f2c-1708-4205-be35-41bfdd474381","volName":"71166f2c-1708-4205-be35-41bfdd474381","pool":{"id":2,"uuid":"468ecd4b-14a6-3b7d-8991-c9dd7427b94a","host":"10.147.28.7","path":"/export/home/sanjeev/pri_esx_os","port":2049,"type":"NetworkFilesystem"},"wait":10800}}] }
2013-07-26 07:02:45,251 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-440:null) Seq 2-1034027794: Executing request
2013-07-26 07:02:45,252 INFO [vmware.resource.VmwareResource] (DirectAgent-440:10.147.40.13) Executing resource CreateVolumeOVACommand: {"secUrl":"nfs://10.147.28.7/export/home/sanjeev/sec_esx_os","volPath":"volumes/2/14/71166f2c-1708-4205-be35-41bfdd474381","volName":"71166f2c-1708-4205-be35-41bfdd474381","pool":{"id":2,"uuid":"468ecd4b-14a6-3b7d-8991-c9dd7427b94a","host":"10.147.28.7","path":"/export/home/sanjeev/pri_esx_os","port":2049,"type":"NetworkFilesystem"},"wait":10800}
2013-07-26 07:02:45,252 INFO [vmware.manager.VmwareStorageManagerImpl] (DirectAgent-440:10.147.40.13) volss: execute CreateVolumeOVA cmd at vmwareMngImpl.
2013-07-26 07:02:45,252 INFO [vmware.manager.VmwareStorageManagerImpl] (DirectAgent-440:10.147.40.13) volss: mountPoint: /var/cloudstack/mnt/VM/6615759585382.733bb9c1installPath:volumes/2/14/71166f2c-1708-4205-be35-41bfdd474381
2013-07-26 07:02:45,258 INFO [vmware.manager.VmwareStorageManagerImpl] (DirectAgent-440:10.147.40.13) volss: execute vmwareMgrImpl: VolName 71166f2c-1708-4205-be35-41bfdd474381
2013-07-26 07:02:45,259 INFO [vmware.manager.VmwareStorageManagerImpl] (DirectAgent-440:10.147.40.13) Fang: exportDir is (for VolumeOVA): /var/cloudstack/mnt/VM/6615759585382.733bb9c1/volumes/2/14
2013-07-26 07:02:45,259 INFO [vmware.manager.VmwareStorageManagerImpl] (DirectAgent-440:10.147.40.13) Sync file system before we package OVA...
2013-07-26 07:02:45,260 DEBUG [vmware.manager.VmwareStorageManagerImpl] (DirectAgent-440:10.147.40.13) Executing: sudo sync
2013-07-26 07:02:45,522 DEBUG [network.router.VirtualNetworkApplianceManagerImpl] (RouterStatusMonitor-1:null) Found 1 routers to update status.
2013-07-26 07:02:45,536 DEBUG [network.router.VirtualNetworkApplianceManagerImpl] (RouterStatusMonitor-1:null) Found 0 networks to update RvR status.
2013-07-26 07:02:45,692 DEBUG [vmware.manager.VmwareStorageManagerImpl] (DirectAgent-440:10.147.40.13) Execution is successful.
2013-07-26 07:02:45,693 INFO [vmware.manager.VmwareStorageManagerImpl] (DirectAgent-440:10.147.40.13) Package Volume OVA with commmand: tar -cf 71166f2c-1708-4205-be35-41bfdd474381.ova 71166f2c-1708-4205-be35-41bfdd474381.ovf 71166f2c-1708-4205-be35-41bfdd474381-disk0.vmdk
2013-07-26 07:02:45,693 DEBUG [vmware.manager.VmwareStorageManagerImpl] (DirectAgent-440:10.147.40.13) Executing: tar -cf 71166f2c-1708-4205-be35-41bfdd474381.ova 71166f2c-1708-4205-be35-41bfdd474381.ovf 71166f2c-1708-4205-be35-41bfdd474381-disk0.vmdk
2013-07-26 07:02:45,743 WARN [vmware.manager.VmwareStorageManagerImpl] (DirectAgent-440:10.147.40.13) Exception: tar -cf 71166f2c-1708-4205-be35-41bfdd474381.ova 71166f2c-1708-4205-be35-41bfdd474381.ovf 71166f2c-1708-4205-be35-41bfdd474381-disk0.vmdk
java.io.IOException: Cannot run program "tar" (in directory "/var/cloudstack/mnt/VM/6615759585382.733bb9c1/volumes/2/14"): java.io.IOException: error=13, Permission denied
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.VmwareStorageManagerImpl.execute(VmwareStorageManagerImpl.java:205)
at com.cloud.hypervisor.vmware.resource.VmwareResource.execute(VmwareResource.java:5263)
at com.cloud.hypervisor.vmware.resource.VmwareResource.executeRequest(VmwareResource.java:478)
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: java.io.IOException: error=13, Permission denied
at java.lang.UNIXProcess.<init>(UNIXProcess.java:164)
at java.lang.ProcessImpl.start(ProcessImpl.java:81)
at java.lang.ProcessBuilder.start(ProcessBuilder.java:468)
... 14 more
--
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