SIP Registration

[mailgunj]

Hello All,

I'm trying to register my Cisco cube router 3825 with the service provider. My cube is sending the register message with "expires: 0" even after receiving 200 OK. Are the below messages fine? As per the provider, the format is fine for the first 2 register messages but they say that the last message should not be present.

Sent:
REGISTER sip:bangalore.relianceims.in:5060 SIP/2.0
Via: SIP/2.0/UDP 10.16.81.201:5060;branch=z9hG4bK158513E8
From: <sip:+914438051000@bangalore.relianceims.in>;tag=BA284620-32D
To: <sip:+914438051000@bangalore.relianceims.in>
Date: Wed, 14 Sep 2016 12:00:42 GMT
Call-ID: B24B33F1-79A911E6-A7FBD6BB-FB6EA3E8
User-Agent: Cisco-SIPGateway/IOS-12.x
Max-Forwards: 70
Timestamp: 1473854442
CSeq: 2 REGISTER
Contact: <sip:+914438051000@10.16.81.201:5060>
Expires: 1800
Supported: path
Content-Length: 0

234346: Sep 14 17:30:42.968 IST: //421233/000000000000/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 10.16.81.201:5060;branch=z9hG4bK158513E8
To: <sip:+914438051000@bangalore.relianceims.in>;tag=ztesipNsxQ9ezHJ9*1-4-16648*jggg.1
From: <sip:+914438051000@bangalore.relianceims.in>;tag=BA284620-32D
Call-ID: B24B33F1-79A911E6-A7FBD6BB-FB6EA3E8
CSeq: 2 REGISTER
WWW-Authenticate: Digest realm="bangalore.relianceims.in",domain="sip:scscf1.bangalore.relianceims.in",nonce="7ae7bd0716f18520de8508a1fc26a10e",opaque="aW1zLmNvbS5jbg==",stale=TRUE,algorithm=MD5,qop="auth"
Content-Length: 0

234347: Sep 14 17:30:42.972 IST: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
REGISTER sip:bangalore.relianceims.in:5060 SIP/2.0
Via: SIP/2.0/UDP 10.16.81.201:5060;branch=z9hG4bK1586A1D
From: <sip:+914438051000@bangalore.relianceims.in>;tag=BA284620-32D
To: <sip:+914438051000@bangalore.relianceims.in>
Date: Wed, 14 Sep 2016 12:00:42 GMT
Call-ID: B24B33F1-79A911E6-A7FBD6BB-FB6EA3E8
User-Agent: Cisco-SIPGateway/IOS-12.x
Max-Forwards: 70
Timestamp: 1473854442
CSeq: 3 REGISTER
Contact: <sip:+914438051000@10.16.81.201:5060>
Expires: 1800
Authorization: Digest username="+914438051000@bangalore.relianceims.in",realm="bangalore.relianceims.in",uri="sip:bangalore.relianceims.in:5060",response="fc8334f48dfa0588a03e84a0ffb6cfba",nonce="7ae7bd0716f18520de8508a1fc26a10e",opaque="aW1zLmNvbS5jbg==",cnonce="B5DD041C",qop=auth,algorithm=MD5,nc=00000001
Content-Length: 0

234348: Sep 14 17:30:43.040 IST: //421233/000000000000/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.16.81.201:5060;branch=z9hG4bK1586A1D
To: <sip:+914438051000@bangalore.relianceims.in>;tag=ztesipGleC6sE9b*1-4-16648*jggh.1
From: <sip:+914438051000@bangalore.relianceims.in>;tag=BA284620-32D
Call-ID: B24B33F1-79A911E6-A7FBD6BB-FB6EA3E8
CSeq: 3 REGISTER
Contact: <sip:+914438051000@10.16.81.201:5060>;expires=1800
P-Associated-URI: <tel:+914438051000>
P-Associated-URI: <sip:+91443805![1-3][0-9]{3}!@bangalore.relianceims.in>
P-Associated-URI: <tel:+91443805![1-3][0-9]{3}!>
P-Associated-URI: <sip:+914438051000@bangalore.relianceims.in>
P-Associated-URI: <sip:+914438054![0-4][0-9]{2}!@bangalore.relianceims.in>
P-Associated-URI: <tel:+914438054![0-4][0-9]{2}!>
Date: Wed, 14 Sep 2016 12:00:43 GMT
Authentication-Info: nextnonce="5b1aeba5b281df75ba10a8e6f75a6d41",qop=auth,rspauth="621c4756e40e8da0fad39c7e0a74c433",cnonce="B5DD041C",nc=00000001
Content-Length: 0

234349: Sep 14 17:30:43.044 IST: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
REGISTER sip:bangalore.relianceims.in:5060 SIP/2.0
Via: SIP/2.0/UDP 10.16.81.201:5060;branch=z9hG4bK1587215D
From: <sip:+914438051000@bangalore.relianceims.in>;tag=BA2846A4-784
To: <sip:+914438051000@bangalore.relianceims.in>
Date: Wed, 14 Sep 2016 12:00:43 GMT
Call-ID: B24B33F1-79A911E6-A7FBD6BB-FB6EA3E8
User-Agent: Cisco-SIPGateway/IOS-12.x
Max-Forwards: 70
Timestamp: 1473854443
CSeq: 4 REGISTER
Contact: <sip:+914438051000@10.16.81.201:5060>
Expires: 0
Supported: path
Content-Length: 0

234350: Sep 14 17:30:43.108 IST: //421234/000000000000/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.16.81.201:5060;branch=z9hG4bK1587215D
To: <sip:+914438051000@bangalore.relianceims.in>;tag=ztesipp1jICnsP*1-4-16648*jgha.1
From: <sip:+914438051000@bangalore.relianceims.in>;tag=BA2846A4-784
Call-ID: B24B33F1-79A911E6-A7FBD6BB-FB6EA3E8
CSeq: 4 REGISTER
Contact: <sip:+914438051000@10.16.81.201:5060>;expires=0
P-Associated-URI: <tel:+914438051000>
P-Associated-URI: <tel:+914438054![0-4][0-9]{2}!>
P-Associated-URI: <sip:+914438054![0-4][0-9]{2}!@bangalore.relianceims.in>
P-Associated-URI: <sip:+914438051000@bangalore.relianceims.in>
P-Associated-URI: <tel:+91443805![1-3][0-9]{3}!>
P-Associated-URI: <sip:+91443805![1-3][0-9]{3}!@bangalore.relianceims.in>
Date: Wed, 14 Sep 2016 12:00:43 GMT
Content-Length: 0

Looking forward to your response.

Thanks & regards,

Gunjan Jain

[Mohammed Khan]

Looks like CUBE is sending keepalives in register message with expires set to 0. Do you see this messages  back and forth. Did you observe any call failure because of this?

[mailgunj]

Hello Mohammed,

Thank you for your reply. This is happening every time the timer expires. It's a new setup. We are unable to make calls. The provider is insisting that without registration the calls wouldn't work. Is there a way to block the last register message with expire 0. I have set the expire timer to 1800 in my config.

Thanks & regards,

Gunjan Jain

[Mohammed Khan]

Enable IEC.

voice iec syslog

collect below debug

debug ccsip all

debug voip ccapi inout

[mailgunj]

Hello Mohammad,

Here is the output of debug ccsip all:

GW2(config-sip-ua)#
235051: Sep 14 20:16:36.223 IST: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_register_reset_dns_cache: CCSIP_REGISTER:: registrar 0 DNS resolved
addr reset
235052: Sep 14 20:16:36.223 IST: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_spi_register_update_e164_registrations: CCSIP_REGISTER:: e164
number (+914438051000) event (1)
235053: Sep 14 20:16:36.223 IST: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_register_search_e164_table: ****No entry found in E164 Table
235054: Sep 14 20:16:36.223 IST: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_spi_register_get_rcb: Getting New RCB [0x6B272934]
235055: Sep 14 20:16:36.227 IST: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIAddContextToTable: Added context(0x7116DEB8) with key=[3992] to table
235056: Sep 14 20:16:36.227 IST: //-1/000000000000/SIP/Info/ccsip_offer_ans_init:
235057: Sep 14 20:16:36.227 IST: //-1/000000000000/SIP/Info/ccsip_iwf_init:
235058: Sep 14 20:16:36.227 IST: //-1/000000000000/SIP/Info/ccsip_ipip_media_service_init:
235059: Sep 14 20:16:36.227 IST: //-1/000000000000/SIP/Info/sipSPI_ipip_vcc_Initialization: Entry...
235060: Sep 14 20:16:36.227 IST: //-1/000000000000/SIP/Info/ccsipRegisterSetTargetInfo: p2p mode with Registrar Server =
dns:bangalore.relianceims.in
235061: Sep 14 20:16:36.227 IST: //-1/000000000000/SIP/Info/ccsipRegisterSetTargetInfo: Parsing The Registrar Address
235062: Sep 14 20:16:36.227 IST: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIGetOutboundHostAndDestHostPrivate: CCSIP: target_host :
bangalore.relianceims.in target_port : 5060

235063: Sep 14 20:16:36.227 IST: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIGetOutboundHostAndDestHostPrivate: CCSIP: outbound_host :
10.237.246.225 outbound_port : 5060

235064: Sep 14 20:16:36.227 IST: //-1/000000000000/SIP/Info/sipSPIOutboundProxyReuse: Do not reuse Outbound Proxy IP adress and
Port
235065: Sep 14 20:16:36.227 IST: //-1/000000000000/SIP/State/sipSPIChangeState: 0x7116DEB8 : State change from (STATE_NONE,
SUBSTATE_NONE) to (STATE_IDLE, SUBSTATE_NONE)
235066: Sep 14 20:16:36.227 IST: //-1/000000000000/SIP/Info/ccsip_spi_registrar_add_expires_header: Inside
ccsip_spi_registrar_add_expires_header for Expires
235067: Sep 14 20:16:36.227 IST: //-1/xxxxxxxxxxxx/SIP/Event/sipSPIEventInfo: Queued event from SIP SPI :
SIPSPI_EV_OUTBOUND_REGISTER
235068: Sep 14 20:16:36.227 IST: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIIncrementOverloadCount: Local 1 Global 1
235069: Sep 14 20:16:36.227 IST: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_register_add_to_e164_table: ****Added to E164 Table at position: 0
235070: Sep 14 20:16:36.227 IST: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 3 for
event 40
235071: Sep 14 20:16:36.227 IST: //-1/000000000000/SIP/Info/act_idle_outgoing_register: In act_idle_outgoing_register

235072: Sep 14 20:16:36.227 IST: //423548/000000000000/SIP/Info/act_idle_outgoing_register: Send REGISTER to 10.237.246.225:5060

235073: Sep 14 20:16:36.227 IST: //423548/000000000000/SIP/Info/sipSPIUaddCcbToUACTable: ****Adding to UAC table.
235074: Sep 14 20:16:36.227 IST: //423548/000000000000/SIP/Info/sipSPIUaddCcbToTable: Added to table. ccb=0x7116DEB8
key=DEEF2497-79C011E6-B0FDD6BB-FB6EA3E8
235075: Sep 14 20:16:36.227 IST: //-1/xxxxxxxxxxxx/SIP/Info/resolve_sig_ip_address_to_bind: calling reg_invoke_ip_first_hop()
235076: Sep 14 20:16:36.227 IST: //-1/xxxxxxxxxxxx/SIP/Info/resolve_sig_ip_address_to_bind: calling ip_best_local_address()
235077: Sep 14 20:16:36.227 IST: //-1/xxxxxxxxxxxx/SIP/Info/resolve_sig_ip_address_to_bind: return addr 10.16.81.201
235078: Sep 14 20:16:36.227 IST: //423548/000000000000/SIP/Info/sipSPIPresendProcessing: Presend Processing called for 7 event
235079: Sep 14 20:16:36.227 IST: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIRetrieveOutgoingPassThruData: Retrieving Data from RCB
235080: Sep 14 20:16:36.227 IST: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIRetrieveOutgoingPassThruData: Retrieving Data from RCB
235081: Sep 14 20:16:36.227 IST: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetDateHeader: Converting TimeZone IST to SIP default timezone = GMT
235082: Sep 14 20:16:36.231 IST: //423548/000000000000/SIP/Info/sipSPISendRegister: Associated container=0x6B63F4A8 to Register
235083: Sep 14 20:16:36.231 IST: //423548/000000000000/SIP/Transport/sipSPISendRegister: Sending REGISTER to the transport layer
235084: Sep 14 20:16:36.231 IST: //423548/000000000000/SIP/Transport/sipSPIGetSwitchTransportFlag: Return the Global configuration,
Switch Transport is FALSE
235085: Sep 14 20:16:36.231 IST: //423548/000000000000/SIP/Transport/sipSPITransportSendMessage: msg=0x73556AAC,
addr=10.237.246.225, port=5060, sentBy_port=0, local_addr=, is_req=1, transport=1, switch=0, callBack=0x61B14BA0
235086: Sep 14 20:16:36.231 IST: //423548/000000000000/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg
immediately
235087: Sep 14 20:16:36.231 IST: //423548/000000000000/SIP/Transport/sipTransportLogicSendMsg: switch transport is 0
235088: Sep 14 20:16:36.231 IST: //-1/xxxxxxxxxxxx/SIP/Transport/sipConnectionManagerGetConnection: connection required for
raddr:10.237.246.225, rport:5060 with laddr:

235089: Sep 14 20:16:36.231 IST: //423548/000000000000/SIP/Transport/sipTransportLogicSendMsg: Set to send the msg=0x73556AAC
235090: Sep 14 20:16:36.231 IST: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x73556AAC,
addr=10.237.246.225, port=5060, local_addr=, connId=2 for UDP
235091: Sep 14 20:16:36.231 IST: //423548/000000000000/SIP/State/sipSPIChangeState: 0x7116DEB8 : State change from (STATE_IDLE,
SUBSTATE_NONE) to (SIP_STATE_OUTGOING_REGISTER, SUBSTATE_NONE)
235092: Sep 14 20:16:36.231 IST: //423548/000000000000/SIP/State/sipSPIChangeState: 0x7116DEB8 : State change from
(SIP_STATE_OUTGOING_REGISTER, SUBSTATE_NONE) to (SIP_STATE_OUTGOING_REGISTER, SUBSTATE_NONE)
235093: Sep 14 20:16:36.231 IST: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
REGISTER sip:bangalore.relianceims.in:5060 SIP/2.0Via: SIP/2.0/UDP 10.16.81.201:5060;branch=z9hG4bK15A01E38From: <sip:
+914438051000@bangalore.relianceims.in>;tag=BAC027BC-219BTo: <sip:+914438051000@bangalore.relianceims.in>Date: Wed, 14 Sep
2016 14:46:36 GMTCall-ID: DEEF2497-79C011E6-B0FDD6BB-FB6EA3E8User-Agent: Cisco-SIPGateway/IOS-12.xMax-Forwards:
70Timestamp: 1473864396CSeq: 2 REGISTERContact: <sip:+914438051000@10.16.81.201:5060>Expires: 1800Supported: pathContent-
Length: 0
235094: Sep 14 20:16:36.295 IST: //-1/xxxxxxxxxxxx/SIP/Info/HandleUdpIPv4SocketReads: Msg enqueued for SPI with IP addr:
[10.237.246.225]:5060, local_address:[ - ]
235095: Sep 14 20:16:36.295 IST: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 2 for
event 1
235096: Sep 14 20:16:36.295 IST: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x0
235097: Sep 14 20:16:36.295 IST: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_new_msg_preprocessor: Checking Invite Dialog
235098: Sep 14 20:16:36.295 IST: //423548/000000000000/SIP/Info/sipSPIMatchRespToReqTran: removing unneeded z9hG4bK15A01E38
from via branch list
235099: Sep 14 20:16:36.295 IST: //423548/000000000000/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 401 UnauthorizedVia: SIP/2.0/UDP 10.16.81.201:5060;branch=z9hG4bK15A01E38To: <sip:
+914438051000@bangalore.relianceims.in>;tag=ztesipYso1uH6x-gdJ*1-4-16648*fgi.1From: <sip:
+914438051000@bangalore.relianceims.in>;tag=BAC027BC-219BCall-ID: DEEF2497-79C011E6-B0FDD6BB-FB6EA3E8CSeq: 2
REGISTERWWW-Authenticate: Digest
realm="bangalore.relianceims.in",domain="sip:scscf1.bangalore.relianceims.in",nonce="d41d8cd98f00b204e9800998ecf8427e",opaque="aW1
zLmNvbS5jbg==",stale=TRUE,algorithm=MD5,qop="auth"Content-Length: 0
235100: Sep 14 20:16:36.295 IST: //423548/000000000000/SIP/Info/sipSPICheckResponseExt: non-INVITE response with no RSEQ - do not
disable IS_REL1XX
235101: Sep 14 20:16:36.295 IST: //423548/000000000000/SIP/Info/sipSPIGenerateAuthorizationResponse: HA1 is:
c0135a17f03bef7c5f7969e7eca9561f
235102: Sep 14 20:16:36.295 IST: //423548/000000000000/SIP/Info/sipSPIPresendProcessing: Presend Processing called for 7 event
235103: Sep 14 20:16:36.295 IST: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIRetrieveOutgoingPassThruData: Retrieving Data from RCB
235104: Sep 14 20:16:36.295 IST: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIRetrieveOutgoingPassThruData: Retrieving Data from RCB
235105: Sep 14 20:16:36.295 IST: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetDateHeader: Converting TimeZone IST to SIP default timezone = GMT
235106: Sep 14 20:16:36.299 IST: //423548/000000000000/SIP/Info/sipSPISendRegister: Associated container=0x6B637100 to Register
235107: Sep 14 20:16:36.299 IST: //423548/000000000000/SIP/Transport/sipSPISendRegister: Sending REGISTER to the transport layer
235108: Sep 14 20:16:36.299 IST: //423548/000000000000/SIP/Transport/sipSPIGetSwitchTransportFlag: Return the Global configuration,
Switch Transport is FALSE
235109: Sep 14 20:16:36.299 IST: //423548/000000000000/SIP/Transport/sipSPITransportSendMessage: msg=0x73556AAC,
addr=10.237.246.225, port=5060, sentBy_port=0, local_addr=, is_req=1, transport=1, switch=0, callBack=0x61B14BA0
235110: Sep 14 20:16:36.299 IST: //423548/000000000000/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg
immediately
235111: Sep 14 20:16:36.299 IST: //423548/000000000000/SIP/Transport/sipTransportLogicSendMsg: switch transport is 0
235112: Sep 14 20:16:36.299 IST: //-1/xxxxxxxxxxxx/SIP/Transport/sipConnectionManagerGetConnection: connection required for
raddr:10.237.246.225, rport:5060 with laddr:

235113: Sep 14 20:16:36.299 IST: //423548/000000000000/SIP/Transport/sipTransportLogicSendMsg: Set to send the msg=0x73556AAC
235114: Sep 14 20:16:36.299 IST: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x73556AAC,
addr=10.237.246.225, port=5060, local_addr=, connId=2 for UDP
235115: Sep 14 20:16:36.299 IST: //423548/000000000000/SIP/State/sipSPIChangeState: 0x7116DEB8 : State change from
(SIP_STATE_OUTGOING_REGISTER, SUBSTATE_NONE) to (SIP_STATE_OUTGOING_REGISTER, SUBSTATE_NONE)
235116: Sep 14 20:16:36.299 IST: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
REGISTER sip:bangalore.relianceims.in:5060 SIP/2.0Via: SIP/2.0/UDP 10.16.81.201:5060;branch=z9hG4bK15A11487From: <sip:
+914438051000@bangalore.relianceims.in>;tag=BAC027BC-219BTo: <sip:+914438051000@bangalore.relianceims.in>Date: Wed, 14 Sep
2016 14:46:36 GMTCall-ID: DEEF2497-79C011E6-B0FDD6BB-FB6EA3E8User-Agent: Cisco-SIPGateway/IOS-12.xMax-Forwards:
70Timestamp: 1473864396CSeq: 3 REGISTERContact: <sip:+914438051000@10.16.81.201:5060>Expires: 1800Authorization: Digest
username="+914438051000@bangalore.relianceims.in",realm="bangalore.relianceims.in",uri="sip:bangalore.relianceims.in:5060",response="8
0229339f802eeb9cf669d95e0a38732",nonce="d41d8cd98f00b204e9800998ecf8427e",opaque="aW1zLmNvbS5jbg==",cnonce="8EB59523",q
op=auth,algorithm=MD5,nc=00000001Content-Length: 0
235117: Sep 14 20:16:36.367 IST: //-1/xxxxxxxxxxxx/SIP/Info/HandleUdpIPv4SocketReads: Msg enqueued for SPI with IP addr:
[10.237.246.225]:5060, local_address:[ - ]
235118: Sep 14 20:16:36.367 IST: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 2 for
event 1
235119: Sep 14 20:16:36.367 IST: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x0
235120: Sep 14 20:16:36.367 IST: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_new_msg_preprocessor: Checking Invite Dialog
235121: Sep 14 20:16:36.367 IST: //423548/000000000000/SIP/Info/sipSPIMatchRespToReqTran: removing unneeded z9hG4bK15A11487
from via branch list
235122: Sep 14 20:16:36.367 IST: //423548/000000000000/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 200 OKVia: SIP/2.0/UDP 10.16.81.201:5060;branch=z9hG4bK15A11487To: <sip:
+914438051000@bangalore.relianceims.in>;tag=ztesip6nnIwsc2_q7P9EiNPZr10wq*1-4-16648*fgj.1From: <sip:
+914438051000@bangalore.relianceims.in>;tag=BAC027BC-219BCall-ID: DEEF2497-79C011E6-B0FDD6BB-FB6EA3E8CSeq: 3
REGISTERContact: <sip:+914438051000@10.16.81.201:5060>;expires=1800P-Associated-URI: <tel:+914438051000>P-Associated-URI:
<sip:+91443805![1-3][0-9]{3}!@bangalore.relianceims.in>P-Associated-URI: <tel:+91443805![1-3][0-9]{3}!>P-Associated-URI: <sip:
+914438051000@bangalore.relianceims.in>P-Associated-URI: <sip:+914438054![0-4][0-9]{2}!@bangalore.relianceims.in>P-Associated-URI:
<tel:+914438054![0-4][0-9]{2}!>Date: Wed, 14 Sep 2016 14:46:37 GMTAuthentication-Info:
nextnonce="d28cfa0aadc9961af310252caad23a7e",qop=auth,rspauth="9011e7d48344428ff8784b16411ec8ba",cnonce="8EB59523",nc=000
00001Content-Length: 0
235123: Sep 14 20:16:36.367 IST: //423548/000000000000/SIP/Info/sipSPICheckResponseExt: non-INVITE response with no RSEQ - do not
disable IS_REL1XX
235124: Sep 14 20:16:36.367 IST: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIDecrementOverloadCount: Count:Local 0 Global 0
235125: Sep 14 20:16:36.367 IST: //423548/000000000000/SIP/Info/sipSPIRegPthruProcessResponse: Processing response w/ resp code
== 200
235126: Sep 14 20:16:36.367 IST: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIGetRPCBFromRCB: Retreiving RCB [0x6B272934] from RPCB [0x0]
235127: Sep 14 20:16:36.367 IST: //423548/000000000000/SIP/Error/sipSPIRegPthruProcessResponse: Error NO RPCB

235128: Sep 14 20:16:36.367 IST: //-1/xxxxxxxxxxxx/SIP/Info/ccsipRegisterStartRCBTimer: Starting timer for pattern +914438051000 for 1440
seconds
235129: Sep 14 20:16:36.367 IST: //423548/000000000000/SIP/Info/ccsip_gw_register_get_response_info: Create new SIP register
response info (0x69382170)
235130: Sep 14 20:16:36.367 IST: //423548/000000000000/SIP/Info/ccsip_gw_register_process_response: P-Associated-URI (<tel:
+914438051000>,<sip:+91443805![1-3][0-9]{3}!@bangalore.relianceims.in>,<tel:+91443805![1-3][0-9]{3}!>,<sip:
+914438051000@bangalore.relianceims.in>,<sip:+914438054![0-4][0-9]{2}!@bangalore.relianceims.in>,<tel:+914438054![0-4][0-9]{2}!>)
235131: Sep 14 20:16:36.367 IST: //423548/000000000000/SIP/Info/ccsip_gw_register_process_response: URI (<tel:+914438051000>)
235132: Sep 14 20:16:36.367 IST: //423548/000000000000/SIP/Info/ccsip_gw_register_process_response: user portion of URI
(914438051000)
235133: Sep 14 20:16:36.367 IST: //423548/000000000000/SIP/Info/ccsip_gw_register_process_response: URI (<sip:+91443805![1-3][0-9]
{3}!@bangalore.relianceims.in>)
235134: Sep 14 20:16:36.367 IST: Parse Error: url_parseSipUrl: Bad separator sequence
235135: Sep 14 20:16:36.367 IST: //423548/000000000000/SIP/Error/ccsip_gw_register_process_response: Invalid SIP location
235136: Sep 14 20:16:36.371 IST: //423548/000000000000/SIP/Error/ccsip_gw_register_process_response: Un-register and Re-register
number (+914438051000)
235137: Sep 14 20:16:36.371 IST: //423548/000000000000/SIP/Info/ccsip_gw_register_free_response_info: Free Register Response Info
(0x69382170)
235138: Sep 14 20:16:36.371 IST: //423548/000000000000/SIP/Error/ccsip_api_register_result_ind: Error detected in 200 OK Register
Response
235139: Sep 14 20:16:36.371 IST: //423548/000000000000/SIP/Info/ccsip_register_reset_registration: Un-register/Re-register usersname
+914438051000
235140: Sep 14 20:16:36.371 IST: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_register_handle_e164_rcb_unregistration: CCSIP_UNREGISTER:: e164
rcb number (+914438051000)
235141: Sep 14 20:16:36.371 IST: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_register_delete_from_e164_table: ****Deleted +914438051000 from E164
Table
235142: Sep 14 20:16:36.371 IST: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIAddContextToTable: Added context(0x711576D8) with key=[3993] to table
235143: Sep 14 20:16:36.371 IST: //-1/000000000000/SIP/Info/ccsip_offer_ans_init:
235144: Sep 14 20:16:36.371 IST: //-1/000000000000/SIP/Info/ccsip_iwf_init:
235145: Sep 14 20:16:36.371 IST: //-1/000000000000/SIP/Info/ccsip_ipip_media_service_init:
235146: Sep 14 20:16:36.371 IST: //-1/000000000000/SIP/Info/sipSPI_ipip_vcc_Initialization: Entry...
235147: Sep 14 20:16:36.371 IST: //-1/000000000000/SIP/Info/sipSPIOutboundProxyReuse: Do not reuse Outbound Proxy IP adress and
Port
235148: Sep 14 20:16:36.371 IST: //-1/000000000000/SIP/State/sipSPIChangeState: 0x711576D8 : State change from (STATE_NONE,
SUBSTATE_NONE) to (STATE_IDLE, SUBSTATE_NONE)
235149: Sep 14 20:16:36.371 IST: //-1/000000000000/SIP/Info/ccsip_spi_registrar_add_expires_header: Inside
ccsip_spi_registrar_add_expires_header for Expires
235150: Sep 14 20:16:36.371 IST: //-1/xxxxxxxxxxxx/SIP/Event/sipSPIEventInfo: Queued event from SIP SPI :
SIPSPI_EV_OUTBOUND_REGISTER
235151: Sep 14 20:16:36.371 IST: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIIncrementOverloadCount: Local 1 Global 1
235152: Sep 14 20:16:36.371 IST: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_spi_register_get_rcb: Getting New RCB [0x74393A98]
235153: Sep 14 20:16:36.371 IST: //423548/000000000000/SIP/Info/ccsip_register_reset_registration: Re-Register number
(+914438051000)
235154: Sep 14 20:16:36.371 IST: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_register_search_e164_table: ****No entry found in E164 Table
235155: Sep 14 20:16:36.371 IST: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_register_add_to_e164_table: ****Added to E164 Table at position: 0
235156: Sep 14 20:16:36.371 IST: //-1/xxxxxxxxxxxx/SIP/Info/ccsipRegisterStartRCBTimer: Starting timer for pattern +914438051000 for 1440
seconds
235157: Sep 14 20:16:36.371 IST: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIDeleteContextFromTable: Context for key=[3992] removed.
235158: Sep 14 20:16:36.371 IST: //423548/000000000000/SIP/Info/sipSPIUdeleteCcbFromUACTable: ****Deleting from UAC table.
235159: Sep 14 20:16:36.371 IST: //423548/000000000000/SIP/Info/sipSPIUdeleteCcbFromTable: Deleting from table. ccb=0x7116DEB8
key=DEEF2497-79C011E6-B0FDD6BB-FB6EA3E8
235160: Sep 14 20:16:36.371 IST: //423548/000000000000/SIP/Info/sipSPIFlushEventBufferQueue: There are 0 events on the internal queue
that are going to be free'd
235161: Sep 14 20:16:36.371 IST: //423548/000000000000/SIP/Info/sipSPI_ipip_free_codec_profile: Codec Profiles Freed
235162: Sep 14 20:16:36.371 IST: //423548/000000000000/SIP/Info/ccsip_offer_ans_delete:
235163: Sep 14 20:16:36.371 IST: //423548/000000000000/SIP/Info/ccsip_iwf_delete:
235164: Sep 14 20:16:36.371 IST: //423548/000000000000/SIP/Info/sipSPIUfreeOneCCB: Freeing ccb 7116DEB8
235165: Sep 14 20:16:36.371 IST: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIGetContextFromTable: NO context for key[3992]
235166: Sep 14 20:16:36.371 IST: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 3 for
event 40
235167: Sep 14 20:16:36.371 IST: //-1/000000000000/SIP/Info/act_idle_outgoing_register: In act_idle_outgoing_register

235168: Sep 14 20:16:36.371 IST: //-1/000000000000/SIP/Info/act_idle_outgoing_register: Send REGISTER to 10.237.246.225:5060

235169: Sep 14 20:16:36.371 IST: //-1/000000000000/SIP/Info/sipSPIUaddCcbToUACTable: ****Adding to UAC table.
235170: Sep 14 20:16:36.371 IST: //-1/000000000000/SIP/Info/sipSPIUaddCcbToTable: Added to table. ccb=0x711576D8 key=DEEF2497-
79C011E6-B0FDD6BB-FB6EA3E8
235171: Sep 14 20:16:36.371 IST: //-1/xxxxxxxxxxxx/SIP/Info/resolve_sig_ip_address_to_bind: calling reg_invoke_ip_first_hop()
235172: Sep 14 20:16:36.371 IST: //-1/xxxxxxxxxxxx/SIP/Info/resolve_sig_ip_address_to_bind: calling ip_best_local_address()
235173: Sep 14 20:16:36.371 IST: //-1/xxxxxxxxxxxx/SIP/Info/resolve_sig_ip_address_to_bind: return addr 10.16.81.201
235174: Sep 14 20:16:36.371 IST: //-1/000000000000/SIP/Info/sipSPIPresendProcessing: Presend Processing called for 7 event
235175: Sep 14 20:16:36.371 IST: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIRetrieveOutgoingPassThruData: Retrieving Data from RCB
235176: Sep 14 20:16:36.371 IST: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIRetrieveOutgoingPassThruData: Retrieving Data from RCB
235177: Sep 14 20:16:36.371 IST: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetDateHeader: Converting TimeZone IST to SIP default timezone = GMT
235178: Sep 14 20:16:36.371 IST: //-1/000000000000/SIP/Info/sipSPISendRegister: Associated container=0x6B63D5B8 to Register
235179: Sep 14 20:16:36.371 IST: //-1/000000000000/SIP/Transport/sipSPISendRegister: Sending REGISTER to the transport layer
235180: Sep 14 20:16:36.371 IST: //-1/000000000000/SIP/Transport/sipSPIGetSwitchTransportFlag: Return the Global configuration, Switch
Transport is FALSE
235181: Sep 14 20:16:36.371 IST: //-1/000000000000/SIP/Transport/sipSPITransportSendMessage: msg=0x7176E7F8,
addr=10.237.246.225, port=5060, sentBy_port=0, local_addr=, is_req=1, transport=1, switch=0, callBack=0x61B14BA0
235182: Sep 14 20:16:36.371 IST: //-1/000000000000/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg
immediately
235183: Sep 14 20:16:36.371 IST: //-1/000000000000/SIP/Transport/sipTransportLogicSendMsg: switch transport is 0
235184: Sep 14 20:16:36.371 IST: //-1/xxxxxxxxxxxx/SIP/Transport/sipConnectionManagerGetConnection: connection required for
raddr:10.237.246.225, rport:5060 with laddr:

235185: Sep 14 20:16:36.371 IST: //-1/000000000000/SIP/Transport/sipTransportLogicSendMsg: Set to send the msg=0x7176E7F8
235186: Sep 14 20:16:36.371 IST: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x7176E7F8,
addr=10.237.246.225, port=5060, local_addr=, connId=2 for UDP
235187: Sep 14 20:16:36.371 IST: //-1/000000000000/SIP/State/sipSPIChangeState: 0x711576D8 : State change from (STATE_IDLE,
SUBSTATE_NONE) to (SIP_STATE_OUTGOING_REGISTER, SUBSTATE_NONE)
235188: Sep 14 20:16:36.371 IST: //-1/000000000000/SIP/State/sipSPIChangeState: 0x711576D8 : State change from
(SIP_STATE_OUTGOING_REGISTER, SUBSTATE_NONE) to (SIP_STATE_OUTGOING_REGISTER, SUBSTATE_NONE)
235189: Sep 14 20:16:36.375 IST: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
REGISTER sip:bangalore.relianceims.in:5060 SIP/2.0Via: SIP/2.0/UDP 10.16.81.201:5060;branch=z9hG4bK15A2A25From: <sip:
+914438051000@bangalore.relianceims.in>;tag=BAC0284C-1A52To: <sip:+914438051000@bangalore.relianceims.in>Date: Wed, 14 Sep
2016 14:46:36 GMTCall-ID: DEEF2497-79C011E6-B0FDD6BB-FB6EA3E8User-Agent: Cisco-SIPGateway/IOS-12.xMax-Forwards:
70Timestamp: 1473864396CSeq: 4 REGISTERContact: <sip:+914438051000@10.16.81.201:5060>Expires: 0Supported: pathContent-
Length: 0
235190: Sep 14 20:16:36.435 IST: //-1/xxxxxxxxxxxx/SIP/Info/HandleUdpIPv4SocketReads: Msg enqueued for SPI with IP addr:
[10.237.246.225]:5060, local_address:[ - ]
235191: Sep 14 20:16:36.435 IST: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 2 for
event 1
235192: Sep 14 20:16:36.435 IST: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x0
235193: Sep 14 20:16:36.435 IST: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_new_msg_preprocessor: Checking Invite Dialog
235194: Sep 14 20:16:36.435 IST: //-1/000000000000/SIP/Info/sipSPIMatchRespToReqTran: removing unneeded z9hG4bK15A2A25 from via
branch list
235195: Sep 14 20:16:36.435 IST: //-1/000000000000/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 200 OKVia: SIP/2.0/UDP 10.16.81.201:5060;branch=z9hG4bK15A2A25To: <sip:
+914438051000@bangalore.relianceims.in>;tag=ztesipOwDkS4GQ*1-4-16648*fhc.1From: <sip:
+914438051000@bangalore.relianceims.in>;tag=BAC0284C-1A52Call-ID: DEEF2497-79C011E6-B0FDD6BB-FB6EA3E8CSeq: 4
REGISTERContact: <sip:+914438051000@10.16.81.201:5060>;expires=0P-Associated-URI: <tel:+914438051000>P-Associated-URI: <tel:
+914438054![0-4][0-9]{2}!>P-Associated-URI: <sip:+914438054![0-4][0-9]{2}!@bangalore.relianceims.in>P-Associated-URI: <sip:
+914438051000@bangalore.relianceims.in>P-Associated-URI: <tel:+91443805![1-3][0-9]{3}!>P-Associated-URI: <sip:+91443805![1-3][0-9]
{3}!@bangalore.relianceims.in>Date: Wed, 14 Sep 2016 14:46:37 GMTContent-Length: 0
235196: Sep 14 20:16:36.439 IST: //-1/000000000000/SIP/Info/sipSPICheckResponseExt: non-INVITE response with no RSEQ - do not
disable IS_REL1XX
235197: Sep 14 20:16:36.439 IST: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIDecrementOverloadCount: Count:Local 0 Global 0
235198: Sep 14 20:16:36.439 IST: //-1/000000000000/SIP/Info/sipSPIRegPthruProcessResponse: Processing response w/ resp code == 200
235199: Sep 14 20:16:36.439 IST: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIGetRPCBFromRCB: Retreiving RCB [0x6B272934] from RPCB [0x0]
235200: Sep 14 20:16:36.439 IST: //-1/000000000000/SIP/Error/sipSPIRegPthruProcessResponse: Error NO RPCB

235201: Sep 14 20:16:36.439 IST: //-1/000000000000/SIP/Info/ccsipGetCCBFromRCB: Retrived CCB pointer [0x711576D8]
235202: Sep 14 20:16:36.439 IST: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_spi_register_free_rcb: Freeing rcb [0x6B272934]
235203: Sep 14 20:16:36.439 IST: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIDeleteContextFromTable: Context for key=[3993] removed.
235204: Sep 14 20:16:36.439 IST: //-1/000000000000/SIP/Info/sipSPIUdeleteCcbFromUACTable: ****Deleting from UAC table.
235205: Sep 14 20:16:36.439 IST: //-1/000000000000/SIP/Info/sipSPIUdeleteCcbFromTable: Deleting from table. ccb=0x711576D8
key=DEEF2497-79C011E6-B0FDD6BB-FB6EA3E8
235206: Sep 14 20:16:36.439 IST: //-1/000000000000/SIP/Info/sipSPIFlushEventBufferQueue: There are 0 events on the internal queue that
are going to be free'd
235207: Sep 14 20:16:36.439 IST: //-1/000000000000/SIP/Info/sipSPI_ipip_free_codec_profile: Codec Profiles Freed
235208: Sep 14 20:16:36.439 IST: //-1/000000000000/SIP/Info/ccsip_offer_ans_delete:
235209: Sep 14 20:16:36.439 IST: //-1/000000000000/SIP/Info/ccsip_iwf_delete:
235210: Sep 14 20:16:36.439 IST: //423549/000000000000/SIP/Info/sipSPIUfreeOneCCB: Freeing ccb 711576D8
235211: Sep 14 20:16:36.439 IST: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIGetContextFromTable: NO context for key[3993]

[Mohammed Khan]

\\ SIP 200 Ok from Telco \\

SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.16.81.201:5060;branch=z9hG4bK15A11487
To: <sip:+914438051000@bangalore.relianceims.in>;tag=ztesip6nnIwsc2_q7P9EiNPZr10wq*1-4-16648*fgj.1
From: <sip:+914438051000@bangalore.relianceims.in>;tag=BAC027BC-219B
Call-ID: DEEF2497-79C011E6-B0FDD6BB-FB6EA3E8
CSeq: 3
REGISTER
Contact: <sip:+914438051000@10.16.81.201:5060>;
expires=1800
P-Associated-URI: <tel:+914438051000>
P-Associated-URI:<sip:+91443805![1-3][0-9]{3}!@bangalore.relianceims.in>
P-Associated-URI: <tel:+91443805![1-3][0-9]{3}!>
P-Associated-URI: <sip:+914438051000@bangalore.relianceims.in>
P-Associated-URI: <sip:+914438054![0-4][0-9]{2}!@bangalore.relianceims.in>
P-Associated-URI:<tel:+914438054![0-4][0-9]{2}!>
Date: Wed, 14 Sep 2016 14:46:37 GMT
Authentication-Info:nextnonce="d28cfa0aadc9961af310252caad23a7e",qop=auth,rspauth="9011e7d48344428ff8784b16411ec8ba",cnonce="8EB59523",nc=00000001
Content-Length: 0

\\CUBE don't like any special characters in P-Associated-URI, hence detects an error in 200 OK\\

235135: Sep 14 20:16:36.367 IST: //423548/000000000000/SIP/Error/ccsip_gw_register_process_response: Invalid SIP location
235136: Sep 14 20:16:36.371 IST: //423548/000000000000/SIP/Error/ccsip_gw_register_process_response: Un-register and Re-register number (+914438051000)
235137: Sep 14 20:16:36.371 IST: //423548/000000000000/SIP/Info/ccsip_gw_register_free_response_info: Free Register Response Info (0x69382170)
235138: Sep 14 20:16:36.371 IST: //423548/000000000000/SIP/Error/ccsip_api_register_result_ind: Error detected in 200 OK Register Response
235139: Sep 14 20:16:36.371 IST: //423548/000000000000/SIP/Info/ccsip_register_reset_registration: Un-register/Re-register usersname +914438051000
235140: Sep 14 20:16:36.371 IST: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_register_handle_e164_rcb_unregistration: CCSIP_UNREGISTER:: e164 rcb number (+914438051000)

Symptoms matches below defect.

CSCtl73914 - 2921 Gateway -15.1-1-T1 running unable to register with IMS

Try upgrading IOS to latest version

[mailgunj]

Hello Mohammad,

Thank you for your response. We have planned for an upgrade over the weekend. Will let you know if it worked post upgrade.

Regards,

Gunjan Jain

[mailgunj]

Hello Mohammad,

Upgrading to the latest firmware did not help. Is there any other way out?

Thanks & regards,

Gunjan Jain

[Mohammed Khan]

collect below debugs

debug ccsip all

debug voip ccapi inout

[Robert Shaw]

Hi,

Can we see the output of the following?

Show run

Show sip-ua register status

Show ver

Thanks
Rob

[mailgunj]

Hello Rob,

Please find the attached files.

Thanks & regards,

Gunjan Jain

[shakir0011]

Hello,

We are experiencing same issue, any solution available?