i have try clean DB and re initial CS4.2.1. in Xen server pool, nfs primary storage have attached., it is ok.
i search other person meet same problem, but no solution. http://permalink.gmane.org/gmane.comp.apache.cloudstack.user/8728 hope some one can give me some support. thanks -----------------------------------------------------------------------------------------> 2014-01-29 23:37:07,747 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (secstorage-1:null) Deploy avoids pods: null, clusters: null, hosts: [1] 2014-01-29 23:37:07,749 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (secstorage-1:null) DeploymentPlanner allocation algorithm: com.cloud.deploy.FirstFitPlanner_EnhancerByCloudStack_1de5a3b1@9317ccb 2014-01-29 23:37:07,749 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (secstorage-1:null) Trying to allocate a host and storage pools from dc:1, pod:1,cluster:null, requested cpu: 500, requested ram: 268435456 2014-01-29 23:37:07,749 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (secstorage-1:null) Is ROOT volume READY (pool already allocated)?: No 2014-01-29 23:37:07,749 DEBUG [cloud.deploy.FirstFitPlanner] (secstorage-1:null) Searching resources only under specified Pod: 1 2014-01-29 23:37:07,749 DEBUG [cloud.deploy.FirstFitPlanner] (secstorage-1:null) Listing clusters in order of aggregate capacity, that have (atleast one host with) enough CPU and RAM capacity under this Pod: 1 2014-01-29 23:37:07,759 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (secstorage-1:null) Checking resources in Cluster: 1 under Pod: 1 2014-01-29 23:37:07,759 DEBUG [allocator.impl.FirstFitAllocator] (secstorage-1:FirstFitRoutingAllocator) Looking for hosts in dc: 1 pod:1 cluster:1 2014-01-29 23:37:07,763 DEBUG [allocator.impl.FirstFitAllocator] (secstorage-1:FirstFitRoutingAllocator) FirstFitAllocator has 2 hosts to check for allocation: [Host[-2-Routing], Host[-1-Routing]] 2014-01-29 23:37:07,767 DEBUG [allocator.impl.FirstFitAllocator] (secstorage-1:FirstFitRoutingAllocator) Found 2 hosts for allocation after prioritization: [Host[-2-Routing], Host[-1-Routing]] 2014-01-29 23:37:07,767 DEBUG [allocator.impl.FirstFitAllocator] (secstorage-1:FirstFitRoutingAllocator) Looking for speed=500Mhz, Ram=256 2014-01-29 23:37:07,772 DEBUG [cloud.capacity.CapacityManagerImpl] (secstorage-1:FirstFitRoutingAllocator) Checking if host: 2 has enough capacity for requested CPU: 500 and requested RAM: 268435456 , cpuOverprovisioningFactor: 1.0 2014-01-29 23:37:07,775 DEBUG [cloud.capacity.CapacityManagerImpl] (secstorage-1:FirstFitRoutingAllocator) Hosts's actual total CPU: 13590 and CPU after applying overprovisioning: 13590 2014-01-29 23:37:07,775 DEBUG [cloud.capacity.CapacityManagerImpl] (secstorage-1:FirstFitRoutingAllocator) Free CPU: 13590 , Requested CPU: 500 2014-01-29 23:37:07,776 DEBUG [cloud.capacity.CapacityManagerImpl] (secstorage-1:FirstFitRoutingAllocator) Free RAM: 9669118976 , Requested RAM: 268435456 2014-01-29 23:37:07,776 DEBUG [cloud.capacity.CapacityManagerImpl] (secstorage-1:FirstFitRoutingAllocator) Host has enough CPU and RAM available 2014-01-29 23:37:07,776 DEBUG [cloud.capacity.CapacityManagerImpl] (secstorage-1:FirstFitRoutingAllocator) STATS: Can alloc CPU from host: 2, used: 0, reserved: 0, actual total: 13590, total with overprovisioning: 13590; requested cpu:500,alloc_from_last_host?:false ,considerReservedCapacity?: true 2014-01-29 23:37:07,776 DEBUG [cloud.capacity.CapacityManagerImpl] (secstorage-1:FirstFitRoutingAllocator) STATS: Can alloc MEM from host: 2, used: 0, reserved: 0, total: 9669118976; requested mem: 268435456,alloc_from_last_host?:false ,considerReservedCapacity?: true 2014-01-29 23:37:07,776 DEBUG [allocator.impl.FirstFitAllocator] (secstorage-1:FirstFitRoutingAllocator) Found a suitable host, adding to list: 2 2014-01-29 23:37:07,776 DEBUG [allocator.impl.FirstFitAllocator] (secstorage-1:FirstFitRoutingAllocator) Host name: xen01, hostId: 1 is in avoid set, skipping this and trying other available hosts 2014-01-29 23:37:07,776 DEBUG [allocator.impl.FirstFitAllocator] (secstorage-1:FirstFitRoutingAllocator) Host Allocator returning 1 suitable hosts 2014-01-29 23:37:07,777 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (secstorage-1:null) Checking suitable pools for volume (Id, Type): (19,ROOT) 2014-01-29 23:37:07,778 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (secstorage-1:null) We need to allocate new storagepool for this volume 2014-01-29 23:37:07,778 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (secstorage-1:null) Calling StoragePoolAllocators to find suitable pools 2014-01-29 23:37:07,780 DEBUG [storage.allocator.LocalStoragePoolAllocator] (secstorage-1:null) LocalStoragePoolAllocator trying to find storage pool to fit the vm 2014-01-29 23:37:07,780 DEBUG [storage.allocator.ClusterScopeStoragePoolAllocator] (secstorage-1:null) ClusterScopeStoragePoolAllocator looking for storage pool 2014-01-29 23:37:07,780 DEBUG [storage.allocator.ClusterScopeStoragePoolAllocator] (secstorage-1:null) Looking for pools in dc: 1 pod:1 cluster:1 2014-01-29 23:37:07,784 DEBUG [storage.allocator.AbstractStoragePoolAllocator] (secstorage-1:null) Checking if storage pool is suitable, name: null ,poolId: 1 2014-01-29 23:37:07,784 DEBUG [storage.allocator.AbstractStoragePoolAllocator] (secstorage-1:null) StoragePool is in avoid set, skipping this pool 2014-01-29 23:37:07,784 DEBUG [storage.allocator.ClusterScopeStoragePoolAllocator] (secstorage-1:null) ClusterScopeStoragePoolAllocator returning 0 suitable storage pools 2014-01-29 23:37:07,784 DEBUG [storage.allocator.ZoneWideStoragePoolAllocator] (secstorage-1:null) ZoneWideStoragePoolAllocator to find storage pool 2014-01-29 23:37:07,788 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (secstorage-1:null) No suitable pools found for volume: Vol[19|vm=19|ROOT] under cluster: 1 2014-01-29 23:37:07,788 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (secstorage-1:null) No suitable pools found 2014-01-29 23:37:07,788 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (secstorage-1:null) No suitable storagePools found under this Cluster: 1 2014-01-29 23:37:07,792 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (secstorage-1:null) Could not find suitable Deployment Destination for this VM under any clusters, returning. 2014-01-29 23:37:07,793 DEBUG [cloud.deploy.FirstFitPlanner] (secstorage-1:null) Searching resources only under specified Pod: 1 2014-01-29 23:37:07,793 DEBUG [cloud.deploy.FirstFitPlanner] (secstorage-1:null) Listing clusters in order of aggregate capacity, that have (atleast one host with) enough CPU and RAM capacity under this Pod: 1 2014-01-29 23:37:07,796 DEBUG [cloud.deploy.FirstFitPlanner] (secstorage-1:null) Removing from the clusterId list these clusters from avoid set: [1] 2014-01-29 23:37:07,796 DEBUG [cloud.deploy.FirstFitPlanner] (secstorage-1:null) No clusters found after removing disabled clusters and clusters in avoid list, returning. 2014-01-29 23:37:07,802 DEBUG [cloud.capacity.CapacityManagerImpl] (secstorage-1:null) VM state transitted from :Starting to Stopped with event: OperationFailedvm's original host id: null new host id: null host id before state transition: 1 2014-01-29 23:37:07,810 DEBUG [cloud.capacity.CapacityManagerImpl] (secstorage-1:null) Hosts's actual total CPU: 13590 and CPU after applying overprovisioning: 13590 2014-01-29 23:37:07,810 DEBUG [cloud.capacity.CapacityManagerImpl] (secstorage-1:null) Hosts's actual total RAM: 9669119040 and RAM after applying overprovisioning: 9669118976 2014-01-29 23:37:07,810 DEBUG [cloud.capacity.CapacityManagerImpl] (secstorage-1:null) release cpu from host: 1, old used: 1000,reserved: 0, actual total: 13590, total with overprovisioning: 13590; new used: 500,reserved:0; movedfromreserved: false,moveToReserveredfalse 2014-01-29 23:37:07,810 DEBUG [cloud.capacity.CapacityManagerImpl] (secstorage-1:null) release mem from host: 1, old used: 1342177280,reserved: 0, total: 9669118976; new used: 1073741824,reserved:0; movedfromreserved: false,moveToReserveredfalse 2014-01-29 23:37:07,813 WARN [storage.secondary.SecondaryStorageManagerImpl] (secstorage-1:null) Exception while trying to start secondary storage vm com.cloud.exception.InsufficientServerCapacityException: Unable to create a deployment for VM[SecondaryStorageVm|s-19-VM]Scope=interface com.cloud.dc.DataCenter; id=1 at com.cloud.vm.VirtualMachineManagerImpl.advanceStart(VirtualMachineManagerImpl.java:841) at com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:577) at com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:570) at com.cloud.storage.secondary.SecondaryStorageManagerImpl.startSecStorageVm(SecondaryStorageManagerImpl.java:267) at com.cloud.storage.secondary.SecondaryStorageManagerImpl.allocCapacity(SecondaryStorageManagerImpl.java:696) at com.cloud.storage.secondary.SecondaryStorageManagerImpl.expandPool(SecondaryStorageManagerImpl.java:1300) at com.cloud.secstorage.PremiumSecondaryStorageManagerImpl.scanPool(PremiumSecondaryStorageManagerImpl.java:123) at com.cloud.secstorage.PremiumSecondaryStorageManagerImpl.scanPool(PremiumSecondaryStorageManagerImpl.java:50) at com.cloud.vm.SystemVmLoadScanner.loadScan(SystemVmLoadScanner.java:104) at com.cloud.vm.SystemVmLoadScanner.access$100(SystemVmLoadScanner.java:33) at com.cloud.vm.SystemVmLoadScanner$1.reallyRun(SystemVmLoadScanner.java:81) at com.cloud.vm.SystemVmLoadScanner$1.run(SystemVmLoadScanner.java:72) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471) at java.util.concurrent.FutureTask$Sync.innerRunAndReset(FutureTask.java:351) at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:178) at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:165) at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:267) 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:701) 2014-01-29 23:37:07,814 INFO [storage.secondary.SecondaryStorageManagerImpl] (secstorage-1:null) Unable to start secondary storage vm for standby capacity, secStorageVm vm Id : 19, will recycle it and start a new one 2014-01-29 23:37:07,817 DEBUG [cloud.vm.VirtualMachineManagerImpl] (secstorage-1:null) VM is already stopped: VM[SecondaryStorageVm|s-19-VM] 2014-01-29 23:37:07,821 DEBUG [cloud.capacity.CapacityManagerImpl] (secstorage-1:null) VM state transitted from :Stopped to Expunging with event: ExpungeOperationvm's original host id: null new host id: null host id before state transition: null 2014-01-29 23:37:07,824 DEBUG [cloud.vm.VirtualMachineManagerImpl] (secstorage-1:null) Destroying vm VM[SecondaryStorageVm|s-19-VM] 2014-01-29 23:37:07,824 DEBUG [cloud.vm.VirtualMachineManagerImpl] (secstorage-1:null) Cleaning up NICS 2014-01-29 23:37:07,824 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Cleaning network for vm: 19 2014-01-29 23:37:07,836 DEBUG [network.guru.PublicNetworkGuru] (secstorage-1:null) public network deallocate network: networkId: 200, ip: 192.168.240.50 2014-01-29 23:37:07,842 DEBUG [network.guru.PublicNetworkGuru] (secstorage-1:null) Deallocated nic: NicProfile[72-19-null-null-null 2014-01-29 23:37:07,844 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Removed nic id=72 2014-01-29 23:37:07,845 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Revoving nic secondary ip entry ... 2014-01-29 23:37:07,851 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Removed nic id=73 2014-01-29 23:37:07,852 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Revoving nic secondary ip entry ... 2014-01-29 23:37:07,864 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Removed nic id=74 2014-01-29 23:37:07,865 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Revoving nic secondary ip entry ... 2014-01-29 23:37:07,884 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Removed nic id=75 2014-01-29 23:37:07,886 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Revoving nic secondary ip entry ... 2014-01-29 23:37:07,888 DEBUG [cloud.storage.VolumeManagerImpl] (secstorage-1:null) Cleaning storage for vm: 19 2014-01-29 23:37:07,903 INFO [storage.volume.VolumeServiceImpl] (secstorage-1:null) Expunge volume with no data store specified 2014-01-29 23:37:07,906 INFO [storage.volume.VolumeServiceImpl] (secstorage-1:null) Volume 19 is not referred anywhere, remove it from volumes table 2014-01-29 23:37:07,913 DEBUG [cloud.vm.VirtualMachineManagerImpl] (secstorage-1:null) Expunged VM[SecondaryStorageVm|s-19-VM] 2014-01-29 23:37:07,919 INFO [cloud.secstorage.PremiumSecondaryStorageManagerImpl] (secstorage-1:null) Primary secondary storage is not even started, wait until next turn 2014-01-29 23:37:10,313 INFO [storage.volume.VolumeServiceImpl] (consoleproxy-1:null) Unable to acquire lock on VMTemplateStoragePool 37 2014-01-29 23:37:10,315 ERROR [cloud.vm.VirtualMachineManagerImpl] (consoleproxy-1:null) Failed to start instance VM[ConsoleProxy|v-2-VM] java.lang.NullPointerException at org.apache.cloudstack.storage.volume.VolumeServiceImpl.createBaseImageAsync(VolumeServiceImpl.java:428) at org.apache.cloudstack.storage.volume.VolumeServiceImpl.createVolumeFromTemplateAsync(VolumeServiceImpl.java:575) at com.cloud.storage.VolumeManagerImpl.recreateVolume(VolumeManagerImpl.java:2577) at com.cloud.storage.VolumeManagerImpl.prepare(VolumeManagerImpl.java:2641) at com.cloud.vm.VirtualMachineManagerImpl.advanceStart(VirtualMachineManagerImpl.java:888) at com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:577) at com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:570) at com.cloud.consoleproxy.ConsoleProxyManagerImpl.startProxy(ConsoleProxyManagerImpl.java:556) at com.cloud.consoleproxy.ConsoleProxyManagerImpl.allocCapacity(ConsoleProxyManagerImpl.java:928) at com.cloud.consoleproxy.ConsoleProxyManagerImpl.expandPool(ConsoleProxyManagerImpl.java:1672) at com.cloud.consoleproxy.ConsoleProxyManagerImpl.expandPool(ConsoleProxyManagerImpl.java:157) at com.cloud.vm.SystemVmLoadScanner.loadScan(SystemVmLoadScanner.java:111) at com.cloud.vm.SystemVmLoadScanner.access$100(SystemVmLoadScanner.java:33) at com.cloud.vm.SystemVmLoadScanner$1.reallyRun(SystemVmLoadScanner.java:81) at com.cloud.vm.SystemVmLoadScanner$1.run(SystemVmLoadScanner.java:72) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471) at java.util.concurrent.FutureTask$Sync.innerRunAndReset(FutureTask.java:351) at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:178) at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:165) at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:267) 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:701) 2014-01-29 23:37:10,318 DEBUG [cloud.vm.VirtualMachineManagerImpl] (consoleproxy-1:null) Cleaning up resources for the vm VM[ConsoleProxy|v-2-VM] in Starting state 2014-01-29 23:37:10,320 DEBUG [agent.transport.Request] (consoleproxy-1:null) Seq 1-1493762102: Sending { Cmd , MgmtId: 345050143793, via: 1, Ver: v1, Flags: 100111, [{"com.cloud.agent.api.StopCommand":{"isProxy":false,"executeInSequence":true,"vmName":"v-2-VM","wait":0}}] } 2014-01-29 23:37:10,321 DEBUG [agent.transport.Request] (consoleproxy-1:null) Seq 1-1493762102: Executing: { Cmd , MgmtId: 345050143793, via: 1, Ver: v1, Flags: 100111, [{"com.cloud.agent.api.StopCommand":{"isProxy":false,"executeInSequence":true,"vmName":"v-2-VM","wait":0}}] } 2014-01-29 23:37:10,321 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-151:null) Seq 1-1493762102: Executing request 2014-01-29 23:37:10,444 INFO [xen.resource.CitrixResourceBase] (DirectAgent-151:null) VM does not exist on XenServerce2325a7-2953-4a88-af4e-d828e5624ffc 2014-01-29 23:37:10,444 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-151:null) Seq 1-1493762102: Response Received: 2014-01-29 23:37:10,444 DEBUG [agent.transport.Request] (DirectAgent-151:null) Seq 1-1493762102: Processing: { Ans: , MgmtId: 345050143793, via: 1, Ver: v1, Flags: 110, [{"com.cloud.agent.api.StopAnswer":{"result":true,"details":"VM does not exist","wait":0}}] } 2014-01-29 23:37:10,445 DEBUG [agent.manager.AgentAttache] (DirectAgent-151:null) Seq 1-1493762102: No more commands found 2014-01-29 23:37:10,445 DEBUG [agent.transport.Request] (consoleproxy-1:null) Seq 1-1493762102: Received: { Ans: , MgmtId: 345050143793, via: 1, Ver: v1, Flags: 110, { StopAnswer } } 2014-01-29 23:37:10,456 DEBUG [network.guru.ControlNetworkGuru] (consoleproxy-1:null) Released nic: NicProfile[6-2-null-null-null 2014-01-29 23:37:10,464 DEBUG [dc.dao.DataCenterIpAddressDaoImpl] (consoleproxy-1:null) Releasing ip address for reservationId=8326d153-52df-4c46-ac11-a10c433c3fbe, instance=7 2014-01-29 23:37:10,465 DEBUG [network.guru.PodBasedNetworkGuru] (consoleproxy-1:null) Released nic: NicProfile[7-2-null-null-null 2014-01-29 23:37:10,468 DEBUG [cloud.vm.VirtualMachineManagerImpl] (consoleproxy-1:null) Successfully released network resources for the vm VM[ConsoleProxy|v-2-VM] 2014-01-29 23:37:10,468 DEBUG [cloud.vm.VirtualMachineManagerImpl] (consoleproxy-1:null) Successfully cleanued up resources for the vm VM[ConsoleProxy|v-2-VM] in Starting state 2014-01-29 23:37:10,473 DEBUG [cloud.capacity.CapacityManagerImpl] (consoleproxy-1:null) VM state transitted from :Starting to Stopped with event: OperationFailedvm's original host id: 2 new host id: null host id before state transition: 1 2014-01-29 23:37:10,480 DEBUG [cloud.capacity.CapacityManagerImpl] (consoleproxy-1:null) Hosts's actual total CPU: 13590 and CPU after applying overprovisioning: 13590 2014-01-29 23:37:10,480 DEBUG [cloud.capacity.CapacityManagerImpl] (consoleproxy-1:null) Hosts's actual total RAM: 9669119040 and RAM after applying overprovisioning: 9669118976 2014-01-29 23:37:10,481 DEBUG [cloud.capacity.CapacityManagerImpl] (consoleproxy-1:null) release cpu from host: 1, old used: 500,reserved: 0, actual total: 13590, total with overprovisioning: 13590; new used: 0,reserved:0; movedfromreserved: false,moveToReserveredfalse 2014-01-29 23:37:10,481 DEBUG [cloud.capacity.CapacityManagerImpl] (consoleproxy-1:null) release mem from host: 1, old used: 1073741824,reserved: 0, total: 9669118976; new used: 0,reserved:0; movedfromreserved: false,moveToReserveredfalse 2014-01-29 23:37:10,484 WARN [cloud.consoleproxy.ConsoleProxyManagerImpl] (consoleproxy-1:null) Exception while trying to start console proxy com.cloud.exception.AgentUnavailableException: Resource [Host:1] is unreachable: Host 1: Unable to start instance due to null at com.cloud.vm.VirtualMachineManagerImpl.advanceStart(VirtualMachineManagerImpl.java:999) at com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:577) at com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:570) at com.cloud.consoleproxy.ConsoleProxyManagerImpl.startProxy(ConsoleProxyManagerImpl.java:556) at com.cloud.consoleproxy.ConsoleProxyManagerImpl.allocCapacity(ConsoleProxyManagerImpl.java:928) at com.cloud.consoleproxy.ConsoleProxyManagerImpl.expandPool(ConsoleProxyManagerImpl.java:1672) at com.cloud.consoleproxy.ConsoleProxyManagerImpl.expandPool(ConsoleProxyManagerImpl.java:157) at com.cloud.vm.SystemVmLoadScanner.loadScan(SystemVmLoadScanner.java:111) at com.cloud.vm.SystemVmLoadScanner.access$100(SystemVmLoadScanner.java:33) at com.cloud.vm.SystemVmLoadScanner$1.reallyRun(SystemVmLoadScanner.java:81) at com.cloud.vm.SystemVmLoadScanner$1.run(SystemVmLoadScanner.java:72) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471) at java.util.concurrent.FutureTask$Sync.innerRunAndReset(FutureTask.java:351) at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:178) at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:165) at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:267) 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:701) Caused by: java.lang.NullPointerException at org.apache.cloudstack.storage.volume.VolumeServiceImpl.createBaseImageAsync(VolumeServiceImpl.java:428) at org.apache.cloudstack.storage.volume.VolumeServiceImpl.createVolumeFromTemplateAsync(VolumeServiceImpl.java:575) at com.cloud.storage.VolumeManagerImpl.recreateVolume(VolumeManagerImpl.java:2577) at com.cloud.storage.VolumeManagerImpl.prepare(VolumeManagerImpl.java:2641) at com.cloud.vm.VirtualMachineManagerImpl.advanceStart(VirtualMachineManagerImpl.java:888) ... 19 more 2014-01-29 23:37:14,276 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-84:null) Ping from 1 2014-01-29 23:37:15,955 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-121:null) Ping from 2
