[Users] ovirt VM start fails - Perm Denied error

Mon Feb 13 16:21:00 UTC 2012

On 02/12/2012 10:28 AM, Deepak C Shetty wrote:
> Hi,
>    I have tried this multiple times and i hit the same error.
> 
> I have 3 storage domains  created (iso, data and export) all connected
> to the DC with DC status as Up and
> 1 host with status as Up and the same (only) host acting as SPM.
> 
> I used the engine-iso-uploader utility to upload my .iso to the iso domain.
> Created a new VM and attached a vdisk of type sparse (thin-prov) and
> click on "Run Once",
> where i select "Attach CD" and select my .iso, and change boot order to
> boot from CD, then disk.
> 
> But i get this error...
> 
> VM first-ovirt-vm is down. Exit message internal error process exited
> while connecting to monitor: qemu-kvm: -drive
> file=/rhev/data-center/4087fea7-b54a-4318-8d5c-828eff8846f4/35f880f8-bd0c-4063-b171-2ddaa59e1212/images/11111111-1111-1111-1111-111111111111/Fedora-16-x86_64-DVD.iso,if=none,media=cdrom,id=drive-ide0-1-0,readonly=on,format=raw:
> could not open disk image
> /rhev/data-center/4087fea7-b54a-4318-8d5c-828eff8846f4/35f880f8-bd0c-4063-b171-2ddaa59e1212/images/11111111-1111-1111-1111-111111111111/Fedora-16-x86_64-DVD.iso:
> Permission denied .

I hit this same issue last week, on an ovirt-engine that I'd updated
from nightly to stable. In order to get around the issue, I completely
uninstalled ovirt and removed the /rhev/datacenter directory, which
wasn't removed automatically when I uninstalled ovirt. Once I did that,
I was able to proceed normally.

Jason

> 
> I am unable to figure out why.. bcos the user.group perms for the .iso
> are fine.
> In fact i logged into the system serving the nfs share and added 0777 perms
> still i get the same error. Here is the snip of how the perms for .iso
> look like...
> 
> ll
> /tmp/iso1-domain/35f880f8-bd0c-4063-b171-2ddaa59e1212/images/11111111-1111-1111-1111-111111111111/Fedora-16-x86_64-DVD.iso
> 
> -rwxr-xr-x. 1 vdsm kvm 3757047808 Feb 13 04:24
> /tmp/iso1-domain/35f880f8-bd0c-4063-b171-2ddaa59e1212/images/11111111-1111-1111-1111-111111111111/Fedora-16-x86_64-DVD.iso
> 
> 
> Here are some of the imp. logs from the engine.log... note that i tried
> multiple times, so there are multiple
> entries of ERRORs for each of those tries...
> 
> 2012-02-13 05:10:04,563 INFO 
> [org.ovirt.engine.core.vdsbroker.UpdateVdsDynamicDataVDSCommand]
> (pool-5-thread-47) FINISH, UpdateVdsDynamicDataVDSCommand, log id: 549dfc2f
> 2012-02-13 05:10:04,612 INFO 
> [org.ovirt.engine.core.bll.RunVmOnceCommand] (pool-5-thread-47) Running
> command: RunVmOnceCommand internal: false. Entities affected :  ID:
> c587bc8e-f800-4ce4-a35e-1dd43480cb58 Type: VM
> 2012-02-13 05:10:04,617 ERROR [org.ovirt.engine.core.bll.RunVmCommand]
> (pool-5-thread-47) Cant find VDS to run the VM
> c587bc8e-f800-4ce4-a35e-1dd43480cb58 on, so this VM will not be run.
> 2012-02-13 05:10:04,622 ERROR
> [org.ovirt.engine.core.bll.RunVmOnceCommand] (pool-5-thread-47)
> Transaction rolled-back for command:
> org.ovirt.engine.core.bll.RunVmOnceCommand.
> 2012-02-13 05:11:25,735 INFO 
> [org.ovirt.engine.core.bll.DbUserCacheManager]
> (QuartzScheduler_Worker-10) DbUserCacheManager::refreshAllUserData() -
> entered
> 2012-02-13 05:11:52,648 WARN 
> [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
> (http--0.0.0.0-8080-1) calling GetConfigurationValueQuery with null
> version, using default general for version
> 2012-02-13 05:11:52,791 WARN 
> [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
> (http--0.0.0.0-8080-2) calling GetConfigurationValueQuery with null
> version, using default general for version
> 2012-02-13 05:11:55,828 WARN 
> [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
> (http--0.0.0.0-8080-8) calling GetConfigurationValueQuery with null
> version, using default general for version
> 2012-02-13 05:11:56,917 WARN 
> [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
> (http--0.0.0.0-8080-2) calling GetConfigurationValueQuery with null
> version, using default general for version
> 2012-02-13 05:12:11,611 INFO 
> [org.ovirt.engine.core.bll.UpdateVmCommand] (http--0.0.0.0-8080-10)
> Running command: UpdateVmCommand internal: false. Entities affected : 
> ID: c587bc8e-f800-4ce4-a35e-1dd43480cb58 Type: VM
> 2012-02-13 05:12:11,617 INFO 
> [org.ovirt.engine.core.vdsbroker.irsbroker.IsValidVDSCommand]
> (http--0.0.0.0-8080-10) START, IsValidVDSCommand(storagePoolId =
> 4087fea7-b54a-4318-8d5c-828eff8846f4, ignoreFailoverLimit = false,
> compatabilityVersion = null), log id: 247cacfc
> 2012-02-13 05:12:11,619 INFO 
> [org.ovirt.engine.core.vdsbroker.irsbroker.IsValidVDSCommand]
> (http--0.0.0.0-8080-10) FINISH, IsValidVDSCommand, return: true, log id:
> 247cacfc
> 2012-02-13 05:12:11,632 INFO 
> [org.ovirt.engine.core.vdsbroker.irsbroker.UpdateVMVDSCommand]
> (http--0.0.0.0-8080-10) START, UpdateVMVDSCommand(storagePoolId =
> 4087fea7-b54a-4318-8d5c-828eff8846f4, ignoreFailoverLimit = false,
> compatabilityVersion = null, storageDomainId =
> 00000000-0000-0000-0000-000000000000, infoDictionary.size = 1), log id:
> 1294a3c3
> 2012-02-13 05:12:11,904 INFO 
> [org.ovirt.engine.core.vdsbroker.irsbroker.UpdateVMVDSCommand]
> (http--0.0.0.0-8080-10) FINISH, UpdateVMVDSCommand, log id: 1294a3c3
> 2012-02-13 05:12:23,502 INFO 
> [org.ovirt.engine.core.vdsbroker.irsbroker.IsoPrefixVDSCommand]
> (http--0.0.0.0-8080-1) START, IsoPrefixVDSCommand(storagePoolId =
> 4087fea7-b54a-4318-8d5c-828eff8846f4, ignoreFailoverLimit = false,
> compatabilityVersion = null), log id: 201b9bfd
> 2012-02-13 05:12:23,502 INFO 
> [org.ovirt.engine.core.vdsbroker.irsbroker.IsoPrefixVDSCommand]
> (http--0.0.0.0-8080-1) FINISH, IsoPrefixVDSCommand, return:
> /rhev/data-center/4087fea7-b54a-4318-8d5c-828eff8846f4/35f880f8-bd0c-4063-b171-2ddaa59e1212/images/11111111-1111-1111-1111-111111111111,
> log id: 201b9bfd
> 2012-02-13 05:12:23,567 INFO 
> [org.ovirt.engine.core.bll.RunVmOnceCommand] (http--0.0.0.0-8080-1)
> Running command: RunVmOnceCommand internal: false. Entities affected : 
> ID: c587bc8e-f800-4ce4-a35e-1dd43480cb58 Type: VM
> 2012-02-13 05:12:23,586 INFO 
> [org.ovirt.engine.core.vdsbroker.CreateVmVDSCommand]
> (http--0.0.0.0-8080-1) START, CreateVmVDSCommand(vdsId =
> c6ff0cd0-55b5-11e1-ac57-00145e3f27e8,
> vmId=c587bc8e-f800-4ce4-a35e-1dd43480cb58,
> vm=org.ovirt.engine.core.common.businessentities.VM at 2d5e24e9), log id:
> 25e637df
> 2012-02-13 05:12:23,594 INFO 
> [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand]
> (http--0.0.0.0-8080-1) START, CreateVDSCommand(vdsId =
> c6ff0cd0-55b5-11e1-ac57-00145e3f27e8,
> vmId=c587bc8e-f800-4ce4-a35e-1dd43480cb58,
> vm=org.ovirt.engine.core.common.businessentities.VM at 2d5e24e9), log id:
> 3bee3ef3
> 2012-02-13 05:12:23,756 INFO 
> [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand]
> (http--0.0.0.0-8080-1)
> org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand
> spiceSslCipherSuite=DEFAULT,memSize=512,kvmEnable=true,boot=dc,smp=1,vmType=kvm,emulatedMachine=pc-0.14,keyboardLayout=en-us,nice=0,display=qxl,smpCoresPerSocket=1,spiceSecureChannels=smain,sinputs,spiceMonitors=1,cdrom=/rhev/data-center/4087fea7-b54a-4318-8d5c-828eff8846f4/35f880f8-bd0c-4063-b171-2ddaa59e1212/images/11111111-1111-1111-1111-111111111111/Fedora-16-x86_64-DVD.iso,timeOffset=0,transparentHugePages=true,drives=[Ljava.util.Map;@426264c4,vmId=c587bc8e-f800-4ce4-a35e-1dd43480cb58,acpiEnable=true,vmName=first-ovirt-vm,cpuType=Opteron_G1,custom={}
> 
> 2012-02-13 05:12:23,756 INFO 
> [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand]
> (http--0.0.0.0-8080-1) FINISH, CreateVDSCommand, log id: 3bee3ef3
> 2012-02-13 05:12:23,760 INFO 
> [org.ovirt.engine.core.vdsbroker.CreateVmVDSCommand]
> (http--0.0.0.0-8080-1) IncreasePendingVms::CreateVmIncreasing vds
> llm56.in.ibm.com pending vcpu count, now 1. Vm: first-ovirt-vm
> 2012-02-13 05:12:23,764 INFO 
> [org.ovirt.engine.core.vdsbroker.CreateVmVDSCommand]
> (http--0.0.0.0-8080-1) FINISH, CreateVmVDSCommand, return:
> WaitForLaunch, log id: 25e637df
> 2012-02-13 05:12:26,522 INFO 
> [org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand]
> (QuartzScheduler_Worker-52) START, DestroyVDSCommand(vdsId =
> c6ff0cd0-55b5-11e1-ac57-00145e3f27e8,
> vmId=c587bc8e-f800-4ce4-a35e-1dd43480cb58, force=false, secondsToWait=0,
> gracefully=false), log id: 1091a515
> 2012-02-13 05:12:26,707 INFO 
> [org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand]
> (QuartzScheduler_Worker-52) FINISH, DestroyVDSCommand, log id: 1091a515
> 2012-02-13 05:12:26,724 INFO 
> [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo]
> (QuartzScheduler_Worker-52) Running on vds during rerun failed vm: null
> 2012-02-13 05:12:26,729 INFO 
> [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo]
> (QuartzScheduler_Worker-52) vm first-ovirt-vm running in db and not
> running in vds - add to rerun treatment. vds llm56.in.ibm.com
> 2012-02-13 05:12:26,741 ERROR
> [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo]
> (QuartzScheduler_Worker-52) Rerun vm
> c587bc8e-f800-4ce4-a35e-1dd43480cb58. Called from vds llm56.in.ibm.com
> 2012-02-13 05:12:26,745 INFO 
> [org.ovirt.engine.core.vdsbroker.UpdateVdsDynamicDataVDSCommand]
> (pool-5-thread-47) START, UpdateVdsDynamicDataVDSCommand(vdsId =
> c6ff0cd0-55b5-11e1-ac57-00145e3f27e8,
> vdsDynamic=org.ovirt.engine.core.common.businessentities.VdsDynamic at 7ac864a5),
> log id: 137ee32a
> 2012-02-13 05:12:26,748 INFO 
> [org.ovirt.engine.core.vdsbroker.UpdateVdsDynamicDataVDSCommand]
> (pool-5-thread-47) FINISH, UpdateVdsDynamicDataVDSCommand, log id: 137ee32a
> 2012-02-13 05:12:26,795 INFO 
> [org.ovirt.engine.core.bll.RunVmOnceCommand] (pool-5-thread-47) Running
> command: RunVmOnceCommand internal: false. Entities affected :  ID:
> c587bc8e-f800-4ce4-a35e-1dd43480cb58 Type: VM
> 2012-02-13 05:12:26,800 ERROR [org.ovirt.engine.core.bll.RunVmCommand]
> (pool-5-thread-47) Cant find VDS to run the VM
> c587bc8e-f800-4ce4-a35e-1dd43480cb58 on, so this VM will not be run.
> 2012-02-13 05:12:26,805 ERROR
> [org.ovirt.engine.core.bll.RunVmOnceCommand] (pool-5-thread-47)
> Transaction rolled-back for command:
> org.ovirt.engine.core.bll.RunVmOnceCommand.
> 
> 
> Appreciate any help provided.
> 
> thanx,
> deepak
> 
> 
> 
> 
> _______________________________________________
> Users mailing list
> Users at ovirt.org
> http://lists.ovirt.org/mailman/listinfo/users