05-23-2012 03:44 PM - edited 03-16-2019 11:19 AM
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?
Thank you,
David
Solved! Go to Solution.
05-24-2012 08:30 AM
Can you try this..
voice register pool 10
codec g711u
and test again..
05-24-2012 12:45 AM
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..
05-24-2012 03:59 AM
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
05-24-2012 04:16 AM
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
05-24-2012 05:50 AM
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" <110>;tag=00000000000000ee00769002-67e8738a110>
To: <516319XXXX>516319XXXX>
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: <110>110>
Expires: 180
Accept: application/sdp
Allow: ACK,BYE,CANCEL,INVITE,NOTIFY,OPTIONS,REFER,REGISTER,UPDATE,SUBSCRIBE,INFO
Remote-Party-ID: "David" <110>;party=calling;id-type=subscriber;privacy=off;screen=yes110>
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" <110>;tag=00000000000000ee00769002-67e8738a110>
To: <516319XXXX>516319XXXX>
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" <110>;tag=00000000000000ee00769002-67e8738a110>
To: <516319XXXX>;tag=26DAAF0-A04516319XXXX>
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" <110>;tag=00000000000000ee00769002-67e8738a110>
To: <516319XXXX>;tag=26DAAF0-A04516319XXXX>
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
05-24-2012 07:54 AM
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
05-24-2012 08:00 AM
Here is the ephone debug state log.
Thanks for all your help.
05-24-2012 08:30 AM
Can you try this..
voice register pool 10
codec g711u
and test again..
05-24-2012 08:52 AM
Well, that was easy...
Thanks so much for your help, as always Aokanlawon.
05-24-2012 09:44 AM
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..
05-26-2012 06:27 AM
PM sent
Discover and save your favorite ideas. Come back to expert answers, step-by-step guides, recent topics, and more.
New here? Get started with these tips. How to use Community New member guide