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:110@172.16.1.1>;tag=31303430463300110ab8ba82-65dcb24d

To: <sip:5555555555@172.16.1.1>;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: 31303430-4633000d-3fe2beb9-3f578473@10.10.2.50

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

I have this problem too.
0 votes
Correct Answer by Ayodeji oladipo... about 1 year 11 months ago

Can you try this..

voice register pool  10

codec g711u

and test again..

  • 1
  • 2
  • 3
  • 4
  • 5
Average Rating: 5 (2 ratings)
Ayodeji oladipo... 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 oladipo... 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:516319xxxx@172.16.1.1 SIP/2.0

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

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

To:

Call-ID: 00000000-00000031-741ab5ca-05951c53@10.10.2.50

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: 00000000-00000031-741ab5ca-05951c53@10.10.2.50

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: 00000000-00000031-741ab5ca-05951c53@10.10.2.50

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:516319xxxx@172.16.1.1 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: 00000000-00000031-741ab5ca-05951c53@10.10.2.50

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

Login or Register to take actions

This Discussion

Posted May 23, 2012 at 3:44 PM
Stats:
Replies:10 Avg. Rating:5
Views:697 Votes:0
Shares:0

Related Content

Discussions Leaderboard

Rank Username Points
1 21,036
2 15,047
3 10,325
4 8,014
5 4,856
Rank Username Points
121
105
98
62
61