Chandan Purushothama created CLOUDSTACK-4432:
------------------------------------------------
Summary: [VMWare] NPE thrown during VM Deployment
Key: CLOUDSTACK-4432
URL: https://issues.apache.org/jira/browse/CLOUDSTACK-4432
Project: CloudStack
Issue Type: Bug
Security Level: Public (Anyone can view this level - this is the default.)
Components: VMware
Affects Versions: 4.2.0
Reporter: Chandan Purushothama
Priority: Critical
Fix For: 4.2.1
Attachments: management-server.zip
===========
Observation:
===========
2013-08-21 17:09:32,344 DEBUG [allocator.impl.FirstFitAllocator]
(Job-Executor-49:job-66 = [ 50b09c49-f155-4b59-b6a3-9c77394fe172 ]
FirstFitRoutingAllocator) Found a suitable host, adding to list: 10
2013-08-21 17:09:32,345 DEBUG [allocator.impl.FirstFitAllocator]
(Job-Executor-49:job-66 = [ 50b09c49-f155-4b59-b6a3-9c77394fe172 ]
FirstFitRoutingAllocator) Host Allocator returning 1 suitable hosts
2013-08-21 17:09:32,346 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl]
(Job-Executor-49:job-66 = [ 50b09c49-f155-4b59-b6a3-9c77394fe172 ]) Checking
suitable pools for volume (Id, Type): (18,ROOT)
2013-08-21 17:09:32,346 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl]
(Job-Executor-49:job-66 = [ 50b09c49-f155-4b59-b6a3-9c77394fe172 ]) We need to
allocate new storagepool for this volume
2013-08-21 17:09:32,347 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl]
(Job-Executor-49:job-66 = [ 50b09c49-f155-4b59-b6a3-9c77394fe172 ]) Calling
StoragePoolAllocators to find suitable pools
2013-08-21 17:09:32,349 DEBUG [storage.allocator.LocalStoragePoolAllocator]
(Job-Executor-49:job-66 = [ 50b09c49-f155-4b59-b6a3-9c77394fe172 ])
LocalStoragePoolAllocator trying to find storage pool to fit the vm
2013-08-21 17:09:32,349 DEBUG
[storage.allocator.ClusterScopeStoragePoolAllocator] (Job-Executor-49:job-66 =
[ 50b09c49-f155-4b59-b6a3-9c77394fe172 ]) ClusterScopeStoragePoolAllocator
looking for storage pool
2013-08-21 17:09:32,349 DEBUG
[storage.allocator.ClusterScopeStoragePoolAllocator] (Job-Executor-49:job-66 =
[ 50b09c49-f155-4b59-b6a3-9c77394fe172 ]) Looking for pools in dc: 1 pod:1
cluster:6
2013-08-21 17:09:32,350 DEBUG
[storage.allocator.ClusterScopeStoragePoolAllocator] (Job-Executor-49:job-66 =
[ 50b09c49-f155-4b59-b6a3-9c77394fe172 ]) No storage pools available for shared
volume allocation, returning
2013-08-21 17:09:32,350 DEBUG [storage.allocator.ZoneWideStoragePoolAllocator]
(Job-Executor-49:job-66 = [ 50b09c49-f155-4b59-b6a3-9c77394fe172 ])
ZoneWideStoragePoolAllocator to find storage pool
2013-08-21 17:09:32,353 DEBUG
[storage.allocator.GarbageCollectingStoragePoolAllocator]
(Job-Executor-49:job-66 = [ 50b09c49-f155-4b59-b6a3-9c77394fe172 ])
GarbageCollectingStoragePoolAllocator looking for storage pool
2013-08-21 17:09:32,361 DEBUG [cloud.storage.StorageManagerImpl]
(Job-Executor-49:job-66 = [ 50b09c49-f155-4b59-b6a3-9c77394fe172 ]) Storage
pool garbage collector found 0 templates to clean up in storage pool:
vmware-primary-1
2013-08-21 17:09:32,365 DEBUG [cloud.storage.StorageManagerImpl]
(Job-Executor-49:job-66 = [ 50b09c49-f155-4b59-b6a3-9c77394fe172 ]) Storage
pool garbage collector found 1 templates to clean up in storage pool:
vmware-primary-2
2013-08-21 17:09:32,366 DEBUG [cloud.template.TemplateManagerImpl]
(Job-Executor-49:job-66 = [ 50b09c49-f155-4b59-b6a3-9c77394fe172 ]) Evicting
TmplPool[5-7-201-1bb6ddc2f6bf3f918ebd7ead6073aae5]
2013-08-21 17:09:32,368 DEBUG [agent.transport.Request] (Job-Executor-49:job-66
= [ 50b09c49-f155-4b59-b6a3-9c77394fe172 ]) Seq 5-357960810: Sending { Cmd ,
MgmtId: 7471666038533, via: 5, Ver: v1, Flags: 100111,
[{"com.cloud.agent.api.storage.DestroyCommand":{"volume":{"id":5,"mountPoint":"/export/home/chandan/307PB-195-103/primary2","path":"1bb6ddc2f6bf3f918ebd7ead6073aae5","size":0,"storagePoolType":"NetworkFilesystem","storagePoolUuid":"96bc10ee-70b3-3d20-a60c-c068a024b3a7","deviceId":0},"wait":0}}]
}
2013-08-21 17:09:32,369 DEBUG [agent.transport.Request] (Job-Executor-49:job-66
= [ 50b09c49-f155-4b59-b6a3-9c77394fe172 ]) Seq 5-357960810: Executing: { Cmd
, MgmtId: 7471666038533, via: 5, Ver: v1, Flags: 100111,
[{"com.cloud.agent.api.storage.DestroyCommand":{"volume":{"id":5,"mountPoint":"/export/home/chandan/307PB-195-103/primary2","path":"1bb6ddc2f6bf3f918ebd7ead6073aae5","size":0,"storagePoolType":"NetworkFilesystem","storagePoolUuid":"96bc10ee-70b3-3d20-a60c-c068a024b3a7","deviceId":0},"wait":0}}]
}
2013-08-21 17:09:32,369 DEBUG [agent.manager.DirectAgentAttache]
(DirectAgent-302:null) Seq 5-357960810: Executing request
2013-08-21 17:09:32,369 WARN [agent.manager.DirectAgentAttache]
(DirectAgent-302:null) Seq 5-357960810: Exception caught
java.lang.NullPointerException
at
com.cloud.agent.manager.DirectAgentAttache$Task.run(DirectAgentAttache.java:195)
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.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$101(ScheduledThreadPoolExecutor.java:165)
at
java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:266)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1110)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:603)
at java.lang.Thread.run(Thread.java:679)
2013-08-21 17:09:35,105 DEBUG [agent.manager.AgentManagerImpl]
(AgentManager-Handler-8:null) SeqA 7-11405: Processing Seq 7-11405: { Cmd ,
MgmtId: -1, via: 7, Ver: v1, Flags: 11,
[{"com.cloud.agent.api.ConsoleProxyLoadReportCommand":{"_proxyVmId":9,"_loadInfo":"{\n
\"connections\": []\n}","wait":0}}] }
--
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