Cisco Mobile client outgoing calls failing

Answered Question
May 23rd, 2012

Hi Everyone,


I'm trying to get Cisco Mobile working with CME 8.6. I can call from the deskphones to the extension of the cisco mobile iphone, and vice versa. 'm getting the following error when trying to place an outgoing call. Outgoing calling is working on the deskphones.



May 23 22:21:16.397: //144/728EE52680F4/SIP/Msg/ccsipDisplayMsg:

Sent:

SIP/2.0 503 Service Unavailable


Via: SIP/2.0/TCP 10.10.2.50:52001;branch=z9hG4bK7c3e1179


From: "David" <sip:[email protected]>;tag=31303430463300110ab8ba82-65dcb24d


To: <sip:[email protected]>;tag=A5FB98-940   !!-- for some reason its sending the call to the CME box (172.16.1.1 rather than the SIP                                                                                                                    provider IP)


Date: Wed, 23 May 2012 22:21:16 GMT


Call-ID: [email protected]


CSeq: 101 INVITE


Allow-Events: telephone-event


Server: Cisco-SIPGateway/IOS-12.x


Reason: Q.850;cause=47


Content-Length: 0


I know its probably a simple config change since I have no other SIP clients (its probably not set up). Can anyone point me in the right direction?


My config.


Thank you,

David

Correct Answer by Ayodeji Okanlawon about 4 years 9 months ago

Can you try this..


voice register pool  10

codec g711u


and test again..

  • 1
  • 2
  • 3
  • 4
  • 5
Overall Rating: 5 (2 ratings)
Loading.
Ayodeji Okanlawon Thu, 05/24/2012 - 00:45

Hi David,


I cant see your config for the SIP softphone? The cisco Mobile is SIP softphone client and I did not see any configuration for it.


I take it that its configured and registered? Maybe the config you sent is old one?

   

Secondly,


The dialled number is only defined as incoming called number on your inbound dial-peer, which suggest that your CME phones all use DNs beginning with this pattern. So the call is sent to CME whihc is the right thing...Are you dialling the correct number?


dial-peer voice 1 voip

description **Incoming Call from SIP Trunk**

incoming called-number 55555555..

Davidwagman1 Thu, 05/24/2012 - 03:59

Hi Aokanlawon, thanks again for the reply.


The mobile iphone client is registered and can place calls to local extensions. Just calling out using the sip trunk is not working.  Is this what you are looking for?


voice register global
 mode cme
 source-address 172.16.1.1 port 5060
 max-dn 10
 max-pool 10
 authenticate register
 hold-alert
 tftp-path flash:
 create profile sync 0001697021794105
!
voice register dn  1
 number 110
 pickup-group 1
 name David
!
voice register pool  10
 registration-timer max 720 min 660
 id mac 0026.4ABC.C138
 session-transport tcp
 type CiscoMobile-iOS
 number 1 dn 1
 username 110 password xxxxxx



As far as the dialed number, I just changed the actual #s to 555-555-5555, but the outgoing call was to my cell #, and the incoming called # is the DID. In actuality, the DID # and the outgoing call # are different numbers, and im at a loss as to why its hitting CME rather than the sip trunk. It was a poor masking of the phone numbers on my part.


Best,

David

Ayodeji Okanlawon Thu, 05/24/2012 - 04:16

Ok thats good. Just wanted to clarify.


Can you send the correct logs here you can use ...... or XXX to mask the called number. you can PM the actual dialled number. But send the logs here..


Can you also send debug voip ccapi inout..so I can see what dial-peer the call is matching

Davidwagman1 Thu, 05/24/2012 - 05:50

I've posted the logs below:


sip messages:


=~=~=~=~=~=~=~=~=~=~=~= PuTTY log 2012.05.24 08:45:01 =~=~=~=~=~=~=~=~=~=~=~=


CME#

May 24 12:47:38.940: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:

Received:

INVITE sip:[email protected] SIP/2.0


Via: SIP/2.0/TCP 10.10.2.50:53480;branch=z9hG4bK4df99e51


From: "David" ;tag=00000000000000ee00769002-67e8738a


To:


Call-ID: [email protected]


Max-Forwards: 70


Date: Thu, 24 May 2012 12:47:40 GMT


CSeq: 101 INVITE


User-Agent: Cisco-SIPIPCommunicator/9.2.1


Contact:


Expires: 180


Accept: application/sdp


Allow: ACK,BYE,CANCEL,INVITE,NOTIFY,OPTIONS,REFER,REGISTER,UPDATE,SUBSCRIBE,INFO


Remote-Party-ID: "David" ;party=calling;id-type=subscriber;privacy=off;screen=yes


Supported: replaces,join,sdp-anat,norefersub,extended-refer,X-cisco-callinfo,X-cisco-serviceuri,X-cisco-escapecodes,X-cisco-service-control,X-cisco-srtp-fallback,X-cisco-monrec,X-cisco-config,X-cisco-sis-5.2.0


Allow-Events: kpml,dialog


Recv-Info: conference


Recv-Info: x-cisco-conference


Content-Length: 216


Content-Type: application/sdp


Content-Disposition: session;handling=optional




v=0


o=Cisco-SIPUA 22212 0 IN IP4 10.10.2.50


s=SIP Call


t=0 0


m=audio 16398 RTP/AVP 18 0 8


c=IN IP4 10.10.2.50


a=rtpmap:18 G729/8000


a=fmtp:18 annexb=no


a=rtpmap:0 PCMU/8000


a=rtpmap:8 PCMA/8000


a=sendrecv



May 24 12:47:38.952: //282/7A95B28A818C/SIP/Msg/ccsipDisplayMsg:

Sent:

SIP/2.0 100 Trying


Via: SIP/2.0/TCP 10.10.2.50:53480;branch=z9hG4bK4df99e51


From: "David" ;tag=00000000000000ee00769002-67e8738a


To:


Date: Thu, 24 May 2012 12:47:38 GMT


Call-ID: [email protected]


CSeq: 101 INVITE


Allow-Events: telephone-event


Server: Cisco-SIPGateway/IOS-12.x


Content-Length: 0





May 24 12:47:38.968: //282/7A95B28A818C/SIP/Msg/ccsipDisplayMsg:

Sent:

SIP/2.0 503 Service Unavailable


Via: SIP/2.0/TCP 10.10.2.50:53480;branch=z9hG4bK4df99e51


From: "David" ;tag=00000000000000ee00769002-67e8738a


To: ;tag=26DAAF0-A04


Date: Thu, 24 May 2012 12:47:38 GMT


Call-ID: [email protected]


CSeq: 101 INVITE


Allow-Events: telephone-event


Server: Cisco-SIPGateway/IOS-12.x


Reason: Q.850;cause=47


Content-Length: 0





May 24 12:47:38.972: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:

Received:

ACK sip:[email protected] SIP/2.0


Via: SIP/2.0/TCP 10.10.2.50:53480;branch=z9hG4bK4df99e51


From: "David" ;tag=00000000000000ee00769002-67e8738a


To: ;tag=26DAAF0-A04


Call-ID: [email protected]


Date: Thu, 24 May 2012 12:47:41 GMT


CSeq: 101 ACK


Content-Length: 0






ccapi inout:



=~=~=~=~=~=~=~=~=~=~=~= PuTTY log 2012.05.24 08:40:57 =~=~=~=~=~=~=~=~=~=~=~=


May 24 12:42:56.389: VOICE REGISTER POOL-10 has registered. Name:SEP00264ABCC138  IP:10.10.2.50  DeviceType:Phone


May 24 12:43:09.221: //-1/D9CFF8CC8186/CCAPI/cc_api_display_ie_subfields:

   cc_api_call_setup_ind_common:

   cisco-username=110

   ----- ccCallInfo IE subfields -----

   cisco-ani=110

   cisco-anitype=0

   cisco-aniplan=0

   cisco-anipi=0

   cisco-anisi=1

   dest=516319xxxx

   cisco-desttype=0

   cisco-destplan=0

   cisco-rdie=FFFFFFFF

   cisco-rdn=

   cisco-rdntype=0

   cisco-rdnplan=0

   cisco-rdnpi=-1

   cisco-rdnsi=-1

   cisco-redirectreason=-1   fwd_final_type =0

   final_redirectNumber =

   hunt_group_timeout =0


May 24 12:43:09.221: //-1/D9CFF8CC8186/CCAPI/cc_api_call_setup_ind_common:

   Interface=0x48AED9C8, Call Info(

   Calling Number=110,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),

   Called Number=516319xxxx(TON=Unknown, NPI=Unknown),

   Calling Translated=FALSE, Subscriber Type Str=Unknown, FinalDestinationFlag=FALSE,

   Incoming Dial-peer=40001, Progress Indication=NULL(0), Calling IE Present=TRUE,

   Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=280

May 24 12:43:09.221: //-1/D9CFF8CC8186/CCAPI/ccCheckClipClir:

   In: Calling Number=110(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)

May 24 12:43:09.221: //-1/D9CFF8CC8186/CCAPI/ccCheckClipClir:

   Out: Calling Number=110(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)

May 24 12:43:09.221: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:


May 24 12:43:09.221: :cc_get_feature_vsa malloc success

May 24 12:43:09.221: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:


May 24 12:43:09.221:  cc_get_feature_vsa count is 1

May 24 12:43:09.221: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:


May 24 12:43:09.221: :FEATURE_VSA attributes are: feature_name:0,feature_time:1246262744,feature_id:47

May 24 12:43:09.221: //280/D9CFF8CC8186/CCAPI/cc_api_call_setup_ind_common:

   Set Up Event Sent;

   Call Info(Calling Number=110(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),

   Called Number=516319xxxx(TON=Unknown, NPI=Unknown))

May 24 12:43:09.225: //280/D9CFF8CC8186/CCAPI/cc_process_call_setup_ind:

   Event=0x49322810

May 24 12:43:09.225: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search:

   Try with the demoted called number 516319xxxx

May 24 12:43:09.225: //280/D9CFF8CC8186/CCAPI/ccCallSetContext:

   Context=0x49F68F20

May 24 12:43:09.229: //280/D9CFF8CC8186/CCAPI/cc_process_call_setup_ind:

   >>>>CCAPI handed cid 280 with tag 40001 to app "_ManagedAppProcess_Default"

May 24 12:43:09.229: //280/D9CFF8CC8186/CCAPI/ccCallSetupAck:

   Call Id=280

May 24 12:43:09.229: //280/D9CFF8CC8186/CCAPI/cc_api_set_transfer_info:

   Transfer Number=, Transfer Reason=0x0

May 24 12:43:09.229: //280/D9CFF8CC8186/CCAPI/ccCallReportDigits:

   (callID=0x118, digit_event=0x0, enable=FALSE, consume=FALSE)

May 24 12:43:09.229: //280/D9CFF8CC8186/CCAPI/ccCallReportDigits:

   Enabled=TRUE, Call Id=280

May 24 12:43:09.229: //280/D9CFF8CC8186/CCAPI/cc_api_call_report_digits_done:

   (vdbPtr=0x48AED9C8, callID=0x118, disp=0, digit_event=0x0, enable=FALSE, consume=FALSE)

May 24 12:43:09.229: //280/D9CFF8CC8186/CCAPI/cc_api_call_report_digits_done:

   Enabled=TRUE, Disposition=0x0, Interface=0x48AED9C8, Call Id=280

May 24 12:43:09.229: //280/D9CFF8CC8186/CCAPI/cc_api_call_report_digits_done:

   Call Entry(Initial Digit Timeout=10000(ms), Inter Digit Timeout=10000(ms))

May 24 12:43:09.233: //280/D9CFF8CC8186/CCAPI/ccCallProceeding:

   Progress Indication=NULL(0)

May 24 12:43:09.233: //280/D9CFF8CC8186/CCAPI/ccCallSetupRequest:

   Destination=, Calling IE Present=TRUE, Mode=0,

   Outgoing Dial-peer=2, Params=0x49F6CDB0, Progress Indication=NULL(0)

May 24 12:43:09.233: //280/D9CFF8CC8186/CCAPI/ccCheckClipClir:

   In: Calling Number=110(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)

May 24 12:43:09.233: //280/D9CFF8CC8186/CCAPI/ccCheckClipClir:

   Out: Calling Number=110(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)

May 24 12:43:09.233: //280/D9CFF8CC8186/CCAPI/ccCallSetupRequest:

   Destination Pattern=[2-9]..[2-9]......, Called Number=516319xxxx, Digit Strip=FALSE

May 24 12:43:09.233: //280/D9CFF8CC8186/CCAPI/ccCallSetupRequest:

   Calling Number=110(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),

   Called Number=516319xxxx(TON=Unknown, NPI=Unknown),

   Redirect Number=, Display Info=David

   Account Number=110, Final Destination Flag=FALSE,

   Guid=D9CFF8CC-A4D4-11E1-8186-9BD43F3E7007, Outgoing Dial-peer=2

May 24 12:43:09.233: //280/D9CFF8CC8186/CCAPI/cc_api_display_ie_subfields:

   ccCallSetupRequest:

   cisco-username=110

   ----- ccCallInfo IE subfields -----

   cisco-ani=110

   cisco-anitype=0

   cisco-aniplan=0

   cisco-anipi=0

   cisco-anisi=1

   dest=516319xxxx

   cisco-desttype=0

   cisco-destplan=0

   cisco-rdie=FFFFFFFF

   cisco-rdn=

   cisco-rdntype=0

   cisco-rdnplan=0

   cisco-rdnpi=-1

   cisco-rdnsi=-1

   cisco-redirectreason=-1   fwd_final_type =0

   final_redirectNumber =

   hunt_group_timeout =0


May 24 12:43:09.237: //280/D9CFF8CC8186/CCAPI/ccIFCallSetupRequestPrivate:

   Interface=0x48AED9C8, Interface Type=3, Destination=, Mode=0x0,

   Call Params(Calling Number=110,(Calling Name=David iPad)(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),

   Called Number=516319xxxx(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,

   Subscriber Type Str=Unknown, FinalDestinationFlag=FALSE, Outgoing Dial-peer=2, Call Count On=FALSE,

   Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)

May 24 12:43:09.237: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:


May 24 12:43:09.237: :cc_get_feature_vsa malloc success

May 24 12:43:09.237: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:


May 24 12:43:09.237:  cc_get_feature_vsa count is 2

May 24 12:43:09.237: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:


May 24 12:43:09.237: :FEATURE_VSA attributes are: feature_name:0,feature_time:1246263864,feature_id:48

May 24 12:43:09.237: //281/D9CFF8CC8186/CCAPI/ccIFCallSetupRequestPrivate:

   SPI Call Setup Request Is Success; Interface Type=3, FlowMode=1

May 24 12:43:09.237: //281/D9CFF8CC8186/CCAPI/ccCallSetContext:

   Context=0x49F6CD60

May 24 12:43:09.237: //280/D9CFF8CC8186/CCAPI/ccSaveDialpeerTag:

   Outgoing Dial-peer=2

May 24 12:43:09.237: //281/D9CFF8CC8186/CCAPI/cc_api_call_disconnected:

   Cause Value=47, Interface=0x48AED9C8, Call Id=281

May 24 12:43:09.237: //281/D9CFF8CC8186/CCAPI/cc_api_call_disconnected:

   Call Entry(Responsed=TRUE, Cause Value=47, Retry Count=0)

May 24 12:43:09.241: //281/D9CFF8CC8186/CCAPI/cc_api_call_disconnected:

   Cause Value=47, Interface=0x48AED9C8, Call Id=281

May 24 12:43:09.241: //281/D9CFF8CC8186/CCAPI/cc_api_call_disconnected:

   Call Entry(Responsed=TRUE, Cause Value=47, Retry Count=0)

May 24 12:43:09.241: //280/D9CFF8CC8186/CCAPI/ccCallReleaseResources:

   release reserved xcoding resource.

May 24 12:43:09.241: //281/D9CFF8CC8186/CCAPI/ccCallSetAAA_Accounting:

   Accounting=0, Call Id=281

May 24 12:43:09.241: //281/D9CFF8CC8186/CCAPI/ccCallDisconnect:

   Cause Value=47, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=47)

May 24 12:43:09.241: //281/D9CFF8CC8186/CCAPI/ccCallDisconnect:

   Cause Value=47, Call Entry(Responsed=TRUE, Cause Value=47)

May 24 12:43:09.241: //281/D9CFF8CC8186/CCAPI/cc_api_call_disconnect_done:

   Disposition=-11, Interface=0x48AED9C8, Tag=0x0, Call Id=281,

   Call Entry(Disconnect Cause=47, Voice Class Cause Code=0, Retry Count=0)

May 24 12:43:09.241: //281/D9CFF8CC8186/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

May 24 12:43:09.241: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:


May 24 12:43:09.241: :cc_free_feature_vsa freeing 4A487A30

May 24 12:43:09.241: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:


May 24 12:43:09.241:  vsacount in free is 1

May 24 12:43:09.245: //280/D9CFF8CC8186/CCAPI/ccCallDisconnect:

   Cause Value=47, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)

May 24 12:43:09.245: //280/D9CFF8CC8186/CCAPI/ccCallDisconnect:

   Cause Value=47, Call Entry(Responsed=TRUE, Cause Value=47)

May 24 12:43:09.253: //280/D9CFF8CC8186/CCAPI/cc_api_call_disconnect_done:

   Disposition=0, Interface=0x48AED9C8, Tag=0x0, Call Id=280,

   Call Entry(Disconnect Cause=47, Voice Class Cause Code=0, Retry Count=0)

May 24 12:43:09.257: //280/D9CFF8CC8186/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

May 24 12:43:09.257: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:


May 24 12:43:09.257: :cc_free_feature_vsa freeing 4A4875D0

May 24 12:43:09.257: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:


May 24 12:43:09.257:  vsacount in free is 0

Ayodeji Okanlawon Thu, 05/24/2012 - 07:54

David,


Can you send me a "debug ephone state" and mae a test call again...Please use your link or put it in a text file and attach here..dont paste it as it makes the thread very long

Davidwagman1 Thu, 05/24/2012 - 08:52

Well, that was easy...


Thanks so much for your help, as always Aokanlawon.

Ayodeji Okanlawon Thu, 05/24/2012 - 09:44

My pleasure always. Just a strange one, as the sip phone offered codec g711ulaw in its invite. Thats why I didnt suggest it at first. Glad to know it worked..

Actions

This Discussion

Related Content