Buy or Renew
Buy or Renew
cancel
Turn on suggestions
Auto-suggest helps you quickly narrow down your search results by suggesting possible matches as you type.
Showing results for 
Search instead for 
Did you mean: 
cancel
Start a conversation
3351
Views
10
Helpful
6
Replies

SIP Trunk Registration Problems

Robert Shaw
Level 3
Level 3

‎11-11-2014 04:32 AM - edited ‎03-17-2019 12:52 AM

Hi Folks,

 

I'm in need of a little help.  I've been trawling the internet for days to try and find the answer I'm looking for, everything tells me I've got it right, but something must be wrong.

I have a Cisco 2901 being configured as a CUBE to register a SIP Trunk with my provider.  I'm running IOS 15.2(3).  Running CUCM 9.1 in the backend, but I'm mainly concerned at the moment with the SIP Trunk Registration on the CUBE.

Basically my trunk won't register, my provider tells me that the Supported:Path tag in the outbound Register header shouldn't be there and I should also be sending a NONCE, which as you will see from the output below is blank.  Apparently at that point they will challenge me with a new NONCE which my gateway will respond to and receive a 200 OK.  I'm not sure how to get my CUBE to send a NONCE, everything I've read so far suggests my (basic) config should generate it in the Authorize Register Header.  I have included the key bits of the config below the CCSIP Register output, if you need anything else from the config please let me know.  Can someone please point me in the right direction?

 

Nov 11 12:24:30.868: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_register_reset_dns_cache: CCSIP_REGISTER:: registrar 0 DNS resolved addr reset
Nov 11 12:24:30.868: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_spi_register_update_e164_registrations: CCSIP_REGISTER:: e164 number (1411802) event (1)
Nov 11 12:24:30.868: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_register_search_e164_table: ****No entry found in E164 Table
Nov 11 12:24:30.868: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_spi_register_get_rcb: Getting New RCB [0x32875B1C]
Nov 11 12:24:30.868: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIAddContextToTable: Added context(0x32651960) with key=[28] to table
Nov 11 12:24:30.868: //-1/000000000000/SIP/Info/ccsip_offer_ans_init:
Nov 11 12:24:30.868: //-1/000000000000/SIP/Info/ccsip_iwf_init:
Nov 11 12:24:30.868: //-1/000000000000/SIP/Info/ccsip_ipip_media_service_init:
Nov 11 12:24:30.868: //-1/000000000000/SIP/Info/sipSPI_ipip_vcc_Initialization:  Entry...
Nov 11 12:24:30.868: //-1/000000000000/SIP/Info/ccsip_ipip_media_forking_init: MF: Queue is initialised..
Nov 11 12:24:30.868: //-1/000000000000/SIP/Info/ccsipRegisterSetTargetInfo: p2p mode with Registrar Server = dns:sip.orbtalk.co.uk
Nov 11 12:24:30.868: //-1/000000000000/SIP/Info/ccsipRegisterSetTargetInfo: Parsing The Registrar Address
Nov 11 12:24:30.868: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIGetOutboundHostAndDestHostPrivate: CCSIP: target_host : sip.orbtalk.co.uk target_port : 5060

Nov 11 12:24:30.868: //-1/000000000000/SIP/Info/sipSPIValidateAndCopyOutboundHost: CCSIP: copy target_host to outbound_host
Nov 11 12:24:30.868: //-1/000000000000/SIP/Info/sipSPIOutboundProxyReuse: Do not reuse Outbound Proxy IP adress and Port
Nov 11 12:24:30.868: //-1/000000000000/SIP/State/sipSPIChangeState: 0x32651960 : State change from (STATE_NONE, SUBSTATE_NONE)  to (STATE_IDLE, SUBSTATE_NONE)
Nov 11 12:24:30.868: //-1/000000000000/SIP/Info/ccsip_spi_registrar_add_expires_header: Inside ccsip_spi_registrar_add_expires_header for Expires
Nov 11 12:24:30.868: //-1/xxxxxxxxxxxx/SIP/Event/sipSPIEventInfo: Queued event from SIP SPI : SIPSPI_EV_OUTBOUND_REGISTER
Nov 11 12:24:30.868: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIIncrementOverloadCount: Local 1 Global 1
Nov 11 12:24:30.868: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_register_add_to_e164_table: ****Added to E164 Table at position: 0
Nov 11 12:24:30.868: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 3 for event 40
Nov 11 12:24:30.868: //-1/000000000000/SIP/Info/act_idle_outgoing_register: In act_idle_outgoing_register

Nov 11 12:24:30.868: //18/000000000000/SIP/Info/act_idle_outgoing_register:  Send REGISTER to sip.orbtalk.co.uk:5060

Nov 11 12:24:30.868: //18/000000000000/SIP/Info/sipSPIUaddCcbToUACTable: ****Adding to UAC table.
Nov 11 12:24:30.868: //18/000000000000/SIP/Info/sipSPIUaddCcbToTable: Added to table. ccb=0x32651960 key=856ACD7B-68D411E4-800CC209-840A6404
Nov 11 12:24:30.868: //-1/xxxxxxxxxxxx/SIP/Event/sipSPIEventInfo: Queued event from SIP SPI : SIPSPI_EV_DNS_RESOLVE
Nov 11 12:24:30.868: //18/000000000000/SIP/State/sipSPIChangeState: 0x32651960 : State change from (STATE_IDLE, SUBSTATE_NONE)  to (STATE_IDLE, SUBSTATE_SENT_DNS)
Nov 11 12:24:30.868: //18/000000000000/SIP/State/sipSPIChangeState: 0x32651960 : State change from (STATE_IDLE, SUBSTATE_SENT_DNS)  to (SIP_STATE_OUTGOING_REGISTER, SUBSTATE_SENT_DNS)
Nov 11 12:24:30.868: //-1/xxxxxxxxxxxx/SIP/Info/sip_dns_type_srv_query: TYPE SRV query for _sip._udp.sip.orbtalk.co.uk and type:1
Nov 11 12:24:30.900: //-1/xxxxxxxxxxxx/SIP/Info/sip_dns_type_a_aaaa_query: DNS query for sip.orbtalk.co.uk and type:1
Nov 11 12:24:30.900: //-1/xxxxxxxxxxxx/SIP/Info/sip_dns_type_a_query: TYPE A query successful for sip.orbtalk.co.uk
Nov 11 12:24:30.900: //-1/xxxxxxxxxxxx/SIP/Info/sip_dns_type_a_aaaa_query: IP Address of sip.orbtalk.co.uk is:

Nov 11 12:24:30.900: //-1/xxxxxxxxxxxx/SIP/Info/sip_dns_type_a_aaaa_query: 217.20.39.101

Nov 11 12:24:30.900: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 2 for event 43
Nov 11 12:24:30.900: //-1/xxxxxxxxxxxx/SIP/Info/sipSPICacheHostToCCB: sipSPICacheHostToCCB dnsResponse.num_hosts = 1
Nov 11 12:24:30.900: //-1/xxxxxxxxxxxx/SIP/Info/sipSPICacheHostToCCB: IP Address No. 1, IP address 217.20.39.101
Nov 11 12:24:30.900: //-1/xxxxxxxxxxxx/SIP/Info/resolve_sig_ip_address_to_bind: calling reg_invoke_ip_first_hop()
Nov 11 12:24:30.900: //-1/xxxxxxxxxxxx/SIP/Info/resolve_sig_ip_address_to_bind: ip_best_local_address 80.194.85.94 for SIP
Nov 11 12:24:30.900: //-1/xxxxxxxxxxxx/SIP/Info/resolve_sig_ip_address_to_bind: return addr 80.194.85.94
Nov 11 12:24:30.900: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_spi_register_get_rcb: Getting New RCB [0x328766A8]
Nov 11 12:24:30.900: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_register_set_dns_resolved_address: CCSIP_REGISTER:: registrar 0 DNS resolved addr set to 217.20.39.101:5060
Nov 11 12:24:30.900: //-1/xxxxxxxxxxxx/SIP/Info/ccsipRegisterStartRCBTimer: Starting timer for pattern  for 3600 seconds
Nov 11 12:24:30.900: //18/000000000000/SIP/State/sipSPIChangeState: 0x32651960 : State change from (SIP_STATE_OUTGOING_REGISTER, SUBSTATE_SENT_DNS)  to (SIP_STATE_OUTGOING_REGISTER, SUBSTATE_NONE)
Nov 11 12:24:30.900: //18/000000000000/SIP/Info/sipSPIPresendProcessing: Presend Processing called for 7 event
Nov 11 12:24:30.900: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIRetrieveOutgoingPassThruData: Retrieving Data from RCB
Nov 11 12:24:30.900: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIRetrieveOutgoingPassThruData: Retrieving Data from RCB
Nov 11 12:24:30.900: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetDateHeader: Converting TimeZone ASD to SIP default timezone = GMT
Nov 11 12:24:30.900: //18/000000000000/SIP/Info/sipSPISendRegister: Associated container=0x3285AE3C to Register
Nov 11 12:24:30.900: //18/000000000000/SIP/Transport/sipSPISendRegister: Sending REGISTER to the transport layer
Nov 11 12:24:30.900: //18/000000000000/SIP/Transport/sipSPIGetSwitchTransportFlag: Return the Global configuration, Switch Transport is FALSE
Nov 11 12:24:30.900: //18/000000000000/SIP/Transport/sipSPITransportSendMessage: msg=0x2C9FC918, addr=217.20.39.101, port=5060, sentBy_port=0, local_addr=, is_req=1, transport=1, switch=0, callBack=0x255E40D8
Nov 11 12:24:30.900: //18/000000000000/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg immediately
Nov 11 12:24:30.900: //18/000000000000/SIP/Transport/sipTransportLogicSendMsg: switch transport is 0
Nov 11 12:24:30.900: //-1/xxxxxxxxxxxx/SIP/Transport/sipConnectionManagerGetConnection: connection required for raddr:217.20.39.101, rport:5060 with laddr:

Nov 11 12:24:30.900: //-1/xxxxxxxxxxxx/SIP/Transport/sipInstanceGetConnectionId: Registering gcb=0x32651960 with connection=0x316F6034 context list
Nov 11 12:24:30.900: //18/000000000000/SIP/Transport/sipTransportLogicSendMsg: Set to send the msg=0x2C9FC918
Nov 11 12:24:30.900: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x2C9FC918, addr=217.20.39.101, port=5060, local_addr=, connId=2 for UDP
Nov 11 12:24:30.900: //18/000000000000/SIP/State/sipSPIChangeState: 0x32651960 : State change from (SIP_STATE_OUTGOING_REGISTER, SUBSTATE_NONE)  to (SIP_STATE_OUTGOING_REGISTER, SUBSTATE_NONE)
Nov 11 12:24:30.900: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
REGISTER sip:sip.orbtalk.co.uk:5060 SIP/2.0
Via: SIP/2.0/UDP 80.194.85.94:5060;branch=z9hG4bK119DE
From: <sip:1111111@sip.orbtalk.co.uk>;tag=210E98-CD6
To: <sip:1111111@sip.orbtalk.co.uk>
Date: Tue, 11 Nov 2014 12:24:30 GMT
Call-ID: 856ACD7B-68D411E4-800CC209-840A6404
User-Agent: Cisco-SIPGateway/IOS-15.2.3.T1
Max-Forwards: 70
Timestamp: 1415708670
CSeq: 2 REGISTER
Contact: <sip:1111111@80.194.85.94:5060>
Expires:  3600
Supported: path
Authorization: Digest username="1111111",realm="sip.orbtalk.co.uk",uri="sip:sip.orbtalk.co.uk:5060",response="",nonce=""
Content-Length: 0


Nov 11 12:24:30.908: //-1/xxxxxxxxxxxx/SIP/Info/HandleUdpIPv4SocketReads: Msg enqueued for SPI with IP addr: [217.20.39.101]:5060, local_address:[ - ]
Nov 11 12:24:30.908: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 2 for event 1
Nov 11 12:24:30.908: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x316F4C4C
Nov 11 12:24:30.908: //-1/xxxxxxxxxxxx/SIP/Transport/sipConnectionManagerProcessNewConnMsg: gConnTab=0x316F4C4C, addr=217.20.39.101, port=5060, local_addr=, connid=2, transport=UDP
Nov 11 12:24:30.908: //-1/xxxxxxxxxxxx/SIP/Info/sipHolderGetConnInstance: Return existing connection for port 5060 connId 2
Nov 11 12:24:30.908: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_new_msg_preprocessor: Checking Invite Dialog
Nov 11 12:24:30.908: //18/000000000000/SIP/Info/sipSPIMatchRespToReqTran: removing unneeded z9hG4bK119DE from via branch list
Nov 11 12:24:30.908: //18/000000000000/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 405 Method Not Allowed
Via: SIP/2.0/UDP 80.194.85.94:5060;received=80.194.85.94;rport=59499;branch=z9hG4bK119DE
From: <sip:1111111@sip.orbtalk.co.uk>;tag=210E98-CD6
To: <sip:1111111@sip.orbtalk.co.uk>;tag=1053ce00ee7f576c7d81feba4dc61aca.0b4c
Call-ID: 856ACD7B-68D411E4-800CC209-840A6404
CSeq: 2 REGISTER
Server: OrbTalk
Content-Length: 0


Nov 11 12:24:30.908: //18/000000000000/SIP/Info/sipSPICheckResponseExt: non-INVITE response with no RSEQ - do not disable IS_REL1XX
Nov 11 12:24:30.908: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIDecrementOverloadCount: Count:Local 0 Global 0
Nov 11 12:24:30.908: //18/000000000000/SIP/Error/ccsip_api_register_result_ind:
 Message Code Class 4xx Method Code 100 received for REGISTER
Nov 11 12:24:30.908: //-1/xxxxxxxxxxxx/SIP/Info/ccsipGetCCBFromRCB: Retrived CCB pointer [0x0]
Nov 11 12:24:30.908: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_spi_register_free_rcb: Freeing rcb [0x328766A8]
Nov 11 12:24:30.908: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_register_reset_dns_cache: CCSIP_REGISTER:: registrar 0 DNS resolved addr reset
Nov 11 12:24:30.908: //18/000000000000/SIP/Info/sipSPIRegPthruProcessResponse: Processing response w/ resp code == 405
Nov 11 12:24:30.908: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIGetRPCBFromRCB: Retreiving RCB [0x32875B1C] from RPCB [0x0]
Nov 11 12:24:30.908: //18/000000000000/SIP/Error/sipSPIRegPthruProcessResponse:
 Error NO RPCB

Nov 11 12:24:30.908: //-1/xxxxxxxxxxxx/SIP/Info/ccsipRegisterStartRCBTimer: Starting timer for pattern 1411802 for 180 seconds
Nov 11 12:24:30.908: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIDeleteContextFromTable: Context for key=[28] removed.
Nov 11 12:24:30.908: //18/000000000000/SIP
SIP_NEW_TEST(config-sip-ua)#/Info/sipSPIUdeleteCcbFromUACTable: ****Deleting from UAC table.
Nov 11 12:24:30.908: //18/000000000000/SIP/Info/sipSPIUdeleteCcbFromTable: Deleting from table. ccb=0x32651960 key=856ACD7B-68D411E4-800CC209-840A6404
Nov 11 12:24:30.908: //18/000000000000/SIP/Info/sipSPIFlushEventBufferQueue: There are 0 events on the internal queue that are going to be free'd
Nov 11 12:24:30.908: //-1/xxxxxxxxxxxx/SIP/Transport/sipConnectionManagerUnregisterCtxtInConnection: gConnTab=0x316F4C4C, addr=217.20.39.101, port=5060, local_addr=, unregistering context=0x32651960
Nov 11 12:24:30.908: //-1/xxxxxxxxxxxx/SIP/Transport/sipInstancePurgeContextInConnection: Purging context gcb=0x32651960 from the connection=0x316F6034 context list
Nov 11 12:24:30.908: //18/000000000000/SIP/Info/sipSPI_ipip_free_codec_profile: Codec Profiles Freed
Nov 11 12:24:30.908: //18/000000000000/SIP/Info/ccsip_offer_ans_delete:
Nov 11 12:24:30.908: //18/000000000000/SIP/Info/ccsip_iwf_delete:
Nov 11 12:24:30.908: //18/000000000000/SIP/Info/sipSPIUfreeOneCCB: Freeing ccb 0x32651960
Nov 11 12:24:30.908: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIGetContextFromTable: NO context for key[28]

 

voice service voip
 ip address trusted list
  ipv4 217.20.39.102 255.255.255.255
  ipv4 217.20.39.103 255.255.255.255
  ipv4 212.54.141.15 255.255.255.255
  ipv4 193.104.131.76 255.255.255.255
  ipv4 193.104.131.77 255.255.255.255
  ipv4 217.20.39.101 255.255.255.255
  ipv4 217.20.39.100 255.255.255.255
  ipv4 193.104.103.6 255.255.255.255
  ipv4 193.104.103.2 255.255.255.255
 address-hiding
 allow-connections h323 to h323
 allow-connections h323 to sip
 allow-connections sip to h323
 allow-connections sip to sip
 supplementary-service h450.12
 no supplementary-service sip moved-temporarily
 no supplementary-service sip refer
 fax protocol pass-through g711alaw
 h323
 modem passthrough nse codec g711alaw
 sip
  no call service stop
!
sip-ua
 credentials username 1111111 password 7 xxxxxxxxxxxxxxxxxxxx realm sip.orbtalk.co.uk
 authentication username 1111111 password 7 xxxxxxxxxxxxxxxxxxxx realm sip.orbtalk.co.uk
 registrar dns:sip.orbtalk.co.uk expires 3600 auth-realm sip.orbtalk.co.uk
!

 

Labels:
0 Helpful
6 Replies 6

Sreekanth Narayanan
Cisco Employee
Cisco Employee

‎11-11-2014 05:11 AM

Why don't you try creating a sip-profile so you can insert dummy nonce values into the register message?

voice class sip-profiles 1
request REGISTER sip-header Authorization modify "response=\"\",nonce=\"\""
"response=\"2342f17faba6b2aa668030fd60a94690\",nonce=\"BroadcoreXhyvht82kTqeadcgBW\",cnonc
e=\"037CFE8\",qop=auth,algorithm=MD5,nc=00000001"

You don't need to paste it exactly as above. But make sure the nonce has some dummy value. This profile should only get engaged on the first attempt since we are matching with blank response and nonce strings.

Activate the profile by configuring under voice service voip -> sip

 

voice service voip

 sip

  sip-profiles 1

Robert Shaw
Level 3
Level 3
In response to Sreekanth Narayanan

‎11-11-2014 07:31 AM

Thanks a lot for your response.

Just tried this and unfortunately it didn't work.  I spoke to my provider again and they seem to insist that it's caused by the Supported: Path tag in the Register Header.  Apparently this prevents the SIP Trunk populating the nonce.

Thanks
Rob

0 Helpful

Suresh Subramanian
Level 7
Level 7
In response to Robert Shaw

‎11-11-2014 08:32 AM

Hi Rob,

 

if you want to remove the Supported header from Register message, please try the below.

 

voice class sip-profiles 1
  request REGISTER sip-header Supported remove

//Suresh Please rate all the useful posts.

Robert Shaw
Level 3
Level 3
In response to Suresh Subramanian

‎11-12-2014 12:18 AM

Thanks for your suggestion, I tried with just your suggested statement and also tried with both suggestions but unfortunately it still doesn't work.  I should have said that both statements have the desired effect, the first from Sreekanth populates the response and nonce fields and the second from Suresh removes the Supported: Path tag.  So both really good suggestions, but for some reason in my environment the trunk still won't register.

I have since opened a TAC Case with Cisco.  I'll update this discussion with more information as soon as I get a resolution.  It may help others in the future.

Thanks again for talking the time to respond.

0 Helpful

Robert Shaw
Level 3
Level 3

‎11-12-2014 07:06 AM

Following another conversation with my provider it turns out that it was a configuration problem their end.  After weeks of them telling me it was my configuration it turns out to be their side.  Not very happy, maybe I should look at alternative suppliers before I jump into a contract with these guys!

Thanks to everyone that has responded, as always the Cisco community hasn't let me down.  I'm just sorry it was a waste of time in the end.

0 Helpful

Sreekanth Narayanan
Cisco Employee
Cisco Employee
In response to Robert Shaw

‎11-12-2014 07:22 AM

That's alright! Glad you were able to solve your problem!

0 Helpful
Customers Also Viewed These Support Documents