can you post this on the dev list, you might be able to get more pointed help.
On Tue, May 28, 2013 at 4:24 AM, Maxim Popov <[email protected]> wrote: > Hi. > > I cannot create any instance (nor from templates, nor from ISOs). > > Both primary and secondary storages are NFS based. System VMs are running > OK. > > Cloudstack version 4.1. > > Below is the log: > > 2013-05-28 13:48:19,107 DEBUG [allocator.impl.FirstFitAllocator] > (Job-Executor-8:job-150 FirstFitRoutingAllocator) Found a suitable host, > adding to list: 10 > 2013-05-28 13:48:19,107 DEBUG [allocator.impl.FirstFitAllocator] > (Job-Executor-8:job-150 FirstFitRoutingAllocator) Host Allocator returning > 1 suitable hosts > 2013-05-28 13:48:19,108 DEBUG [cloud.deploy.FirstFitPlanner] > (Job-Executor-8:job-150) Checking suitable pools for volume (Id, Type): > (127,ROOT) > 2013-05-28 13:48:19,108 DEBUG [cloud.deploy.FirstFitPlanner] > (Job-Executor-8:job-150) We need to allocate new storagepool for this volume > 2013-05-28 13:48:19,109 DEBUG [cloud.deploy.FirstFitPlanner] > (Job-Executor-8:job-150) Calling StoragePoolAllocators to find suitable > pools > 2013-05-28 13:48:19,110 DEBUG > [storage.allocator.FirstFitStoragePoolAllocator] (Job-Executor-8:job-150) > Looking for pools in dc: 1 pod:1 cluster:1 > 2013-05-28 13:48:19,111 DEBUG > [storage.allocator.FirstFitStoragePoolAllocator] (Job-Executor-8:job-150) > FirstFitStoragePoolAllocator has 1 pools to check for allocation > 2013-05-28 13:48:19,111 DEBUG > [storage.allocator.AbstractStoragePoolAllocator] (Job-Executor-8:job-150) > Checking if storage pool is suitable, name: NFS Primary 1 ,poolId: 207 > 2013-05-28 13:48:19,111 DEBUG > [storage.allocator.AbstractStoragePoolAllocator] (Job-Executor-8:job-150) > Is localStorageAllocationNeeded? false > 2013-05-28 13:48:19,111 DEBUG > [storage.allocator.AbstractStoragePoolAllocator] (Job-Executor-8:job-150) > Is storage pool shared? true > 2013-05-28 13:48:19,113 DEBUG [cloud.storage.StorageManagerImpl] > (Job-Executor-8:job-150) Checking pool 207 for storage, totalSize: > 3937209942016, usedBytes: 3988783104, usedPct: 0.0010130989108387734, > disable threshold: 0.85 > 2013-05-28 13:48:19,119 DEBUG [cloud.storage.StorageManagerImpl] > (Job-Executor-8:job-150) Checking pool: 207 for volume allocation > [Vol[127|vm=125|ROOT]], maxSize : 7874419884032, totalAllocatedSize : > 1769676800, askingSize : 8589934592, allocated disable threshold: 0.85 > 2013-05-28 13:48:19,119 DEBUG > [storage.allocator.FirstFitStoragePoolAllocator] (Job-Executor-8:job-150) > FirstFitStoragePoolAllocator returning 1 suitable storage pools > 2013-05-28 13:48:19,119 DEBUG [cloud.deploy.FirstFitPlanner] > (Job-Executor-8:job-150) Trying to find a potenial host and associated > storage pools from the suitable host/pool lists for this VM > 2013-05-28 13:48:19,119 DEBUG [cloud.deploy.FirstFitPlanner] > (Job-Executor-8:job-150) Checking if host: 10 can access any suitable > storage pool for volume: ROOT > 2013-05-28 13:48:19,120 DEBUG [cloud.deploy.FirstFitPlanner] > (Job-Executor-8:job-150) Host: 10 can access pool: 207 > 2013-05-28 13:48:19,120 DEBUG [cloud.deploy.FirstFitPlanner] > (Job-Executor-8:job-150) Found a potential host id: 10 name: compute2 and > associated storage pools for this VM > 2013-05-28 13:48:19,121 DEBUG [cloud.deploy.FirstFitPlanner] > (Job-Executor-8:job-150) Returning Deployment Destination: > Dest[Zone(Id)-Pod(Id)-Cluster(Id)-Host(Id)-Storage(Volume(Id|Type-->Pool(Id))] > : > Dest[Zone(1)-Pod(1)-Cluster(1)-Host(10)-Storage(Volume(127|ROOT-->Pool(207))] > 2013-05-28 13:48:19,124 DEBUG [db.Transaction.Transaction] > (Job-Executor-8:job-150) Rolling back the transaction: Time = 2 Name = > > -AsyncJobManagerImpl$1.run:401-Executors$RunnableAdapter.call:471-FutureTask$Sync.innerRun:334-FutureTask.run:166-ThreadPoolExecutor.runWorker:1146-ThreadPoolExecutor$Worker.run:615-Thread.run:679; > called by > -Transaction.rollback:890-Transaction.removeUpTo:833-Transaction.close:657-TransactionContextBuilder.interceptException:63-ComponentInstantiationPostProcessor$InterceptorDispatcher.intercept:133-VMReservationDaoImpl.persist:40-ComponentInstantiationPostProcessor$InterceptorDispatcher.intercept:125-VMEntityDaoImpl.saveVmReservation:165-VMEntityDaoImpl.persist:88-ComponentInstantiationPostProcessor$InterceptorDispatcher.intercept:125-VMEntityDaoImpl.persist:45-ComponentInstantiationPostProcessor$InterceptorDispatcher.intercept:125 > 2013-05-28 13:48:19,149 DEBUG [cloud.vm.UserVmManagerImpl] > (Job-Executor-8:job-150) Destroying vm VM[User|rerwtwer] as it failed to > create on Host with Id:null > 2013-05-28 13:48:19,197 DEBUG [cloud.capacity.CapacityManagerImpl] > (Job-Executor-8:job-150) VM state transitted from :Stopped to Error with > event: OperationFailedToErrorvm's original host id: null new host id: null > host id before state transition: null > 2013-05-28 13:48:19,565 ERROR [cloud.async.AsyncJobManagerImpl] > (Job-Executor-8:job-150) Unexpected exception while executing > org.apache.cloudstack.api.command.user.vm.DeployVMCmd > java.lang.NoSuchMethodError: > org.apache.cloudstack.engine.cloud.entity.api.db.VolumeReservationVO.<init>(JJJLjava/lang/Long;)V > at > org.apache.cloudstack.engine.cloud.entity.api.db.dao.VMReservationDaoImpl.saveVolumeReservation(VMReservationDaoImpl.java:99) > at > org.apache.cloudstack.engine.cloud.entity.api.db.dao.VMReservationDaoImpl.persist(VMReservationDaoImpl.java:88) > at > com.cloud.utils.component.ComponentInstantiationPostProcessor$InterceptorDispatcher.intercept(ComponentInstantiationPostProcessor.java:125) > at > org.apache.cloudstack.engine.cloud.entity.api.db.dao.VMReservationDaoImpl.persist(VMReservationDaoImpl.java:40) > at > com.cloud.utils.component.ComponentInstantiationPostProcessor$InterceptorDispatcher.intercept(ComponentInstantiationPostProcessor.java:125) > at > org.apache.cloudstack.engine.cloud.entity.api.db.dao.VMEntityDaoImpl.saveVmReservation(VMEntityDaoImpl.java:165) > at > org.apache.cloudstack.engine.cloud.entity.api.db.dao.VMEntityDaoImpl.persist(VMEntityDaoImpl.java:88) > at > com.cloud.utils.component.ComponentInstantiationPostProcessor$InterceptorDispatcher.intercept(ComponentInstantiationPostProcessor.java:125) > at > org.apache.cloudstack.engine.cloud.entity.api.db.dao.VMEntityDaoImpl.persist(VMEntityDaoImpl.java:45) > at > com.cloud.utils.component.ComponentInstantiationPostProcessor$InterceptorDispatcher.intercept(ComponentInstantiationPostProcessor.java:125) > at > org.apache.cloudstack.engine.cloud.entity.api.VMEntityManagerImpl.reserveVirtualMachine(VMEntityManagerImpl.java:182) > at > org.apache.cloudstack.engine.cloud.entity.api.VirtualMachineEntityImpl.reserve(VirtualMachineEntityImpl.java:198) > at > com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:3864) > at > com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:3458) > at > com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:3444) > at > com.cloud.utils.component.ComponentInstantiationPostProcessor$InterceptorDispatcher.intercept(ComponentInstantiationPostProcessor.java:125) > at > org.apache.cloudstack.api.command.user.vm.DeployVMCmd.execute(DeployVMCmd.java:379) > at com.cloud.api.ApiDispatcher.dispatch(ApiDispatcher.java:162) > at > com.cloud.async.AsyncJobManagerImpl$1.run(AsyncJobManagerImpl.java:437) > 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.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) > at > java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) > at java.lang.Thread.run(Thread.java:679) > 2013-05-28 13:48:19,566 DEBUG [cloud.async.AsyncJobManagerImpl] > (Job-Executor-8:job-150) Complete async job-150, jobStatus: 2, resultCode: > 530, result: Error Code: 530 Error text: > org.apache.cloudstack.engine.cloud.entity.api.db.VolumeReservationVO.<init>(JJJLjava/lang/Long;)V
