angeline shen created CLOUDSTACK-5448:
-----------------------------------------

             Summary: site-to-site VPN VR-to-VR [KVM]  Fail to establish VPN 
connections between two VPCs
                 Key: CLOUDSTACK-5448
                 URL: https://issues.apache.org/jira/browse/CLOUDSTACK-5448
             Project: CloudStack
          Issue Type: Bug
      Security Level: Public (Anyone can view this level - this is the default.)
          Components: Management Server
    Affects Versions: 4.3.0
         Environment: MS    10.223.130.59    
CloudPlatform-4.3-900-rhel6.3.tar.gz
host   KVM   10.223.51.3      10.223.51.4

            Reporter: angeline shen
            Priority: Critical
             Fix For: 4.3.0


1. admin login, creates vpc1 and vpc2, Router site-to-site VPNS, create VPN 
customer gateway 

2. attempt to establish VPN connections between 2 VPCs failed with Null pointer 
exception:

2013-12-10 11:16:35,808 DEBUG [c.c.a.ApiServlet] (catalina-exec-15:ctx-dc293bdb 
ctx-3213721c) ===END===  10.215.3.21 -- GET  
command=createVpnConnection&response=json&sessionkey=M2eYCkq%2FsdqEc3dp3uvp7ke8jHg%3D&s2svpngatewayid=8bb2ebf0-11de-4fb3-bd86-438f7b6d4a87&s2scustomergatewayid=086f3de9-5f8c-4bcb-9c7a-0f097acea8f4&passive=true&_=1386703355792
2013-12-10 11:16:35,811 INFO  [o.a.c.f.j.i.AsyncJobMonitor] 
(Job-Executor-65:ctx-93679f8e) Add job-69 into job monitoring
2013-12-10 11:16:35,811 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] 
(Job-Executor-65:ctx-93679f8e) Executing AsyncJobVO {id:69, userId: 2, 
accountId: 2, instanceType: None, instanceId: 4, cmd: 
org.apache.cloudstack.api.command.user.vpn.CreateVpnConnectionCmd, cmdInfo: 
{"id":"4","response":"json","sessionkey":"M2eYCkq/sdqEc3dp3uvp7ke8jHg\u003d","s2scustomergatewayid":"086f3de9-5f8c-4bcb-9c7a-0f097acea8f4","cmdEventType":"VPN.S2S.CONNECTION.CREATE","ctxUserId":"2","s2svpngatewayid":"8bb2ebf0-11de-4fb3-bd86-438f7b6d4a87","passive":"true","httpmethod":"GET","_":"1386703355792","ctxAccountId":"2","ctxStartEventId":"253"},
 cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0, result: 
null, initMsid: 7692017993539, completeMsid: null, lastUpdated: null, 
lastPolled: null, created: null}
2013-12-10 11:16:35,863 DEBUG [c.c.a.t.Request] (Job-Executor-65:ctx-93679f8e 
ctx-3213721c) Seq 1-1648170383: Sending  { Cmd , MgmtId: 7692017993539, via: 
1(Rack2Host18.lab.vmops.com), Ver: v1, Flags: 100101, 
[{"com.cloud.agent.api.routing.Site2SiteVpnCfgCommand":{"create":true,"localPublicIp":"10.223.123.7","localGuestCidr":"10.1.1.1/16","localPublicGateway":"10.223.123.1","peerGatewayIp":"10.233.123.36","peerGuestCidrList":"10.3.1.1/16","ipsecPsk":"1237","ikePolicy":"3des-md5","espPolicy":"3des-md5","ikeLifetime":86400,"espLifetime":3600,"dpd":false,"passive":true,"accessDetails":{"zone.network.type":"Advanced","router.ip":"169.254.0.169","router.name":"r-3-VM"},"wait":0}}]
 }
2013-12-10 11:16:36,276 DEBUG [c.c.a.t.Request] (AgentManager-Handler-2:null) 
Seq 1-1648170383: Processing:  { Ans: , MgmtId: 7692017993539, via: 1, Ver: v1, 
Flags: 100, [{"com.cloud.agent.api.Answer":{"result":true,"wait":0}}] }
2013-12-10 11:16:36,277 DEBUG [c.c.a.m.AgentAttache] 
(AgentManager-Handler-2:null) Seq 1-1648170383: No more commands found
2013-12-10 11:16:36,277 DEBUG [c.c.a.t.Request] (Job-Executor-65:ctx-93679f8e 
ctx-3213721c) Seq 1-1648170383: Received:  { Ans: , MgmtId: 7692017993539, via: 
1, Ver: v1, Flags: 100, { Answer } }
2013-12-10 11:16:36,295 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] 
(Job-Executor-65:ctx-93679f8e ctx-3213721c) Complete async job-69, jobStatus: 
SUCCEEDED, resultCode: 0, result: 
org.apache.cloudstack.api.response.Site2SiteVpnConnectionResponse/vpnconnection/{"id":"813b96bd-4fd4-4861-852d-9c93eb5d3076","s2svpngatewayid":"8bb2ebf0-11de-4fb3-bd86-438f7b6d4a87","publicip":"10.223.123.7","s2scustomergatewayid":"086f3de9-5f8c-4bcb-9c7a-0f097acea8f4","gateway":"10.233.123.36","cidrlist":"10.3.1.1/16","ipsecpsk":"1237","ikepolicy":"3des-md5","esppolicy":"3des-md5","ikelifetime":86400,"esplifetime":3600,"dpd":false,"state":"Disconnected","passive":true,"account":"admin","domainid":"500616b0-6124-11e3-8adc-06fef0000743","domain":"ROOT","created":"2013-12-10T11:16:35-0800"}
2013-12-10 11:16:36,304 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] 
(Job-Executor-65:ctx-93679f8e) Done executing 
org.apache.cloudstack.api.command.user.vpn.CreateVpnConnectionCmd for job-69
2013-12-10 11:16:36,309 INFO  [o.a.c.f.j.i.AsyncJobMonitor] 
(Job-Executor-65:ctx-93679f8e) Remove job-69 from job monitoring
2013-12-10 11:16:37,614 DEBUG [c.c.a.ApiServlet] 
(catalina-exec-12:ctx-3db6f358) ===START===  10.215.3.21 -- GET  
command=queryAsyncJobResult&jobId=ef24d7ad-5824-4584-b1a5-5dd7f84a3b3e&response=json&sessionkey=M2eYCkq%2FsdqEc3dp3uvp7ke8jHg%3D&_=1386703357666
2013-12-10 11:16:37,640 DEBUG [c.c.a.ApiServlet] (catalina-exec-12:ctx-3db6f358 
ctx-cca6de7b) ===END===  10.215.3.21 -- GET  
command=queryAsyncJobResult&jobId=ef24d7ad-5824-4584-b1a5-5dd7f84a3b3e&response=json&sessionkey=M2eYCkq%2FsdqEc3dp3uvp7ke8jHg%3D&_=1386703357666
2013-12-10 11:16:37,744 DEBUG [c.c.n.r.VirtualNetworkApplianceManagerImpl] 
(RouterStatusMonitor-1:ctx-5794ddc4) Found 1 routers to update status. 
2013-12-10 11:16:37,768 DEBUG [c.c.a.t.Request] 
(RouterStatusMonitor-1:ctx-5794ddc4) Seq 1-1648170384: Sending  { Cmd , MgmtId: 
7692017993539, via: 1(Rack2Host18.lab.vmops.com), Ver: v1, Flags: 100111, 
[{"com.cloud.agent.api.CheckS2SVpnConnectionsCommand":{"vpnIps":["10.233.123.36"],"accessDetails":{"router.ip":"169.254.0.169","router.name":"r-3-VM"},"wait":30}}]
 }
2013-12-10 11:16:37,868 DEBUG [c.c.a.t.Request] (AgentManager-Handler-7:null) 
Seq 1-1648170384: Processing:  { Ans: , MgmtId: 7692017993539, via: 1, Ver: v1, 
Flags: 110, 
[{"com.cloud.agent.api.Answer":{"result":false,"details":"java.lang.NullPointerException\n\tat
 
com.cloud.agent.api.CheckS2SVpnConnectionsAnswer.parseDetails(CheckS2SVpnConnectionsAnswer.java:43)\n\tat
 
com.cloud.agent.api.CheckS2SVpnConnectionsAnswer.<init>(CheckS2SVpnConnectionsAnswer.java:38)\n\tat
 
com.cloud.agent.resource.virtualnetwork.VirtualRoutingResource.execute(VirtualRoutingResource.java:673)\n\tat
 
com.cloud.agent.resource.virtualnetwork.VirtualRoutingResource.executeRequest(VirtualRoutingResource.java:171)\n\tat
 
com.cloud.hypervisor.kvm.resource.LibvirtComputingResource.executeRequest(LibvirtComputingResource.java:1298)\n\tat
 com.cloud.agent.Agent.processRequest(Agent.java:498)\n\tat 
com.cloud.agent.Agent$AgentRequestHandler.doTask(Agent.java:806)\n\tat 
com.cloud.utils.nio.Task.run(Task.java:83)\n\tat 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1110)\n\tat
 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:603)\n\tat
 java.lang.Thread.run(Thread.java:679)\n","wait":0}}] }
2013-12-10 11:16:37,868 DEBUG [c.c.a.m.AgentAttache] 
(AgentManager-Handler-7:null) Seq 1-1648170384: No more commands found
2013-12-10 11:16:37,869 DEBUG [c.c.a.t.Request] 
(RouterStatusMonitor-1:ctx-5794ddc4) Seq 1-1648170384: Received:  { Ans: , 
MgmtId: 7692017993539, via: 1, Ver: v1, Flags: 110, { Answer } }
2013-12-10 11:16:37,869 DEBUG [c.c.a.m.AgentManagerImpl] 
(RouterStatusMonitor-1:ctx-5794ddc4) Details from executing class 
com.cloud.agent.api.CheckS2SVpnConnectionsCommand: 
java.lang.NullPointerException
        at 
com.cloud.agent.api.CheckS2SVpnConnectionsAnswer.parseDetails(CheckS2SVpnConnectionsAnswer.java:43)
        at 
com.cloud.agent.api.CheckS2SVpnConnectionsAnswer.<init>(CheckS2SVpnConnectionsAnswer.java:38)
        at 
com.cloud.agent.resource.virtualnetwork.VirtualRoutingResource.execute(VirtualRoutingResource.java:673)
        at 
com.cloud.agent.resource.virtualnetwork.VirtualRoutingResource.executeRequest(VirtualRoutingResource.java:171)
        at 
com.cloud.hypervisor.kvm.resource.LibvirtComputingResource.executeRequest(LibvirtComputingResource.java:1298)
        at com.cloud.agent.Agent.processRequest(Agent.java:498)
        at com.cloud.agent.Agent$AgentRequestHandler.doTask(Agent.java:806)
        at com.cloud.utils.nio.Task.run(Task.java:83)
        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-12-10 11:16:37,869 WARN  [c.c.n.r.VirtualNetworkApplianceManagerImpl] 
(RouterStatusMonitor-1:ctx-5794ddc4) Unable to update router r-3-VM's VPN 
connection status
2013-12-10 11:16:37,873 DEBUG [c.c.n.r.VirtualNetworkApplianceManagerImpl] 
(RouterStatusMonitor-1:ctx-5794ddc4) Found 0 networks to update RvR status.  







--
This message was sent by Atlassian JIRA
(v6.1.4#6159)

Reply via email to