CUCM --- CUCM - One Way Calling Issue

tcaputa01 · ‎09-27-2015

I have a Lab Setup with One CUCM Pub on one side of a SSL VPN and another CUCM Pub on the other side. I am succesfully able to call over both ICT / SIP trunk from one side to the other, but when calling from the other side back I get a fast busy. Currently am testing with a SIP trunk in between.

I tried to pull the Call Log Traces and am seeing this on the side I am trying to call. So it looks like the calls are arriving at that CUCM but thats it.

SIP/2.0 503 Service Unavailable
Via: SIP/2.0/TCP 10.0.2.150:5060;branch=z9hG4bK200ad5264c;received=10.0.0.2
From: <sip:1001@10.0.2.150>;tag=148441~3f734969-c967-443e-aade-2174e88151d3-24214227
To: <sip:2500@10.0.0.202>;tag=305864122
Date: Mon, 28 Sep 2015 03:09:13 GMT
Call-ID: 5ae78e00-6081af75-1cf-9602000a@10.0.2.150
CSeq: 101 INVITE
Allow-Events: presence
Warning: 399 CUCM01 "Unable to find a device handler for the request received on port 59326 from 10.0.0.2"
Content-Length: 0

Vivek Batra · ‎09-27-2015

Can you please share the IP address of both PUB and complete SIP trace (including INVITE)...

tcaputa01 · ‎09-28-2015

09:31:04.518 |wait_B2BLinkQualityTimer - Started|1,100,136,1.1^*^*
09:31:04.518 |SdiStats: #Lines: 95 Free HWM: 67 Free HWM(total): 468|*^*^*
09:31:04.518 |wait_B2BLinkQualityTimer - B2BLinkQualityTimer set for 120 seconds|1,100,136,1.1^*^*
09:31:10.434 |SIPStationInit: mOutstandingTokens = 0, resetting to zero|1,100,136,1.1^*^*
09:31:10.434 |SdiStats: #Lines: 3 Free HWM: 3 Free HWM(total): 468|*^*^*
09:31:12.405 |EnvProcessCdr::wait_CdrFileTimer|1,100,231,1.1^*^*
09:31:12.405 |EnvProcessCdr::closeCdrFile|1,100,231,1.1^*^*
09:31:12.405 |EnvProcessCdr::closeCmrFile|1,100,231,1.1^*^*
09:31:43.859 |//SIP/SIPTcp/wait_SdlReadRsp: SdlRead bufferLen=967|1,100,63,1.16^10.0.0.2^*
09:31:43.859 |SdiStats: #Lines: 5 Free HWM: 3 Free HWM(total): 468|*^*^*
09:31:43.859 |//SIP/SIPTcp/wait_SdlReadRsp: Incoming SIP TCP message from 10.0.0.2 on port 35900 index 3 with 967 bytes:
[28,NET]
INVITE sip:2400@10.0.0.202:5060 SIP/2.0
Via: SIP/2.0/TCP 10.0.2.150:5060;branch=z9hG4bK566f45c5b
From: <sip:1001@10.0.2.150>;tag=8~3f734969-c967-443e-aade-2174e88151d3-19059602
To: <sip:2400@10.0.0.202>
Date: Mon, 28 Sep 2015 13:32:13 GMT
Call-ID: 526e7200-6091415d-6-9602000a@10.0.2.150
Supported: timer,resource-priority,replaces
Min-SE: 1800
User-Agent: Cisco-CUCM8.6
Allow: INVITE, OPTIONS, INFO, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY
CSeq: 101 INVITE
Expires: 180
Allow-Events: presence, kpml
Supported: X-cisco-srtp-fallback
Supported: Geolocation
Call-Info: <sip:10.0.2.150:5060>;method="NOTIFY;Event=telephone-event;Duration=500"
Cisco-Guid: 1382969856-0000065536-0000000006-2516713482
Session-Expires: 1800
P-Asserted-Identity: <sip:1001@10.0.2.150>
Remote-Party-ID: <sip:1001@10.0.2.150>;party=calling;screen=yes;privacy=off
Contact: <sip:1001@10.0.2.150:5060;transport=tcp>
Max-Forwards: 70
Content-Length: 0

|1,100,63,1.16^10.0.0.2^*
09:31:43.859 |//SIP/SIPTcp/wait_SdlReadRsp: SignalCounter = 14|1,100,63,1.16^10.0.0.2^*
09:31:43.859 |//SIP/Stack/Info/0x0/ccsip_spi_get_msg_type returned: 2 for event 1|1,100,63,1.16^10.0.0.2^*
09:31:43.859 |//SIP/Stack/Transport/0x0/context=(nil)|1,100,63,1.16^10.0.0.2^*
09:31:43.859 |//SIP/Stack/Transport/0x0/gConnTab=0xe2dc948, addr=10.0.0.2, port=35900, connid=3, transport=TCP|1,100,63,1.16^10.0.0.2^*
09:31:43.859 |//SIP/Stack/Info/0x0/Return existing connection for port 35900 connId 3|1,100,63,1.16^10.0.0.2^*
09:31:43.859 |//SIP/Stack/Info/0x0/Checking Invite Dialog|1,100,63,1.16^10.0.0.2^*
09:31:43.859 |//SIP/Stack/Info/0x0/Added context(0xb6e29da8) with key=[7] to table|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |//SIP/Stack/Transport/0x0/Dialog Transaction Address 10.0.0.2,Port 35900, Transport 2, SentBy Port 5060|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |//SIP/Stack/States/0xb6e29da8/0xb6e29da8 : State change from (STATE_NONE, SUBSTATE_NONE) to (STATE_IDLE, SUBSTATE_NONE)|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |//SIP/Stack/Transport/0x0/Dialog Transaction Address 10.0.0.2,Port 35900, Transport 2, SentBy Port 5060|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |//SIP/Stack/Transport/0x0/Dialog Transaction Address 10.0.0.2,Port 35900, Transport 2, SentBy Port 5060|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |//SIP/Stack/Info/0xb6e29da8/calling host comes from From: 10.0.2.150|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |//SIP/Stack/Info/0xb6e29da8/calling host comes from rpid 10.0.2.150|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |//SIP/Stack/Info/0xb6e29da8/Received current remote name: , current remote number: 1001|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |//SIP/Stack/Info/0xb6e29da8/Received ;screen=yes ;privacy=off -> Setting Octet3A 0x81, extended_privacy 0x00|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |//SIP/Stack/Info/0x0/No GTD found in inbound container|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |//SIP/Stack/Info/0x0/No CSTA found in inbound container|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |//SIP/Stack/Info/0xb6e29da8/****Adding to UAS Request table.|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |//SIP/Stack/Info/0xb6e29da8/Added to table. ccb=0xb6e29da8 key=526e7200-6091415d-6-9602000a@10.0.2.1502400|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |//SIP/Stack/Info/0xb6e29da8/Calling name , number 1001, Calling oct3 0x00, oct_3a 0x81, ext_priv 0x00, Called numb|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |//SIP/Stack/Info/0xb6e29da8/Carrier id code , prev_cid NONE, next_cid NONE, prev_tgrp NONE, next_tgrp NONE|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |//SIP/SIPHandler/ccbId=0/scbId=0/getRel1xxType: No matching SIP trunk found in hash table, returning rel1xx disabled|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |//SIP/SIPHandler/ccbId=0/scbId=0/sipSPIGetCallExtensionSupported: SIPRel1xxEnabledServiceParamSetting=0 , ccb->pld.outboundRel1xx=1|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |//SIP/SIPHandler/ccbId=0/scbId=0/sip_stop_timer: type=SIP_TIMER_EXPIRES value=180000 retries=0|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |//SIP/SIPHandler/ccbId=0/scbId=0/sip_start_timer: type=SIP_TIMER_EXPIRES value=180000 retries=0|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |//SIP/SIPHandler/ccbId=0/scbId=0/checkSyntaxAndSelectAssertedHeader: PAI result [9], total[1], sipUri[1], sipsUri[0], telUri[0]|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |//SIP/SIPHandler/ccbId=0/scbId=0/printAssertedInfo: remoteNum[1001], remoteName[], remoteHost[10.0.2.150], remotePort[5060], remoteTransport[1], remoteSchema[1]|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |//SIP/SIPHandler/ccbId=0/scbId=0/extractAssertedInfo: parseResult[13]|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |//SIP/SIPHandler/ccbId=0/scbId=0/extract_sdp: sipAppGetParticularContent failed to obtain SDP - result=2 len=0|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |//SIP/SIPHandler/ccbId=0/scbId=0/getCalledNumberUri: SIP URL 2400@10.0.0.202:5060|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |//SIP/SIPHandler/ccbId=0/scbId=0/sendSetupInd: bearerless? 0 0|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |//SIP/SIPHandler/ccbId=0/scbId=0/parseContactHeader: Incoming Contact=[<sip:1001@10.0.2.150:5060;transport=tcp>]|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |//SIP/SIPHandler/ccbId=0/scbId=0/sendSetupInd: Trunk Object Not Found|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |//SIP/Stack/Info/0xb6e29da8/ccsip_api_call_setup_ind returned: SIP_SUCCESS_DELAYED_MEDIA|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |//SIP/Stack/Info/0xb6e29da8/Adding call id 8 to table|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |//SIP/Stack/Transport/0xb6e29da8/msg=0xb41f3b50, addr=10.0.0.2, port=35900, sentBy_port=5060, is_req=0, transport=2, switch=0, callBack=|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |//SIP/Stack/Transport/0xb6e29da8/Proceedable for sending msg immediately|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |//SIP/Stack/Transport/0xb6e29da8/switch transport is 0|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |//SIP/Stack/Transport/0x0/Posting send for msg=0xb41f3b50, addr=10.0.0.2, port=35900, connId=3 for TCP|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |//SIP/Stack/States/0xb6e29da8/0xb6e29da8 : State change from (STATE_IDLE, SUBSTATE_NONE) to (STATE_RECD_INVITE, SUBSTATE_NONE)|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |//SIP/Stack/Info/0xb6e29da8/Previous Hop 10.0.2.150:5060|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |SIPStationInit: forwardSIPSignal: dialog=0|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |SIPStationInit: Unable to route SIP msg with connId 3|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |SIPStationInit: forwardSIPSignal Unable to route message, Cannot find the SIP Device with Name=10.0.0.2, Source Port=5060, IpAddress Type=0|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |SIPStationInit: Could not find SIPStationD process for incoming msg on TCP (ccbid=8 tcpindex=3 socket=10.0.0.2:35900)|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |SIPStationInit: wait_SIPSetupInd Unable to get Dpid from dialog, ccbId=8|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |//SIP/SIPTcp/wait_SdlSPISignal: received a spi signal ...|1,100,63,1.16^10.0.0.2^*
09:31:43.860 |//SIP/SIPTcp/wait_SdlSPISignal: Outgoing SIP TCP message to 10.0.0.2 on port 35900 index 3
[29,NET]
SIP/2.0 100 Trying
Via: SIP/2.0/TCP 10.0.2.150:5060;branch=z9hG4bK566f45c5b;received=10.0.0.2
From: <sip:1001@10.0.2.150>;tag=8~3f734969-c967-443e-aade-2174e88151d3-19059602
To: <sip:2400@10.0.0.202>
Date: Mon, 28 Sep 2015 13:31:43 GMT
Call-ID: 526e7200-6091415d-6-9602000a@10.0.2.150
CSeq: 101 INVITE
Allow-Events: presence
Content-Length: 0

|1,100,63,1.16^10.0.0.2^*
09:31:43.861 |//SIP/Stack/Info/0x0/ccsip_spi_get_msg_type returned: 3 for event 8|1,100,63,1.16^10.0.0.2^*
09:31:43.861 |//SIP/Stack/Info/0xb6e29da8/Performing disconnect|1,100,63,1.16^10.0.0.2^*
09:31:43.861 |//SIP/SIPHandler/ccbId=0/scbId=0/sip_stop_timer: type=SIP_TIMER_EXPIRES value=180000 retries=0|1,100,63,1.16^10.0.0.2^*
09:31:43.861 |//SIP/Stack/Info/0xb6e29da8/****Adding to UAS Response table.|1,100,63,1.16^10.0.0.2^*
09:31:43.861 |//SIP/Stack/Info/0xb6e29da8/Added to table. ccb=0xb6e29da8 key=526e7200-6091415d-6-9602000a@10.0.2.1501772543781|1,100,63,1.16^10.0.0.2^*
09:31:43.861 |//SIP/Stack/Info/0xb6e29da8/Associated container=0xb310e688 to Invite Response 503|1,100,63,1.16^10.0.0.2^*
09:31:43.861 |//SIP/Stack/Transport/0xb6e29da8/msg=0xb41f3b10, addr=10.0.0.2, port=35900, sentBy_port=5060, is_req=0, transport=2, switch=0, callBack=|1,100,63,1.16^10.0.0.2^*
09:31:43.861 |//SIP/Stack/Transport/0xb6e29da8/Proceedable for sending msg immediately|1,100,63,1.16^10.0.0.2^*
09:31:43.861 |//SIP/Stack/Transport/0xb6e29da8/switch transport is 0|1,100,63,1.16^10.0.0.2^*
09:31:43.861 |//SIP/Stack/Transport/0x0/Posting send for msg=0xb41f3b10, addr=10.0.0.2, port=35900, connId=3 for TCP|1,100,63,1.16^10.0.0.2^*
09:31:43.861 |//SIP/Stack/Info/0xb6e29da8/Sent an 3456XX Error Response|1,100,63,1.16^10.0.0.2^*
09:31:43.861 |//SIP/Stack/States/0xb6e29da8/0xb6e29da8 : State change from (STATE_RECD_INVITE, SUBSTATE_NONE) to (STATE_DISCONNECTING, SUBSTATE_NONE)|1,100,63,1.16^10.0.0.2^*
09:31:43.861 |//SIP/SIPHandler/ccbId=0/scbId=0/sip_stop_timer: type=SIP_TIMER_CONNECT value=500 retries=6|1,100,63,1.16^10.0.0.2^*
09:31:43.861 |//SIP/SIPHandler/ccbId=0/scbId=0/sip_start_timer: type=SIP_TIMER_CONNECT value=500 retries=6|1,100,63,1.16^10.0.0.2^*
09:31:43.861 |//SIP/SIPTcp/wait_SdlSPISignal: received a spi signal ...|1,100,63,1.16^10.0.0.2^*
09:31:43.861 |//SIP/SIPTcp/wait_SdlSPISignal: Outgoing SIP TCP message to 10.0.0.2 on port 35900 index 3
[30,NET]
SIP/2.0 503 Service Unavailable
Via: SIP/2.0/TCP 10.0.2.150:5060;branch=z9hG4bK566f45c5b;received=10.0.0.2
From: <sip:1001@10.0.2.150>;tag=8~3f734969-c967-443e-aade-2174e88151d3-19059602
To: <sip:2400@10.0.0.202>;tag=1772543781
Date: Mon, 28 Sep 2015 13:31:43 GMT
Call-ID: 526e7200-6091415d-6-9602000a@10.0.2.150
CSeq: 101 INVITE
Allow-Events: presence
Warning: 399 BITS-CUCM01 "Unable to find a device handler for the request received on port 35900 from 10.0.0.2"
Content-Length: 0

|1,100,63,1.16^10.0.0.2^*
09:31:43.873 |//SIP/SIPTcp/wait_SdlReadRsp: SdlRead bufferLen=390|1,100,63,1.17^10.0.0.2^*
09:31:43.873 |//SIP/SIPTcp/wait_SdlReadRsp: Incoming SIP TCP message from 10.0.0.2 on port 35900 index 3 with 390 bytes:
[31,NET]
ACK sip:2400@10.0.0.202:5060 SIP/2.0
Via: SIP/2.0/TCP 10.0.2.150:5060;branch=z9hG4bK566f45c5b
From: <sip:1001@10.0.2.150>;tag=8~3f734969-c967-443e-aade-2174e88151d3-19059602
To: <sip:2400@10.0.0.202>;tag=1772543781
Date: Mon, 28 Sep 2015 13:32:13 GMT
Call-ID: 526e7200-6091415d-6-9602000a@10.0.2.150
Max-Forwards: 70
CSeq: 101 ACK
Allow-Events: presence, kpml
Content-Length: 0

|1,100,63,1.17^10.0.0.2^*
09:31:43.873 |//SIP/SIPTcp/wait_SdlReadRsp: SignalCounter = 15|1,100,63,1.17^10.0.0.2^*
09:31:43.873 |//SIP/Stack/Info/0x0/ccsip_spi_get_msg_type returned: 2 for event 1|1,100,63,1.17^10.0.0.2^*
09:31:43.873 |//SIP/Stack/Transport/0x0/context=(nil)|1,100,63,1.17^10.0.0.2^*
09:31:43.873 |//SIP/Stack/Transport/0x0/gConnTab=0xe2dc948, addr=10.0.0.2, port=35900, connid=3, transport=TCP|1,100,63,1.17^10.0.0.2^*
09:31:43.873 |//SIP/Stack/Info/0x0/Return existing connection for port 35900 connId 3|1,100,63,1.17^10.0.0.2^*
09:31:43.873 |//SIP/Stack/Info/0x0/Checking Invite Dialog|1,100,63,1.17^10.0.0.2^*
09:31:43.873 |//SIP/Stack/Info/0xb6e29da8/*****CCB found in UAS Response table. ccb=0xb6e29da8|1,100,63,1.17^10.0.0.2^*
09:31:43.873 |//SIP/Stack/Transport/0x0/Subsq Transaction Address 10.0.0.2,Port 35900, Transport 2, SentBy Port 5060|1,100,63,1.17^10.0.0.2^*
09:31:43.873 |//SIP/Stack/Transport/0x0/Subsq Transaction Address 10.0.0.2,Port 35900, Transport 2, SentBy Port 5060|1,100,63,1.17^10.0.0.2^*
09:31:43.873 |//SIP/Stack/Info/0xb6e29da8/calling host comes from From: 10.0.2.150|1,100,63,1.17^10.0.0.2^*
09:31:43.873 |//SIP/SIPHandler/ccbId=8/scbId=0/findDevicePID: Routed to SIPStationInit|1,100,63,1.17^10.0.0.2^*
09:31:43.873 |//SIP/Stack/States/0xb6e29da8/0xb6e29da8 : State change from (STATE_DISCONNECTING, SUBSTATE_NONE) to (STATE_DEAD, SUBSTATE_NONE)|1,100,63,1.17^10.0.0.2^*
09:31:43.873 |//SIP/Stack/Info/0xb6e29da8/Removing call id 8|1,100,63,1.17^10.0.0.2^*
09:31:43.873 |//SIP/Stack/Info/0x0/Context for key=[7] removed.|1,100,63,1.17^10.0.0.2^*
09:31:43.873 |//SIP/SIPHandler/ccbId=0/scbId=0/sip_stop_timer: type=SIP_TIMER_CONNECT value=500 retries=6|1,100,63,1.17^10.0.0.2^*
09:31:43.873 |//SIP/Stack/Info/0xb6e29da8/****Deleting from UAS Request table.|1,100,63,1.17^10.0.0.2^*
09:31:43.873 |//SIP/Stack/Info/0xb6e29da8/Deleting from table. ccb=0xb6e29da8 key=526e7200-6091415d-6-9602000a@10.0.2.1502400|1,100,63,1.17^10.0.0.2^*
09:31:43.873 |//SIP/Stack/Info/0xb6e29da8/****Deleting from UAS Response table.|1,100,63,1.17^10.0.0.2^*
09:31:43.873 |//SIP/Stack/Info/0xb6e29da8/Deleting from table. ccb=0xb6e29da8 key=526e7200-6091415d-6-9602000a@10.0.2.1501772543781|1,100,63,1.17^10.0.0.2^*
09:31:43.873 |//SIP/Stack/Info/0xb6e29da8/There are 0 events on the internal queue that are going to be free'd|1,100,63,1.17^10.0.0.2^*
09:31:43.873 |//SIP/Stack/Transport/0x0/gConnTab=0xe2dc948, addr=10.0.0.2, port=35900, unregistering context=0xb6e29da8|1,100,63,1.17^10.0.0.2^*
09:31:43.873 |//SIP/Stack/Transport/0xb6e29da8/Could not purge context gcb=0xb6e29da8 from the connection; gcb might be locked|1,100,63,1.17^10.0.0.2^*
09:31:43.873 |//SIP/Stack/Info/0xb6e29da8/Freeing ccb b6e29da8|1,100,63,1.17^10.0.0.2^*
09:31:43.873 |//SIP/Stack/Info/0x0/NO context for key[7]|1,100,63,1.17^10.0.0.2^*
09:31:43.873 |SIPStationInit: Unable to route SIP msg with connId 3|1,100,63,1.17^10.0.0.2^*
09:31:43.873 |SIPStationInit: forwardSIPSignal Unable to route message, Cannot find the SIP Device with Name=10.0.0.2, Source Port=5060, IpAddress Type=0|1,100,63,1.17^10.0.0.2^*

Ayodeji Okanlawon · ‎09-28-2015

From the logs..

+++

09:31:43.859 |//SIP/SIPTcp/wait_SdlReadRsp: Incoming SIP TCP message from 10.0.0.2 on port 35900 index 3 with 967 bytes:
[28,NET]
INVITE sip:2400@10.0.0.202:5060 SIP/2.0

+++

You should also check the logs from the originating cluster. What IP is advertised in the sip logs?

Please rate all useful posts

Vivek Batra · ‎09-28-2015

Hi,

You should check as per suggestions from Ayodeji.

In the meanwhile if you want to make simple call work (not all scenarios), following workaround may work.

Configure 10.0.0.2 as a SIP server address under SIP Trunk page in PUB1 (10.0.0.202). Now when PUB1 receives INVITE even from NATted IP (10.0.0.2), it would be able to select the SIP trunk. Just ensure you configure the IP 10.0.0.2 as a second priority instead of first.

Also note that in this workaround, when you will make a call from PUB1 and PUB2 is down, PUB1 will try to send this call to 10.0.0.2 and call will fail.

Thanks

Dennis Mink · ‎09-27-2015

did you tick the following box:

Run On All Active Unified CM Nodes

on both sides of the intercluster trunk, in CUCM?

HTH

Please remember to rate useful posts, by clicking on the stars below.

Vivek Batra · ‎09-27-2015

tcaputa01,

I think problem now can be seen from 503 message.

I assume following are the IP address of PUB;

PUB1 - 10.0.0.202

PUB2 - 10.0.2.150

You can make a calls successfully from PUB1 to PUB2. However calls failed from PUB2 to PUB1. This is because when PUB1 receives INVITE, PUB1 should see this INVITE coming from 10.0.2.150 however there is somewhere NATting in between and PUB1 is seeing source IP as 10.0.0.2. That might be the reason why PUB1 is rejecting the SIP INVITE.

If my assumption to above scenario is right, you just to see how to avoid NATting so that PUB1 should see the INVITE coming from 10.0.2.150 instead of 10.0.0.2 and you will be good to go.

Thanks

Vivek

Ayodeji Okanlawon · ‎09-27-2015

+5 to Vivek,

Just to add a little more.. Whenever you receive a 503 service unavailable, there is always a reason text attached that will tell you why the service is not available..

Here we see the reason as follows

Warning: 399 CUCM01 "Unable to find a device handler for the request received on port 59326 from 10.0.0.2"

So we see that cucm's sip daemon is saying that it's receiving and IP address from a source that is not in its database.

Each time you configure an an IP address or a FQDN in the destination of a sip trunk, that a dress is entered in the cucm sip daemon process...

AoSo to resolve lthis as Vivek suggested, look at your Nat configuration and ensure that sip traffic originate from the IP address specified in the cucm sip trunk.

Please rate all useful posts

tcaputa01 · ‎09-28-2015

Thanks Vivek, everything you stated is correct. 10.0.0.2 is my local router where the VPN over to 10.0.2.x subnet terminates. Weird part of it is the other side 10.0.2.X network router is setup the same and is functioning. Maybe I should grab some logs from 10.0.2.150 and compare.

Looking into this further, we are running a OpenVPN between sites and my site is the server side. Might be why it keeps pointing to 10.0.0.2 and not 10.0.2.150