Solved: Re: Outgoing calls failed (sip-ua) configuration

kamilm001 · ‎04-02-2018

Hello everyone. I have a problem with outgoing calls...Here is my debug call messages..PLZ HELP..!

All incoming calls working properly...

Apr 2 2018 20:03:53.821: //60647/6F4100000000/SIP/Call/sipSPICallInfo:
The Call Setup Information is:
Call Control Block (CCB) : 0x0x7F46F6BBD668
State of The Call : STATE_DEAD
TCP Sockets Used : NO
Calling Number : 125981655
Called Number : 5414747
Source IP Address (Sig ): 10.200.21.28
Destn SIP Req Addr:Port : 10.0.1.228:5060
Destn SIP Resp Addr:Port : 10.0.1.228:5060
Destination Name : 10.0.1.228

Apr 2 2018 20:03:53.821: //60647/6F4100000000/SIP/Call/sipSPIMediaCallInfo:
Number of Media Streams: 1
Media Stream : 1
Negotiated Codec : No Codec
Negotiated Codec Bytes : 0
Nego. Codec payload : 255 (tx), 255 (rx)
Negotiated Dtmf-relay : 0
Dtmf-relay Payload : 0 (tx), 0 (rx)
Source IP Address (Media): 10.200.21.28
Source IP Port (Media): 13116
Destn IP Address (Media): -
Destn IP Port (Media): 0
Orig Destn IP Address:Port (Media): [ - ]:0

Apr 2 2018 20:03:53.821: //60647/6F4100000000/SIP/Call/sipSPICallInfo:
Disconnect Cause (CC) : 41
Disconnect Cause (SIP) : 500

Apr 2 2018 20:03:53.825: //60646/6F4100000000/SIP/Call/sipSPICallInfo:
The Call Setup Information is:
Call Control Block (CCB) : 0x0x7F46F6B83928
State of The Call : STATE_DEAD
TCP Sockets Used : NO
Calling Number : 1117
Called Number : 5414747
Source IP Address (Sig ): 10.0.32.14
Destn SIP Req Addr:Port : 10.0.8.11:5060
Destn SIP Resp Addr:Port : 10.0.8.11:5060
Destination Name : 10.0.8.11

Apr 2 2018 20:03:53.825: //60646/6F4100000000/SIP/Call/sipSPIMediaCallInfo:
Number of Media Streams: 1
Media Stream : 1
Negotiated Codec : No Codec
Negotiated Codec Bytes : 0
Nego. Codec payload : 255 (tx), 255 (rx)
Negotiated Dtmf-relay : 0
Dtmf-relay Payload : 0 (tx), 0 (rx)
Source IP Address (Media): 10.0.32.14
Source IP Port (Media): 13114
Destn IP Address (Media): -
Destn IP Port (Media): 0
Orig Destn IP Address:Port (Media): [ - ]:0

Apr 2 2018 20:03:53.825: //60646/6F4100000000/SIP/Call/sipSPICallInfo:
Disconnect Cause (CC) : 41
Disconnect Cause (SIP) : 503

R0g22 · ‎04-03-2018

You are getting a 5XX Server Response from "10.200.21.28" device. Investigate there.

Apr 3 2018 11:32:08.466: //895/1C0F91800000/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 500 Server Internal Error
Via: SIP/2.0/UDP 10.200.21.28:5060;branch=z9hG4bK3901ED;rport=58640
Call-ID: F32422D2-364711E8-804994B4-96B41CAC@10.200.21.28
From: "Xaniyev Ilkin"<sip:5981655@10.200.21.28>;tag=10A745F-23A0
To: <sip:5414747@10.0.1.228>;tag=eeefe823
CSeq: 101 INVITE
Content-Length: 0

View solution in original post

R0g22 · ‎04-02-2018

Take a debug ccsip message and debug voice ccapi inout for a test call.

kamilm001 · ‎04-03-2018

This is my ccsip debug
Apr 3 2018 11:32:06.808: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
hello
Apr 3 2018 11:32:06.816: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
hello
Apr 3 2018 11:32:08.457: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
INVITE sip:5414747@10.0.32.14:5060 SIP/2.0
Via: SIP/2.0/UDP 10.0.8.11:5060;branch=z9hG4bK256132e4619b
From: "Xaniyev Ilkin" <sip:1117@10.0.8.11>;tag=613868~1b41c8c3-0e71-4aad-a968-03ed6ab7c77a-32074978
To: <sip:5414747@10.0.32.14>
Date: Tue, 03 Apr 2018 07:32:08 GMT
Call-ID: 1c0f9180-ac312df8-153a-b08000a@10.0.8.11
Supported: timer,resource-priority,replaces
Min-SE: 1800
User-Agent: Cisco-CUCM12.0
Allow: INVITE, OPTIONS, INFO, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY
CSeq: 101 INVITE
Expires: 180
Allow-Events: presence, kpml
Supported: X-cisco-srtp-fallback,X-cisco-original-called
Call-Info: <sip:10.0.8.11:5060>;method="NOTIFY;Event=telephone-event;Duration=500"
Call-Info: <urn:x-cisco-remotecc:callinfo>;x-cisco-video-traffic-class=DESKTOP
Session-ID: 3a3fdbf500105000a000701f53878268;remote=00000000000000000000000000000000
Cisco-Guid: 0470782336-0000065536-0000000824-0185073674
Session-Expires: 1800
P-Asserted-Identity: "Xaniyev Ilkin" <sip:1117@10.0.8.11>
Remote-Party-ID: "Xaniyev Ilkin" <sip:1117@10.0.8.11>;party=calling;screen=yes;privacy=off
Contact: <sip:1117@10.0.8.11:5060>;+u.sip!devicename.ccm.cisco.com="SEP701F53878268"
Max-Forwards: 69
Content-Length: 0

Apr 3 2018 11:32:08.462: //894/1C0F91800000/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 10.0.8.11:5060;branch=z9hG4bK256132e4619b
From: "Xaniyev Ilkin" <sip:1117@10.0.8.11>;tag=613868~1b41c8c3-0e71-4aad-a968-03ed6ab7c77a-32074978
To: <sip:5414747@10.0.32.14>
Date: Tue, 03 Apr 2018 11:32:08 GMT
Call-ID: 1c0f9180-ac312df8-153a-b08000a@10.0.8.11
CSeq: 101 INVITE
Allow-Events: telephone-event
Server: Cisco-SIPGateway/IOS-15.5.3.S4b
Content-Length: 0

Apr 3 2018 11:32:08.462: //895/1C0F91800000/SIP/Msg/ccsipDisplayMsg:
Sent:
INVITE sip:5414747@10.0.1.228:5060 SIP/2.0
Via: SIP/2.0/UDP 10.200.21.28:5060;branch=z9hG4bK3901ED
From: "Xaniyev Ilkin" <sip:5981655@10.200.21.28>;tag=10A745F-23A0
To: <sip:5414747@10.0.1.228>
Date: Tue, 03 Apr 2018 11:32:08 GMT
Call-ID: F32422D2-364711E8-804994B4-96B41CAC@10.200.21.28
Supported: 100rel,timer,resource-priority,replaces,sdp-anat
Min-SE: 1800
Cisco-Guid: 0470782336-0000065536-0000000824-0185073674
User-Agent: Cisco-SIPGateway/IOS-15.5.3.S4b
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER
CSeq: 101 INVITE
Timestamp: 1522740728
Contact: <sip:5981655@10.200.21.28:5060>
Expires: 180
Allow-Events: telephone-event
Max-Forwards: 68
Session-Expires: 1800
Content-Type: application/sdp
Content-Disposition: session;handling=required
Content-Length: 317

v=0
o=CiscoSystemsSIP-GW-UserAgent 3366 2287 IN IP4 10.200.21.28
s=SIP Call
c=IN IP4 10.200.21.28
t=0 0
m=audio 8036 RTP/AVP 8 0 18 101
c=IN IP4 10.200.21.28
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20

Apr 3 2018 11:32:08.466: //895/1C0F91800000/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 10.200.21.28:5060;branch=z9hG4bK3901ED;rport=58640
Call-ID: F32422D2-364711E8-804994B4-96B41CAC@10.200.21.28
From: "Xaniyev Ilkin"<sip:5981655@10.200.21.28>;tag=10A745F-23A0
To: <sip:5414747@10.0.1.228>
CSeq: 101 INVITE
Content-Length: 0

Apr 3 2018 11:32:08.466: //895/1C0F91800000/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 500 Server Internal Error
Via: SIP/2.0/UDP 10.200.21.28:5060;branch=z9hG4bK3901ED;rport=58640
Call-ID: F32422D2-364711E8-804994B4-96B41CAC@10.200.21.28
From: "Xaniyev Ilkin"<sip:5981655@10.200.21.28>;tag=10A745F-23A0
To: <sip:5414747@10.0.1.228>;tag=eeefe823
CSeq: 101 INVITE
Content-Length: 0

Apr 3 2018 11:32:08.468: //895/1C0F91800000/SIP/Msg/ccsipDisplayMsg:
Sent:
ACK sip:5414747@10.0.1.228:5060 SIP/2.0
Via: SIP/2.0/UDP 10.200.21.28:5060;branch=z9hG4bK3901ED
From: "Xaniyev Ilkin" <sip:5981655@10.0.1.228>;tag=10A745F-23A0
To: <sip:5414747@10.0.1.228>;tag=eeefe823
Date: Tue, 03 Apr 2018 11:32:08 GMT
Call-ID: F32422D2-364711E8-804994B4-96B41CAC@10.200.21.28
Max-Forwards: 70
CSeq: 101 ACK
Allow-Events: telephone-event
Content-Length: 0

Apr 3 2018 11:32:08.468: //894/1C0F91800000/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 503 Service Unavailable
Via: SIP/2.0/UDP 10.0.8.11:5060;branch=z9hG4bK256132e4619b
From: "Xaniyev Ilkin" <sip:1117@10.0.8.11>;tag=613868~1b41c8c3-0e71-4aad-a968-03ed6ab7c77a-32074978
To: <sip:5414747@10.0.32.14>;tag=10A7465-1602
Date: Tue, 03 Apr 2018 11:32:08 GMT
Call-ID: 1c0f9180-ac312df8-153a-b08000a@10.0.8.11
CSeq: 101 INVITE
Allow-Events: telephone-event
Server: Cisco-SIPGateway/IOS-15.5.3.S4b
Reason: Q.850;cause=41
Content-Length: 0

Apr 3 2018 11:32:08.470: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
ACK sip:5414747@10.0.32.14:5060 SIP/2.0
Via: SIP/2.0/UDP 10.0.8.11:5060;branch=z9hG4bK256132e4619b
From: "Xaniyev Ilkin" <sip:1117@10.0.8.11>;tag=613868~1b41c8c3-0e71-4aad-a968-03ed6ab7c77a-32074978
To: <sip:5414747@10.0.32.14>;tag=10A7465-1602
Date: Tue, 03 Apr 2018 07:32:08 GMT
Call-ID: 1c0f9180-ac312df8-153a-b08000a@10.0.8.11
User-Agent: Cisco-CUCM12.0
Max-Forwards: 70
CSeq: 101 ACK
Allow-Events: presence, kpml
Content-Length: 0

kamilm001 · ‎04-03-2018

voice ccapi inout

voip ccapi inout debugging is on
HOVOICERTR01#
HOVOICERTR01#
HOVOICERTR01#
HOVOICERTR01#
Apr 3 2018 11:33:10.359: //-1/410404800000/CCAPI/cc_api_display_ie_subfields:
cc_api_call_setup_ind_common:
cisco-username=1117
----- ccCallInfo IE subfields -----
cisco-ani=1117
cisco-anitype=0
cisco-aniplan=0
cisco-anipi=0
cisco-anisi=0
dest=5414747
cisco-desttype=0
cisco-destplan=0
cisco-rdie=FFFFFFFFFFFFFFFF
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

Apr 3 2018 11:33:10.359: //-1/410404800000/CCAPI/cc_api_call_setup_ind_common:
Interface=0x7FA0F6371A68, Call Info(
Calling Number=1117,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
Called Number=5414747(TON=Unknown, NPI=Unknown),
Calling Translated=FALSE, Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE,
Incoming Dial-peer=101, Progress Indication=NULL(0), Calling IE Present=TRUE,
Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=896
Apr 3 2018 11:33:10.359: //-1/410404800000/CCAPI/ccCheckClipClir:
In: Calling Number=1117(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
Apr 3 2018 11:33:10.359: //-1/410404800000/CCAPI/ccCheckClipClir:
Out: Calling Number=1117(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
Apr 3 2018 11:33:10.359: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Apr 3 2018 11:33:10.359: :cc_get_feature_vsa malloc success
Apr 3 2018 11:33:10.359: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Apr 3 2018 11:33:10.359: cc_get_feature_vsa count is 1
Apr 3 2018 11:33:10.359: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Apr 3 2018 11:33:10.359: :FEATURE_VSA attributes are: feature_name:0,feature_time:140329319917900,feature_id:20
Apr 3 2018 11:33:10.359: //896/410404800000/CCAPI/cc_api_call_setup_ind_common:
Set Up Event Sent;
Call Info(Calling Number=1117(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
Called Number=5414747(TON=Unknown, NPI=Unknown))
Apr 3 2018 11:33:10.359: //896/410404800000/CCAPI/cc_process_call_setup_ind:
Event=0x7FA0F745F748
Apr 3 2018 11:33:10.359: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search:
Try with the demoted called number 5414747
Apr 3 2018 11:33:10.359: //896/410404800000/CCAPI/ccCallSetContext:
Context=0x7FA0FEC5BB70
Apr 3 2018 11:33:10.360: //896/410404800000/CCAPI/cc_process_call_setup_ind:
>>>>CCAPI handed cid 896 with tag 101 to app "_ManagedAppProcess_Default"
Apr 3 2018 11:33:10.360: //896/410404800000/CCAPI/ccCallProceeding:
Progress Indication=NULL(0)
Apr 3 2018 11:33:10.360: //896/410404800000/CCAPI/ccCallSetupRequest:
Destination=, Calling IE Present=TRUE, Mode=0,
Outgoing Dial-peer=100, Params=0x7FA0FEC42420, Progress Indication=NULL(0)
Apr 3 2018 11:33:10.360: //896/410404800000/CCAPI/ccCheckClipClir:
In: Calling Number=5981655(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
Apr 3 2018 11:33:10.360: //896/410404800000/CCAPI/ccCheckClipClir:
Out: Calling Number=5981655(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
Apr 3 2018 11:33:10.360: //896/410404800000/CCAPI/ccCallSetupRequest:
Destination Pattern=[3-5]......, Called Number=5414747, Digit Strip=FALSE
Apr 3 2018 11:33:10.360: //896/410404800000/CCAPI/ccCallSetupRequest:
Calling Number=5981655(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
Called Number=5414747(TON=Unknown, NPI=Unknown),
Redirect Number=, Display Info=Xaniyev Ilkin
Account Number=1117, Final Destination Flag=TRUE,
Guid=41040480-0001-0000-0000-03390B08000A, Outgoing Dial-peer=100
Apr 3 2018 11:33:10.360: //896/410404800000/CCAPI/cc_api_display_ie_subfields:
ccCallSetupRequest:
cisco-username=1117
----- ccCallInfo IE subfields -----
cisco-ani=5981655
cisco-anitype=0
cisco-aniplan=0
cisco-anipi=0
cisco-anisi=0
dest=5414747
cisco-desttype=0
cisco-destplan=0
cisco-rdie=FFFFFFFFFFFFFFFF
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

Apr 3 2018 11:33:10.360: //896/410404800000/CCAPI/ccIFCallSetupRequestPrivate:
Interface=0x7FA0F6371A68, Interface Type=3, Destination=, Mode=0x0,
Call Params(Calling Number=5981655,(Calling Name=Xaniyev Ilkin)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
Called Number=5414747(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,
Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE, Outgoing Dial-peer=100, Call Count On=FALSE,
Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)
Apr 3 2018 11:33:10.360: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Apr 3 2018 11:33:10.360: :cc_get_feature_vsa malloc success
Apr 3 2018 11:33:10.360: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Apr 3 2018 11:33:10.361: cc_get_feature_vsa count is 2
Apr 3 2018 11:33:10.361: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Apr 3 2018 11:33:10.361: :FEATURE_VSA attributes are: feature_name:0,feature_time:140329319917676,feature_id:21
Apr 3 2018 11:33:10.361: //897/410404800000/CCAPI/ccIFCallSetupRequestPrivate:
SPI Call Setup Request Is Success; Interface Type=3, FlowMode=1
Apr 3 2018 11:33:10.361: //897/410404800000/CCAPI/ccCallSetContext:
Context=0x7FA0FEC423A0
Apr 3 2018 11:33:10.361: //896/410404800000/CCAPI/ccSaveDialpeerTag:
Outgoing Dial-peer=100
Apr 3 2018 11:33:10.361: //897/410404800000/CCAPI/cc_api_call_proceeding:
Interface=0x7FA0F6371A68, Progress Indication=NULL(0)
Apr 3 2018 11:33:10.362: //897/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

Apr 3 2018 11:33:10.362: cc_api_get_xcode_stream : 4983
Apr 3 2018 11:33:10.372: //897/410404800000/CCAPI/cc_api_call_disconnected:
Cause Value=41, Interface=0x7FA0F6371A68, Call Id=897
Apr 3 2018 11:33:10.372: //897/410404800000/CCAPI/cc_api_call_disconnected:
Call Entry(Responsed=TRUE, Cause Value=41, Retry Count=0)
Apr 3 2018 11:33:10.372: //896/410404800000/CCAPI/ccCallReleaseResources:
release reserved xcoding resource.
Apr 3 2018 11:33:10.372: //897/410404800000/CCAPI/ccCallSetAAA_Accounting:
Accounting=0, Call Id=897
Apr 3 2018 11:33:10.372: //897/410404800000/CCAPI/ccCallDisconnect:
Cause Value=41, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=41)
Apr 3 2018 11:33:10.372: //897/410404800000/CCAPI/ccCallDisconnect:
Cause Value=41, Call Entry(Responsed=TRUE, Cause Value=41)
Apr 3 2018 11:33:10.372: //897/410404800000/CCAPI/cc_api_call_disconnect_done:
Disposition=0, Interface=0x7FA0F6371A68, Tag=0x0, Call Id=897,
Call Entry(Disconnect Cause=41, Voice Class Cause Code=0, Retry Count=0)
Apr 3 2018 11:33:10.372: //897/410404800000/CCAPI/cc_api_call_disconnect_done:
Call Disconnect Event Sent
Apr 3 2018 11:33:10.372: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Apr 3 2018 11:33:10.372: :cc_free_feature_vsa freeing 7FA0F743E860
Apr 3 2018 11:33:10.372: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Apr 3 2018 11:33:10.372: vsacount in free is 1
Apr 3 2018 11:33:10.373: //896/410404800000/CCAPI/ccCallDisconnect:
Cause Value=41, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)
Apr 3 2018 11:33:10.373: //896/410404800000/CCAPI/ccCallDisconnect:
Cause Value=41, Call Entry(Responsed=TRUE, Cause Value=41)
Apr 3 2018 11:33:10.376: //896/410404800000/CCAPI/cc_api_call_disconnect_done:
Disposition=0, Interface=0x7FA0F6371A68, Tag=0x0, Call Id=896,
Call Entry(Disconnect Cause=41, Voice Class Cause Code=0, Retry Count=0)
Apr 3 2018 11:33:10.376: //896/410404800000/CCAPI/cc_api_call_disconnect_done:
Call Disconnect Event Sent
Apr 3 2018 11:33:10.376: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Apr 3 2018 11:33:10.376: :cc_free_feature_vsa freeing 7FA0F743E940
Apr 3 2018 11:33:10.376: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Apr 3 2018 11:33:10.376: vsacount in free is 0

R0g22 · ‎04-03-2018

You are getting a 5XX Server Response from "10.200.21.28" device. Investigate there.

Apr 3 2018 11:32:08.466: //895/1C0F91800000/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 500 Server Internal Error
Via: SIP/2.0/UDP 10.200.21.28:5060;branch=z9hG4bK3901ED;rport=58640
Call-ID: F32422D2-364711E8-804994B4-96B41CAC@10.200.21.28
From: "Xaniyev Ilkin"<sip:5981655@10.200.21.28>;tag=10A745F-23A0
To: <sip:5414747@10.0.1.228>;tag=eeefe823
CSeq: 101 INVITE
Content-Length: 0