Nitin Mehta created CLOUDSTACK-1721: ---------------------------------------
Summary: Unable to create local storage volumes Key: CLOUDSTACK-1721 URL: https://issues.apache.org/jira/browse/CLOUDSTACK-1721 Project: CloudStack Issue Type: Bug Security Level: Public (Anyone can view this level - this is the default.) Reporter: Nitin Mehta Priority: Critical 2013-03-19 12:40:26,304 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-2:job-27) DeploymentPlanner allocation algorithm: random 2013-03-19 12:40:26,304 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-2:job-27) Trying to allocate a host and storage pools from dc:1, pod:null,cluster:null, requested cpu: 256, requested ram: 268435456 2013-03-19 12:40:26,304 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-2:job-27) Is ROOT volume READY (pool already allocated)?: No 2013-03-19 12:40:26,304 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-2:job-27) Searching all possible resources under this Zone: 1 2013-03-19 12:40:26,307 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-2:job-27) Listing clusters in order of aggregate capacity, that have (atleast one host with) enough CPU and RAM capacity under this Zone: 1 2013-03-19 12:40:26,347 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-2:job-27) Checking resources in Cluster: 1 under Pod: 1 2013-03-19 12:40:26,348 DEBUG [allocator.impl.RandomAllocator] (Job-Executor-2:job-27) Looking for hosts in dc: 1 pod:1 cluster:1 2013-03-19 12:40:26,354 DEBUG [allocator.impl.RandomAllocator] (Job-Executor-2:job-27) Random Allocator found 1 hosts 2013-03-19 12:40:26,354 DEBUG [allocator.impl.RandomAllocator] (Job-Executor-2:job-27) Random Host Allocator returning 1 suitable hosts 2013-03-19 12:40:26,357 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-2:job-27) Checking suitable pools for volume (Id, Type): (10,ROOT) 2013-03-19 12:40:26,357 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-2:job-27) We need to allocate new storagepool for this volume 2013-03-19 12:40:26,361 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-2:job-27) Calling StoragePoolAllocators to find suitable pools 2013-03-19 12:40:26,492 DEBUG [cloud.storage.StorageManagerImpl] (Job-Executor-2:job-27) Checking pool: 200 for volume allocation [Vol[10|vm=10|ROOT]], maxSize : 11804569632768, totalAllocatedSize : 137615496192, askingSize : 21474836480, allocated disable threshold: 0.85 2013-03-19 12:40:26,495 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-2:job-27) Trying to find a potenial host and associated storage pools from the suitable host/pool lists for this VM 2013-03-19 12:40:26,495 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-2:job-27) Checking if host: 1 can access any suitable storage pool for volume: ROOT 2013-03-19 12:40:26,497 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-2:job-27) Host: 1 can access pool: 200 2013-03-19 12:40:26,497 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-2:job-27) Found a potential host id: 1 name: xenserver-nitin and associated storage pools for this VM 2013-03-19 12:40:26,499 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-2:job-27) 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(1)-Storage(Volume(10|ROOT-->Pool(200))] 2013-03-19 12:40:26,567 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-2:job-27) VM state transitted from :Stopped to Starting with event: StartRequestedvm's original host id: null new host id: null host id before state transition: null 2013-03-19 12:40:26,567 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-2:job-27) Successfully transitioned to start state for VM[User|c991a65e-342b-4753-a31b-802201ac91c7] reservation id = b5da6244-7d0e-4a75-a4b9-62813f75547a 2013-03-19 12:40:26,570 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-2:job-27) Trying to deploy VM, vm has dcId: 1 and podId: null 2013-03-19 12:40:26,570 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-2:job-27) advanceStart: DeploymentPlan is provided, using dcId:1, podId: 1, clusterId: 1, hostId: 1, poolId: null 2013-03-19 12:40:26,571 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-2:job-27) Deploy avoids pods: null, clusters: null, hosts: null 2013-03-19 12:40:26,573 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-2:job-27) DeploymentPlanner allocation algorithm: random 2013-03-19 12:40:26,574 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-2:job-27) Trying to allocate a host and storage pools from dc:1, pod:1,cluster:1, requested cpu: 256, requested ram: 268435456 2013-03-19 12:40:26,574 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-2:job-27) Is ROOT volume READY (pool already allocated)?: No 2013-03-19 12:40:26,574 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-2:job-27) DeploymentPlan has host_id specified, making no checks on this host, looks like admin test: 1 2013-03-19 12:40:26,581 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-2:job-27) Looking for suitable pools for this host under zone: 1, pod: 1, cluster: 1 2013-03-19 12:40:26,586 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-2:job-27) Checking suitable pools for volume (Id, Type): (10,ROOT) 2013-03-19 12:40:26,586 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-2:job-27) We need to allocate new storagepool for this volume 2013-03-19 12:40:26,586 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-2:job-27) Calling StoragePoolAllocators to find suitable pools 2013-03-19 12:40:26,748 DEBUG [cloud.storage.StorageManagerImpl] (Job-Executor-2:job-27) Checking pool: 200 for volume allocation [Vol[10|vm=10|ROOT]], maxSize : 11804569632768, totalAllocatedSize : 137615496192, askingSize : 21474836480, allocated disable threshold: 0.85 2013-03-19 12:40:26,748 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-2:job-27) Trying to find a potenial host and associated storage pools from the suitable host/pool lists for this VM 2013-03-19 12:40:26,749 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-2:job-27) Checking if host: 1 can access any suitable storage pool for volume: ROOT 2013-03-19 12:40:26,751 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-2:job-27) Host: 1 can access pool: 200 2013-03-19 12:40:26,751 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-2:job-27) Found a potential host id: 1 name: xenserver-nitin and associated storage pools for this VM 2013-03-19 12:40:26,756 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-2:job-27) 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(1)-Storage(Volume(10|ROOT-->Pool(200))] 2013-03-19 12:40:26,757 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-2:job-27) Deployment found - P0=VM[User|c991a65e-342b-4753-a31b-802201ac91c7], P0=Dest[Zone(Id)-Pod(Id)-Cluster(Id)-Host(Id)-Storage(Volume(Id|Type-->Pool(Id))] : Dest[Zone(1)-Pod(1)-Cluster(1)-Host(1)-Storage(Volume(10|ROOT-->Pool(200))] 2013-03-19 12:40:26,770 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-2:job-27) VM state transitted from :Starting to Starting with event: OperationRetryvm's original host id: null new host id: 1 host id before state transition: null 2013-03-19 12:40:26,793 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-2:job-27) Hosts's actual total CPU: 5984 and CPU after applying overprovisioning: 5984 2013-03-19 12:40:26,793 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-2:job-27) We are allocating VM, increasing the used capacity of this host:1 2013-03-19 12:40:26,793 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-2:job-27) Current Used CPU: 2524 , Free CPU:3332 ,Requested CPU: 256 2013-03-19 12:40:26,793 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-2:job-27) Current Used RAM: 2550136832 , Free RAM:925857792 ,Requested RAM: 268435456 2013-03-19 12:40:26,793 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-2:job-27) CPU STATS after allocation: for host: 1, old used: 2524, old reserved: 128, actual total: 5984, total with overprovisioning: 5984; new used:2780, reserved:128; requested cpu:256,alloc_from_last:false 2013-03-19 12:40:26,793 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-2:job-27) RAM STATS after allocation: for host: 1, old used: 2550136832, old reserved: 134217728, total: 3610212352; new used: 2818572288, reserved: 134217728; requested mem: 268435456,alloc_from_last:false 2013-03-19 12:40:26,795 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-2:job-27) VM is being created in podId: 1 -- 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