Chandan Purushothama created CLOUDSTACK-227:
-----------------------------------------------
Summary: ReconnectHostCmd: NullPointerException: Unable to get
host Information for XenServer 6.0.2 host - on intentionally changing the
traffic labels on the physical network
Key: CLOUDSTACK-227
URL: https://issues.apache.org/jira/browse/CLOUDSTACK-227
Project: CloudStack
Issue Type: Bug
Components: Management Server
Affects Versions: pre-4.0.0
Reporter: Chandan Purushothama
Priority: Minor
Fix For: pre-4.0.0
================
Steps To Reproduce:
================
1. Create Advanced zone with all supported traffic types (Management, Guest,
Public, Storage)
i) PhyNet1
- Mgmt,public,Guest, Storage (Traffic label = NIC0)
- Tags = cloud-xenbr0
ii) PhyNet2
- Guest (Traffic label = NIC1)
- Tags = cloud-xenbr1
2. Add XenServer 6.0.2 host with two nics where NIC0 has network-tag
cloud-xenbr0 and NIC1 has network-tag cloud-xenbr1.
3. Deploy Guest VMs using above physical networks
4. Change traffic labels of each traffic type to different values that do not
exist on hypervisor.
5. Reconnect the Host and observe the NPE. Host is stuck in Disconnected State
================================
NullPointerException - ReconnectHost Job:
================================
2012-09-27 15:06:19,303 DEBUG [cloud.async.AsyncJobManagerImpl]
(catalina-exec-10:null) submit async job-85, details: AsyncJobVO {id:85,
userId: 2, accountId: 2, sessionKey: null, instanceType: Host, instanceId: 1,
cmd: com.cloud.api.commands.ReconnectHostCmd, cmdOriginator: null, cmdInfo:
{"id":"d6c8a9a3-e998-4462-9db8-91adc80e12b8","response":"json","sessionkey":"zXjqIlsgiABR8Ty4cYpLI+hNitE\u003d","ctxUserId":"2","_":"1348783868314","ctxAccountId":"2","ctxStartEventId":"339"},
cmdVersion: 0, callbackType: 0, callbackAddress: null, status: 0,
processStatus: 0, resultCode: 0, result: null, initMsid: 7471666038533,
completeMsid: null, lastUpdated: null, lastPolled: null, created: null}
2012-09-27 15:06:19,307 DEBUG [cloud.async.AsyncJobManagerImpl]
(Job-Executor-62:job-85) Executing com.cloud.api.commands.ReconnectHostCmd for
job-85
2012-09-27 15:06:19,321 INFO [agent.manager.AgentManagerImpl]
(AgentTaskPool-3:null) Host 1 is disconnecting with event ShutdownRequested
2012-09-27 15:06:19,324 DEBUG [agent.manager.AgentManagerImpl]
(AgentTaskPool-3:null) The next status of agent 1is Disconnected, current
status is Up
2012-09-27 15:06:19,325 DEBUG [agent.manager.AgentManagerImpl]
(AgentTaskPool-3:null) Deregistering link for 1 with state Disconnected
2012-09-27 15:06:19,325 DEBUG [agent.manager.AgentManagerImpl]
(AgentTaskPool-3:null) Remove Agent : 1
2012-09-27 15:06:19,325 DEBUG [agent.manager.DirectAgentAttache]
(AgentTaskPool-3:null) Processing disconnect 1
2012-09-27 15:06:19,325 DEBUG [agent.manager.AgentManagerImpl]
(AgentTaskPool-3:null) Sending Disconnect to listener:
com.cloud.hypervisor.xen.discoverer.XcpServerDiscoverer$$EnhancerByCGLIB$$eee040ed
2012-09-27 15:06:19,326 DEBUG [agent.manager.AgentManagerImpl]
(AgentTaskPool-3:null) Sending Disconnect to listener:
com.cloud.hypervisor.vmware.manager.VmwareManagerImpl$$EnhancerByCGLIB$$20bd3dd8
2012-09-27 15:06:19,326 DEBUG [agent.manager.AgentManagerImpl]
(AgentTaskPool-3:null) Sending Disconnect to listener:
com.cloud.vm.ClusteredVirtualMachineManagerImpl$$EnhancerByCGLIB$$eba8cb92
2012-09-27 15:06:19,326 DEBUG [agent.manager.AgentManagerImpl]
(AgentTaskPool-3:null) Sending Disconnect to listener:
com.cloud.network.security.SecurityGroupListener
2012-09-27 15:06:19,326 DEBUG [agent.manager.AgentManagerImpl]
(AgentTaskPool-3:null) Sending Disconnect to listener:
com.cloud.storage.listener.StoragePoolMonitor
2012-09-27 15:06:19,326 DEBUG [agent.manager.AgentManagerImpl]
(AgentTaskPool-3:null) Sending Disconnect to listener:
com.cloud.storage.secondary.SecondaryStorageListener
2012-09-27 15:06:19,326 DEBUG [agent.manager.AgentManagerImpl]
(AgentTaskPool-3:null) Sending Disconnect to listener:
com.cloud.network.NetworkManagerImpl$$EnhancerByCGLIB$$9568aaae
2012-09-27 15:06:19,326 DEBUG [agent.manager.AgentManagerImpl]
(AgentTaskPool-3:null) Sending Disconnect to listener:
com.cloud.agent.manager.AgentMonitor$$EnhancerByCGLIB$$6092d0e
2012-09-27 15:06:19,326 DEBUG [agent.manager.AgentManagerImpl]
(AgentTaskPool-3:null) Sending Disconnect to listener:
com.cloud.storage.download.DownloadListener
2012-09-27 15:06:19,326 DEBUG [agent.manager.AgentManagerImpl]
(AgentTaskPool-3:null) Sending Disconnect to listener:
com.cloud.storage.upload.UploadListener
2012-09-27 15:06:19,326 DEBUG [cloud.async.AsyncJobManagerImpl]
(Job-Executor-62:job-85) Complete async job-85, jobStatus: 1, resultCode: 0,
result: com.cloud.api.response.HostResponse@d9f134e
2012-09-27 15:06:19,328 DEBUG [agent.manager.AgentManagerImpl]
(AgentTaskPool-3:null) Sending Disconnect to listener:
com.cloud.storage.LocalStoragePoolListener$$EnhancerByCGLIB$$95f75342
2012-09-27 15:06:19,329 DEBUG [agent.manager.AgentManagerImpl]
(AgentTaskPool-3:null) Sending Disconnect to listener:
com.cloud.capacity.StorageCapacityListener
2012-09-27 15:06:19,329 DEBUG [agent.manager.AgentManagerImpl]
(AgentTaskPool-3:null) Sending Disconnect to listener:
com.cloud.capacity.ComputeCapacityListener
2012-09-27 15:06:19,329 DEBUG [agent.manager.AgentManagerImpl]
(AgentTaskPool-3:null) Sending Disconnect to listener:
com.cloud.consoleproxy.ConsoleProxyListener
2012-09-27 15:06:19,330 DEBUG [agent.manager.AgentManagerImpl]
(AgentTaskPool-3:null) Sending Disconnect to listener:
com.cloud.network.SshKeysDistriMonitor
2012-09-27 15:06:19,330 DEBUG [agent.manager.AgentManagerImpl]
(AgentTaskPool-3:null) Sending Disconnect to listener:
com.cloud.network.router.VpcVirtualNetworkApplianceManagerImpl$$EnhancerByCGLIB$$9861d236
2012-09-27 15:06:19,330 DEBUG [agent.manager.AgentManagerImpl]
(AgentTaskPool-3:null) Sending Disconnect to listener:
com.cloud.network.NetworkUsageManagerImpl$DirectNetworkStatsListener
2012-09-27 15:06:19,330 DEBUG [cloud.network.NetworkUsageManagerImpl]
(AgentTaskPool-3:null) Disconnected called on 1 with status Disconnected
2012-09-27 15:06:19,330 DEBUG [cloud.host.Status] (AgentTaskPool-3:null)
Transition:[Resource state = Enabled, Agent event = ShutdownRequested, Host id
= 1, name = Rack3Host17.lab.vmops.com]
2012-09-27 15:06:19,337 DEBUG [cloud.async.AsyncJobManagerImpl]
(Job-Executor-62:job-85) Done executing com.cloud.api.commands.ReconnectHostCmd
for job-85
2012-09-27 15:06:19,363 DEBUG [cloud.host.Status] (AgentTaskPool-3:null) Agent
status update: [id = 1; name = Rack3Host17.lab.vmops.com; old status = Up;
event = ShutdownRequested; new status = Disconnected; old update count = 5; new
update count = 6]
2012-09-27 15:06:19,363 DEBUG [agent.manager.ClusteredAgentManagerImpl]
(AgentTaskPool-3:null) Notifying other nodes of to disconnect
2012-09-27 15:06:19,585 DEBUG [agent.manager.DirectAgentAttache]
(DirectAgent-133:null) Ping from 6
2012-09-27 15:06:19,719 DEBUG [agent.manager.DirectAgentAttache]
(DirectAgent-56:null) Ping from 7
2012-09-27 15:06:24,437 DEBUG [cloud.async.AsyncJobManagerImpl]
(catalina-exec-12:null) Async job-85 completed
2012-09-27 15:06:36,655 DEBUG [storage.secondary.SecondaryStorageManagerImpl]
(secstorage-1:null) Zone 1 is not ready to launch secondary storage VM yet
2012-09-27 15:06:36,750 DEBUG [cloud.consoleproxy.ConsoleProxyManagerImpl]
(consoleproxy-1:null) Zone 1 is not ready to launch console proxy yet
2012-09-27 15:06:37,192 DEBUG
[network.router.VirtualNetworkApplianceManagerImpl]
(RouterStatusMonitor-1:null) Found 5 routers.
2012-09-27 15:06:42,117 DEBUG [agent.manager.ClusteredAgentManagerImpl]
(ClusteredAgentManager Timer:null) Found 1 unmanaged direct hosts, processing
connect for them...
2012-09-27 15:06:42,117 DEBUG [agent.manager.ClusteredAgentManagerImpl]
(ClusteredAgentManager Timer:null) Loading directly connected host
1(Rack3Host17.lab.vmops.com)
2012-09-27 15:06:42,204 DEBUG [agent.manager.AgentManagerImpl]
(AgentTaskPool-4:null) Simulating start for resource
8ca2f971-87c5-45d4-9ca3-348c1461ded2 id 1
2012-09-27 15:06:42,449 DEBUG [xen.resource.CitrixResourceBase]
(AgentTaskPool-4:null) Management network is on
pif=e1dec15e-e505-98c5-cb53-5888f41e8251
2012-09-27 15:06:42,463 WARN [xen.resource.CitrixResourceBase]
(AgentTaskPool-4:null) Unable to get host information for 10.223.59.2
java.lang.NullPointerException
at
com.cloud.hypervisor.xen.resource.CitrixResourceBase.getHostInfo(CitrixResourceBase.java:4331)
at
com.cloud.hypervisor.xen.resource.CitrixResourceBase.initialize(CitrixResourceBase.java:4460)
at
com.cloud.hypervisor.xen.resource.XenServer56Resource.initialize(XenServer56Resource.java:328)
at
com.cloud.resource.ResourceManagerImpl.createHostAndAgent(ResourceManagerImpl.java:1598)
at
com.cloud.resource.ResourceManagerImpl.createHostAndAgent(ResourceManagerImpl.java:1668)
at
com.cloud.agent.manager.AgentManagerImpl$SimulateStartTask.run(AgentManagerImpl.java:1195)
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)
2012-09-27 15:06:42,464 WARN [xen.resource.CitrixResourceBase]
(AgentTaskPool-4:null) Unable to get host information for 10.223.59.2
2012-09-27 15:06:42,464 INFO [cloud.resource.ResourceManagerImpl]
(AgentTaskPool-4:null) Unable to fully initialize the agent because no
StartupCommands are returned
=======
Git Info:
=======
Git Revision: 30b19887fd05c7694f8fdf45be9fe9b02d90b1d1
Git URL: https://git-wip-us.apache.org/repos/asf/incubator-cloudstack.git
--
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
