[ https://issues.apache.org/jira/browse/CLOUDSTACK-4768?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel ]
Rayees Namathponnan updated CLOUDSTACK-4768: -------------------------------------------- Attachment: Sep_30_KVM_Adv_Zone.rar > [Automation] Race condition; delete the template and create VM at same time; > deployment failed with libvirt error > ------------------------------------------------------------------------------------------------------------------ > > Key: CLOUDSTACK-4768 > URL: https://issues.apache.org/jira/browse/CLOUDSTACK-4768 > Project: CloudStack > Issue Type: Bug > Security Level: Public(Anyone can view this level - this is the > default.) > Components: KVM > Affects Versions: 4.2.1 > Environment: KVM (RHEL 6.3) > branch - 4.2-forward > Reporter: Rayees Namathponnan > Assignee: edison su > Fix For: 4.2.1 > > Attachments: Sep_30_KVM_Adv_Zone.rar > > > This issue observed during regression automation run, few vm deployment > failed due to some race condition; this issue observed while template delete > and deploy vm command issued at same time > Observed below error in MS log; attached full logs with this defect > 2013-09-27 19:39:36,490 DEBUG [agent.manager.AgentManagerImpl] > (AgentManager-Handler-4:null) Ping from 9 > 2013-09-27 19:39:36,678 DEBUG [agent.transport.Request] > (AgentManager-Handler-10:null) Seq 2-1251542761: Processing: { Ans: , > MgmtId: 29066118877352, via: 2, Ver: v1, Flags: > 110, > [{"com.cloud.agent.api.StartAnswer":{"vm":{"id":247,"name":"i-192-247-QA","type":"User","cpus":1,"minSpeed":100,"maxSpeed":100,"minRam":134217728,"maxRam":134217728,"arch > ":"x86_64","os":"CentOS 5.5 > (64-bit)","bootArgs":"","rebootOnCrash":false,"enableHA":false,"limitCpuUse":false,"enableDynamicallyScaleVm":false,"vncPassword":"992293216169b56" > ,"vncAddr":"10.223.50.67","params":{"Message.ReservedCapacityFreed.Flag":"false"},"uuid":"590048c7-682c-4dd5-be5e-b0ea9203d181","disks":[{"data":{"org.apache.cloudstack.storag > e.to.VolumeObjectTO":{"uuid":"a7b372d9-8cb4-4549-9ce1-6b4b2b249472","volumeType":"ROOT","dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"41b632b5-40 > b3-3024-a38b-ea259c72579f","id":2,"poolType":"NetworkFilesystem","host":"10.223.110.232","path":"/export/home/rayees/SC_QA_AUTO4/primary2","port":2049}},"name":"ROOT-247","siz > e":8589934592,"path":"35083f24-8882-4754-b29f-6ce8025df305","volumeId":271,"vmName":"i-192-247-QA","accountId":192,"format":"QCOW2","id":271,"hypervisorType":"KVM"}},"diskSeq" > :0,"type":"ROOT"},{"data":{"org.apache.cloudstack.storage.to.TemplateObjectTO":{"id":0,"format":"ISO","accountId":0,"hvm":false}},"diskSeq":3,"type":"ISO"}],"nics":[{"deviceId > ":0,"networkRateMbps":200,"defaultNic":true,"uuid":"b10db69f-b7f6-419f-872a-feaa31cab581","ip":"10.1.1.221","netmask":"255.255.255.0","gateway":"10.1.1.1","mac":"02:00:5a:16:0 > 0:02","dns1":"8.8.8.8","broadcastType":"Vlan","type":"Guest","broadcastUri":"vlan://2340","isolationUri":"vlan://2340","isSecurityGroupEnabled":false}]},"result":false,"detail > s":"unable to set user and group to '0:0' on > '/mnt/41b632b5-40b3-3024-a38b-ea259c72579f/ddeac719-b362-4462-b905-6b07578108de': > No such file or directory","wait":0}}] } > 2013-09-27 19:39:36,679 DEBUG [agent.manager.AgentAttache] > (AgentManager-Handler-10:null) Seq 2-1251542761: No more commands found > 2013-09-27 19:39:36,679 DEBUG [agent.transport.Request] > (Job-Executor-139:job-1077 = [ f7164e6a-544f-4c8d-8dc6-45d74ace2094 ]) Seq > 2-1251542761: Received: { Ans: , MgmtId: 29 > 066118877352, via: 2, Ver: v1, Flags: 110, { StartAnswer } } > 2013-09-27 19:39:36,683 INFO [cloud.vm.VirtualMachineManagerImpl] > (Job-Executor-139:job-1077 = [ f7164e6a-544f-4c8d-8dc6-45d74ace2094 ]) Unable > to start VM on Host[-2-Routing > ] due to unable to set user and group to '0:0' on > '/mnt/41b632b5-40b3-3024-a38b-ea259c72579f/ddeac719-b362-4462-b905-6b07578108de': > No such file or directory > 2013-09-27 19:39:36,686 DEBUG [cloud.vm.VirtualMachineManagerImpl] > (Job-Executor-139:job-1077 = [ f7164e6a-544f-4c8d-8dc6-45d74ace2094 ]) > Cleaning up resources for the vm VM[U > ser|590048c7-682c-4dd5-be5e-b0ea9203d181] in Starting state > 2013-09-27 19:39:36,687 DEBUG [agent.transport.Request] > (Job-Executor-139:job-1077 = [ f7164e6a-544f-4c8d-8dc6-45d74ace2094 ]) Seq > 2-1251542762: Sending { Cmd , MgmtId: 29066 > 118877352, via: 2, Ver: v1, Flags: 100111, > [{"com.cloud.agent.api.StopCommand":{"isProxy":false,"executeInSequence":true,"vmName":"i-192-247-QA","wait":0}}] > } > 2013-09-27 19:39:36,884 DEBUG [agent.transport.Request] > (AgentManager-Handler-11:null) Seq 2-1251542762: Processing: { Ans: , > MgmtId: 29066118877352, via: 2, Ver: v1, Flags: > 110, > [{"com.cloud.agent.api.StopAnswer":{"vncPort":0,"result":true,"wait":0}}] } -- This message was sent by Atlassian JIRA (v6.1#6144)