[ 
https://issues.apache.org/jira/browse/CLOUDSTACK-4576?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=13755163#comment-13755163
 ] 

Sudha Ponnaganti commented on CLOUDSTACK-4576:
----------------------------------------------

log snippet for disassociate IP address: 


013-08-30 20:39:47,617 DEBUG [cloud.api.ApiServlet] (catalina-exec-1:null) 
===START=== 10.252.192.43 -- GET 
command=disassociateIpAddress&response=json&sessionkey=UAGLMmvHcEMPIoWbSRGxioeyA6Y%3D&id=f6c19cd2-cd72-4ae5-8f40-ae1687aea4ca&_=1377875402891
 2013-08-30 20:39:47,628 DEBUG [agent.manager.DirectAgentAttache] 
(DirectAgent-270:null) Ping from 3
 2013-08-30 20:39:47,653 DEBUG [cloud.async.AsyncJobManagerImpl] 
(catalina-exec-1:null) submit async job-146 = [ 
52178d4b-b132-497f-8df8-6844a9e441b2 ], details: AsyncJobVO {id:146, userId: 3, 
accountId: 3, sessionKey: null, instanceType: IpAddress, instanceId: 35, cmd: 
org.apache.cloudstack.api.command.user.address.DisassociateIPAddrCmd, 
cmdOriginator: null, cmdInfo: 
{"response":"json","id":"f6c19cd2-cd72-4ae5-8f40-ae1687aea4ca","sessionkey":"UAGLMmvHcEMPIoWbSRGxioeyA6Y\u003d","cmdEventType":"PORTABLE.IPRELEASE","ctxUserId":"3","httpmethod":"GET","_":"1377875402891","ctxAccountId":"3","ctxStartEventId":"509"},
 cmdVersion: 0, callbackType: 0, callbackAddress: null, status: 0, 
processStatus: 0, resultCode: 0, result: null, initMsid: 7280707764394, 
completeMsid: null, lastUpdated: null, lastPolled: null, created: null}
 2013-08-30 20:39:47,656 DEBUG [cloud.api.ApiServlet] (catalina-exec-1:null) 
===END=== 10.252.192.43 -- GET 
command=disassociateIpAddress&response=json&sessionkey=UAGLMmvHcEMPIoWbSRGxioeyA6Y%3D&id=f6c19cd2-cd72-4ae5-8f40-ae1687aea4ca&_=1377875402891
 2013-08-30 20:39:47,658 DEBUG [cloud.async.AsyncJobManagerImpl] 
(Job-Executor-72:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) Executing 
org.apache.cloudstack.api.command.user.address.DisassociateIPAddrCmd for 
job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]
 2013-08-30 20:39:47,682 DEBUG [cloud.async.AsyncJobManagerImpl] 
(Job-Executor-72:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) Sync 
job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ] execution on object 
network.214
 2013-08-30 20:39:47,695 DEBUG [cloud.async.AsyncJobManagerImpl] 
(Job-Executor-72:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) job 
org.apache.cloudstack.api.command.user.address.DisassociateIPAddrCmd for 
job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ] was queued, processing the 
queue.
 2013-08-30 20:39:47,704 DEBUG [cloud.async.AsyncJobManagerImpl] 
(Job-Executor-72:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) Executing 
sync queue item: SyncQueueItemVO {id:83, queueId: 82, contentType: AsyncJob, 
contentId: 146, lastProcessMsid: 7280707764394, lastprocessNumber: 2, 
lastProcessTime: Fri Aug 30 20:39:47 IST 2013, created: Fri Aug 30 20:39:47 IST 
2013}
 2013-08-30 20:39:47,706 DEBUG [cloud.async.AsyncJobManagerImpl] 
(Job-Executor-72:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) Schedule 
queued job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]
 2013-08-30 20:39:47,714 DEBUG [cloud.async.SyncQueueManagerImpl] 
(Job-Executor-72:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) There is a 
pending process in sync queue(id: 82)
 2013-08-30 20:39:47,716 DEBUG [cloud.async.AsyncJobManagerImpl] 
(Job-Executor-73:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) Executing 
org.apache.cloudstack.api.command.user.address.DisassociateIPAddrCmd for 
job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]
 2013-08-30 20:39:47,741 DEBUG [cloud.user.AccountManagerImpl] 
(Job-Executor-73:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) Access to 
Ip[10.147.33.3-2] granted to 
Acct[597f3956-cd84-4574-a5d7-1e09b9eed998-dom1Acc1] by 
DomainChecker_EnhancerByCloudStack_b7983160
 2013-08-30 20:39:47,744 DEBUG [cloud.network.NetworkManagerImpl] 
(Job-Executor-73:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) Revoking 
all Firewallrules as a part of public IP id=35 release...
 2013-08-30 20:39:47,746 DEBUG [network.firewall.FirewallManagerImpl] 
(Job-Executor-73:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) Releasing 
1 firewall rules for ip id=35
 2013-08-30 20:39:47,757 DEBUG [cloud.user.AccountManagerImpl] 
(Job-Executor-73:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) Access to 
Rule[18-Firewall-Active] granted to 
Acct[597f3956-cd84-4574-a5d7-1e09b9eed998-dom1Acc1] by 
DomainChecker_EnhancerByCloudStack_b7983160
 2013-08-30 20:39:47,761 DEBUG [cloud.user.AccountManagerImpl] 
(Job-Executor-73:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) Access to 
Rule[18-Firewall-Active] granted to 
Acct[597f3956-cd84-4574-a5d7-1e09b9eed998-dom1Acc1] by 
DomainChecker_EnhancerByCloudStack_b7983160
 2013-08-30 20:39:47,780 DEBUG [cloud.user.AccountManagerImpl] 
(Job-Executor-73:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) Access to 
Rule[18-Firewall-Revoke] granted to 
Acct[597f3956-cd84-4574-a5d7-1e09b9eed998-dom1Acc1] by 
DomainChecker_EnhancerByCloudStack_b7983160
 2013-08-30 20:39:47,797 DEBUG 
[network.router.VirtualNetworkApplianceManagerImpl] (Job-Executor-73:job-146 = 
[ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) Applying firewall rules in network 
Ntwk[214|Guest|8]
 2013-08-30 20:39:47,812 DEBUG [agent.transport.Request] 
(Job-Executor-73:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) Seq 
3-663552128: Sending { Cmd , MgmtId: 7280707764394, via: 3, Ver: v1, Flags: 
100001, 
[{"com.cloud.agent.api.routing.SetFirewallRulesCommand":{"rules":[{"id":18,"srcIp":"10.147.33.3","protocol":"tcp","srcPortRange":[22,22],"revoked":true,"alreadyAdded":false,"sourceCidrList":["0.0.0.0/0"],"purpose":"Firewall","trafficType":"Ingress","defaultEgressPolicy":false}],"accessDetails":{"router.guest.ip":"10.1.1.1","firewall.egress.default":"false","zone.network.type":"Advanced","router.ip":"169.254.3.37","router.name":"r-18-VM"},"wait":0}}]
 }
 2013-08-30 20:39:47,813 DEBUG [agent.transport.Request] 
(Job-Executor-73:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) Seq 
3-663552128: Executing: { Cmd , MgmtId: 7280707764394, via: 3, Ver: v1, Flags: 
100001, 
[{"com.cloud.agent.api.routing.SetFirewallRulesCommand":{"rules":[{"id":18,"srcIp":"10.147.33.3","protocol":"tcp","srcPortRange":[22,22],"revoked":true,"alreadyAdded":false,"sourceCidrList":["0.0.0.0/0"],"purpose":"Firewall","trafficType":"Ingress","defaultEgressPolicy":false}],"accessDetails":{"router.guest.ip":"10.1.1.1","firewall.egress.default":"false","zone.network.type":"Advanced","router.ip":"169.254.3.37","router.name":"r-18-VM"},"wait":0}}]
 }
 2013-08-30 20:39:47,813 DEBUG [agent.manager.DirectAgentAttache] 
(DirectAgent-94:null) Seq 3-663552128: Executing request
 2013-08-30 20:39:48,243 DEBUG [agent.manager.DirectAgentAttache] 
(DirectAgent-94:null) Seq 3-663552128: Response Received:
 

Log snippet for another IPASSOC : 

13-08-30 20:39:48,294 DEBUG [network.router.VirtualNetworkApplianceManagerImpl] 
(Job-Executor-73:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) Applying 
static nat rules in network Ntwk[214|Guest|8]
 2013-08-30 20:39:48,308 DEBUG [agent.transport.Request] 
(Job-Executor-73:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) Seq 
3-663552129: Sending { Cmd , MgmtId: 7280707764394, via: 3, Ver: v1, Flags: 
100001, 
[{"com.cloud.agent.api.routing.SetStaticNatRulesCommand":{"rules":[{"dstIp":"10.1.1.21","id":0,"srcIp":"10.147.33.3","revoked":true,"alreadyAdded":false,"purpose":"StaticNat","icmpType":0,"icmpCode":0,"defaultEgressPolicy":false}],"accessDetails":{"router.guest.ip":"10.1.1.1","zone.network.type":"Advanced","router.ip":"169.254.3.37","router.name":"r-18-VM"},"wait":0}}]
 }
 2013-08-30 20:39:48,309 DEBUG [agent.transport.Request] 
(Job-Executor-73:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) Seq 
3-663552129: Executing: { Cmd , MgmtId: 7280707764394, via: 3, Ver: v1, Flags: 
100001, 
[{"com.cloud.agent.api.routing.SetStaticNatRulesCommand":{"rules":[{"dstIp":"10.1.1.21","id":0,"srcIp":"10.147.33.3","revoked":true,"alreadyAdded":false,"purpose":"StaticNat","icmpType":0,"icmpCode":0,"defaultEgressPolicy":false}],"accessDetails":{"router.guest.ip":"10.1.1.1","zone.network.type":"Advanced","router.ip":"169.254.3.37","router.name":"r-18-VM"},"wait":0}}]
 }
 2013-08-30 20:39:48,309 DEBUG [agent.manager.DirectAgentAttache] 
(DirectAgent-30:null) Seq 3-663552129: Executing request
 2013-08-30 20:39:48,710 DEBUG [agent.manager.DirectAgentAttache] 
(DirectAgent-94:null) Seq 3-663552005: Executing request
 2013-08-30 20:39:48,745 DEBUG [agent.manager.DirectAgentAttache] 
(DirectAgent-30:null) Seq 3-663552129: Response Received:
 2013-08-30 20:39:48,746 DEBUG [agent.transport.Request] (DirectAgent-30:null) 
Seq 3-663552129: Processing: { Ans: , MgmtId: 7280707764394, via: 3, Ver: v1, 
Flags: 0, 
[{"com.cloud.agent.api.routing.SetStaticNatRulesAnswer":{"results":[null],"result":true,"wait":0}}]
 }
 2013-08-30 20:39:48,746 DEBUG [agent.transport.Request] 
(Job-Executor-73:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) Seq 
3-663552129: Received: { Ans: , MgmtId: 7280707764394, via: 3, Ver: v1, Flags: 
0, { SetStaticNatRulesAnswer } }
 2013-08-30 20:39:48,781 DEBUG 
[network.router.VirtualNetworkApplianceManagerImpl] (Job-Executor-73:job-146 = 
[ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) Applying ip association in network 
Ntwk[214|Guest|8]
 2013-08-30 20:39:48,846 DEBUG [agent.transport.Request] 
(Job-Executor-73:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) Seq 
3-663552130: Sending { Cmd , MgmtId: 7280707764394, via: 3, Ver: v1, Flags: 
100001, 
[{"com.cloud.agent.api.routing.IpAssocCommand":{"ipAddresses":[{"accountId":3,"publicIp":"10.147.33.3","sourceNat":true,"add":false,"oneToOneNat":true,"firstIP":true,"vlanId":"33","vlanGateway":"10.147.33.1","vlanNetmask":"255.255.255.128","vifMacAddress":"06:2c:55:00:00:0d","networkRate":200,"trafficType":"Public"}],"accessDetails":{"router.guest.ip":"10.1.1.1","zone.network.type":"Advanced","router.ip":"169.254.3.37","router.name":"r-18-VM"},"wait":0}},{"com.cloud.agent.api.routing.IpAssocCommand":{"ipAddresses":[{"accountId":3,"publicIp":"10.147.54.162","sourceNat":true,"add":true,"oneToOneNat":false,"firstIP":true,"vlanId":"54","vlanGateway":"10.147.54.1","vlanNetmask":"255.255.255.0","vifMacAddress":"06:2e:a8:00:00:0d","networkRate":200,"trafficType":"Public"}],"accessDetails":{"router.guest.ip":"10.1.1.1","zone.network.type":"Advanced","router.ip":"169.254.3.37","router.name":"r-18-VM"},"wait":0}}]
 }
 2013-08-30 20:39:48,847 DEBUG [agent.transport.Request] 
(Job-Executor-73:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) Seq 
3-663552130: Executing: { Cmd , MgmtId: 7280707764394, via: 3, Ver: v1, Flags: 
100001, 
[{"com.cloud.agent.api.routing.IpAssocCommand":{"ipAddresses":[{"accountId":3,"publicIp":"10.147.33.3","sourceNat":true,"add":false,"oneToOneNat":true,"firstIP":true,"vlanId":"33","vlanGateway":"10.147.33.1","vlanNetmask":"255.255.255.128","vifMacAddress":"06:2c:55:00:00:0d","networkRate":200,"trafficType":"Public"}],"accessDetails":{"router.guest.ip":"10.1.1.1","zone.network.type":"Advanced","router.ip":"169.254.3.37","router.name":"r-18-VM"},"wait":0}},{"com.cloud.agent.api.routing.IpAssocCommand":{"ipAddresses":[{"accountId":3,"publicIp":"10.147.54.162","sourceNat":true,"add":true,"oneToOneNat":false,"firstIP":true,"vlanId":"54","vlanGateway":"10.147.54.1","vlanNetmask":"255.255.255.0","vifMacAddress":"06:2e:a8:00:00:0d","networkRate":200,"trafficType":"Public"}],"accessDetails":{"router.guest.ip":"10.1.1.1","zone.network.type":"Advanced","router.ip":"169.254.3.37","router.name":"r-18-VM"},"wait":0}}]
 }
 2013-08-30 20:39:48,848 DEBUG [agent.manager.DirectAgentAttache] 
(DirectAgent-93:null) Seq 3-663552130: Executing request
 2013-08-30 20:39:48,915 DEBUG [agent.manager.DirectAgentAttache] 
(DirectAgent-94:null) Seq 3-663552005: Response Received:
 2013-08-30 20:39:48,915 DEBUG [agent.transport.Request] (DirectAgent-94:null) 
Seq 3-663552005: Processing: { Ans: , MgmtId: 7280707764394, via: 3, Ver: v1, 
Flags: 10, 
[{"com.cloud.agent.api.ClusterSyncAnswer":{"_clusterId":2,"_newStates":{},"_isExecuted":false,"result":true,"wait":0}}]
 }
 2013-08-30 20:39:48,940 DEBUG [xen.resource.CitrixResourceBase] 
(DirectAgent-93:null) Found a network called 
VLAN-3d877b20-6aa0-1610-5552-30b35effb8ac-33 on host=10.147.40.26; 
Network=931d370f-37f8-84b2-74aa-ae3b33dc705e; 
pif=a278f5d2-a723-dda1-04c6-cc9c8f78ce1d
 2013-08-30 20:39:49,264 DEBUG [agent.manager.AgentManagerImpl] 
(AgentManager-Handler-4:null) SeqA 5-1050: Processing Seq 5-1050: { Cmd , 
MgmtId: -1, via: 5, Ver: v1, Flags: 11, 
[{"com.cloud.agent.api.ConsoleProxyLoadReportCommand":{"_proxyVmId":3,"_loadInfo":"{\n
 \"connections\": []\n}","wait":0}}] }
 2013-08-30 20:39:49,377 DEBUG [agent.manager.AgentManagerImpl] 
(AgentManager-Handler-4:null) SeqA 5-1050: Sending Seq 5-1050: { Ans: , MgmtId: 
7280707764394, via: 5, Ver: v1, Flags: 100010, 
[{"com.cloud.agent.api.AgentControlAnswer":{"result":true,"wait":0}}] }
 2013-08-30 20:39:50,725 DEBUG [cloud.api.ApiServlet] (catalina-exec-9:null) 
===START=== 10.252.192.43 -- GET 
command=queryAsyncJobResult&jobId=52178d4b-b132-497f-8df8-6844a9e441b2&response=json&sessionkey=UAGLMmvHcEMPIoWbSRGxioeyA6Y%3D&_=1377875406038
 2013-08-30 20:39:50,852 DEBUG [cloud.api.ApiServlet] (catalina-exec-9:null) 
===END=== 10.252.192.43 -- GET 
command=queryAsyncJobResult&jobId=52178d4b-b132-497f-8df8-6844a9e441b2&response=json&sessionkey=UAGLMmvHcEMPIoWbSRGxioeyA6Y%3D&_=1377875406038
 2013-08-30 20:39:50,902 INFO [xen.resource.XenServer56Resource] 
(DirectAgent-93:null) Catch com.xensource.xenapi.Types$InternalError: failed to 
destory VLAN eth0 on host 6e4e4d42-8d51-49b3-a67b-3bfd40317157 due to The 
server failed to handle your request, due to an internal error. The given 
message may give details useful for debugging the problem.
 2013-08-30 20:39:50,993 DEBUG [xen.resource.CitrixResourceBase] 
(DirectAgent-93:null) Found a network called 
VLAN-3d877b20-6aa0-1610-5552-30b35effb8ac-54 on host=10.147.40.26; 
Network=34660ed8-6eaa-1295-21d1-221831f08585; 
pif=d02dcf37-85ab-09f7-d943-941a903ad41b
 2013-08-30 20:39:51,463 DEBUG [agent.manager.DirectAgentAttache] 
(DirectAgent-93:null) Seq 3-663552130: Response Received:
 2013-08-30 20:39:51,464 DEBUG [agent.transport.Request] (DirectAgent-93:null) 
Seq 3-663552130: Processing: { Ans: , MgmtId: 7280707764394, via: 3, Ver: v1, 
Flags: 0, 
[{"com.cloud.agent.api.routing.IpAssocAnswer":{"results":["10.147.33.3 - 
success"],"result":true,"wait":0}},{"com.cloud.agent.api.routing.IpAssocAnswer":{"results":["10.147.54.162
 - success"],"result":true,"wait":0}}] }
 2013-08-30 20:39:51,464 DEBUG [agent.transport.Request] 
(Job-Executor-73:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) Seq 
3-663552130: Received: { Ans: , MgmtId: 7280707764394, via: 3, Ver: v1, Flags: 
0, { IpAssocAnswer, IpAssocAnswer } }
 2013-08-30 20:39:51,468 DEBUG [network.rules.RulesManagerImpl] 
(Job-Executor-73:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) 
Successfully released rules for ip id=35 and # of rules now = 0
 2013-08-30 20:39:51,468 DEBUG [cloud.network.NetworkManagerImpl] 
(Job-Executor-73:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) Revoking 
all LoadBalancing rules as a part of public IP id=35 release...
 2013-08-30 20:39:51,470 DEBUG [network.lb.LoadBalancingRulesManagerImpl] 
(Job-Executor-73:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) Found 0 lb 
rules to cleanup
 2013-08-30 20:39:51,470 DEBUG [cloud.network.NetworkManagerImpl] 
(Job-Executor-73:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) Cleaning 
up remote access vpns as a part of public IP id=35 release...
 2013-08-30 20:39:51,471 DEBUG [network.vpn.RemoteAccessVpnManagerImpl] 
(Job-Executor-73:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) there are 
no Remote access vpns for public ip address id=35
 2013-08-30 20:39:51,591 DEBUG [cloud.network.NetworkManagerImpl] 
(Job-Executor-73:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) Releasing 
ip id=35; sourceNat = false
 2013-08-30 20:39:51,595 DEBUG [cloud.network.NetworkManagerImpl] 
(Job-Executor-73:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) Revoking 
all Firewallrules as a part of public IP id=35 release...
 2013-08-30 20:39:51,597 DEBUG [network.firewall.FirewallManagerImpl] 
(Job-Executor-73:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) Releasing 
0 firewall rules for ip id=35
 2013-08-30 20:39:51,599 DEBUG [network.firewall.FirewallManagerImpl] 
(Job-Executor-73:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) There are 
no firewall rules to apply
 2013-08-30 20:39:51,600 DEBUG [network.firewall.FirewallManagerImpl] 
(Job-Executor-73:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) 
Successfully released firewall rules for ip id=35 and # of rules now = 0
 2013-08-30 20:39:51,601 DEBUG [cloud.network.NetworkManagerImpl] 
(Job-Executor-73:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) Revoking 
all PortForwarding/StaticNat rules as a part of public IP id=35 release...
 2013-08-30 20:39:51,602 DEBUG [network.rules.RulesManagerImpl] 
(Job-Executor-73:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) Releasing 
0 port forwarding rules for ip id=35
 2013-08-30 20:39:51,604 DEBUG [network.rules.RulesManagerImpl] 
(Job-Executor-73:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) Releasing 
0 static nat rules for ip id=35
 2013-08-30 20:39:51,606 DEBUG [network.rules.RulesManagerImpl] 
(Job-Executor-73:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) There are 
no port forwarding rules to apply for ip id=35
 2013-08-30 20:39:51,607 DEBUG [network.rules.RulesManagerImpl] 
(Job-Executor-73:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) There are 
no static nat rules to apply for ip id=35
 2013-08-30 20:39:51,624 INFO [cloud.network.NetworkManagerImpl] 
(Job-Executor-73:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) Let 
VirtualRouter handle StaticNat in network 214
 2013-08-30 20:39:51,633 DEBUG 
[network.router.VirtualNetworkApplianceManagerImpl] (Job-Executor-73:job-146 = 
[ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) Applying static nat rules in network 
Ntwk[214|Guest|8]
 2013-08-30 20:39:51,647 DEBUG [agent.transport.Request] 
(Job-Executor-73:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) Seq 
3-663552131: Sending { Cmd , MgmtId: 7280707764394, via: 3, Ver: v1, Flags: 
100001, 
[{"com.cloud.agent.api.routing.SetStaticNatRulesCommand":{"rules":[{"dstIp":"10.1.1.21","id":0,"srcIp":"10.147.33.3","revoked":true,"alreadyAdded":false,"purpose":"StaticNat","icmpType":0,"icmpCode":0,"defaultEgressPolicy":false}],"accessDetails":{"router.guest.ip":"10.1.1.1","zone.network.type":"Advanced","router.ip":"169.254.3.37","router.name":"r-18-VM"},"wait":0}}]
 }
 2013-08-30 20:39:51,648 DEBUG [agent.transport.Request] 
(Job-Executor-73:job-146 = [ 52178d4b-b132-497f-8df8-6844a9e441b2 ]) Seq 
3-663552131: Executing: { Cmd , MgmtId: 7280707764394, via: 3, Ver: v1, Flags: 
100001, 
[{"com.cloud.agent.api.routing.SetStaticNatRulesCommand":{"rules":[{"dstIp":"10.1.1.21","id":0,"srcIp":"10.147.33.3","revoked":true,"alreadyAdded":false,"purpose":"StaticNat","icmpType":0,"icmpCode":0,"defaultEgressPolicy":false}],"accessDetails":{"router.guest.ip":"10.1.1.1","zone.network.type":"Advanced","router.ip":"169.254.3.37","router.name":"r-18-VM"},"wait":0}}]
 }
 
                
> [Portable IP] disassociating a transferred public IP is failing with exception
> ------------------------------------------------------------------------------
>
>                 Key: CLOUDSTACK-4576
>                 URL: https://issues.apache.org/jira/browse/CLOUDSTACK-4576
>             Project: CloudStack
>          Issue Type: Bug
>      Security Level: Public(Anyone can view this level - this is the 
> default.) 
>          Components: Network Controller
>    Affects Versions: 4.2.0
>            Reporter: Sudha Ponnaganti
>            Priority: Critical
>             Fix For: 4.2.0, 4.2.1
>
>
> Steps to reproduce: 
> 1. Have latest CloudStack with at least 2 advanced zone. 
> 2. Go to Regions -> local -> portable IP -> add an ip range like below 
> Gateway : 10.147.33.1 
> startIp : 10.147.33.3 
> endip : 10.147.33.10 
> vlan : 33 
> subnet : 255.255.255.128 
> 3. login as a non-ROOT admin 
> username : dom1User1 
> password : password 
> domain : dom1 
> 4. create the following isolated networks in each zone 
> - Network1Zone1 
> - Network1Zone2 
> 5. deploy the following VMs in each network 
> - vm1Zone1 connected to Network1Zone1 
> - vm1Zone2 connected to Network1Zone2 
> 6. Acquire and associate a portable IP to Network1Zone1 
> 7. enable staticNAT on the above portableIP and associate it to vm1Zone2 of 
> Network1Zone2 and add firewall rule for ssh port
>  
> Observations: 
> (i) portable IP got transferred from Zone1 to Network1Zone2 successfully and 
> able ssh to the portable IP without any issuees.
>  
> 8. disassociate above portable IP from Network1Zone2. 
> Observations: 
> (ii) sequence of things happened as mentioned below 
> - disassociate happened without any issues which cleaned the eth interface 
> from router etc.., but,
>  - it again initiated IPASSOC on its own for the same portable IP which 
> resulted in the following error and thus this IP stuck in release state 
> forever.
>  
> (iii) above behaviour made all further IPASSOCs to fail. 
> Attaching all the required logs along with db dump to the bug. 

--
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

Reply via email to