cancel
Showing results for 
Search instead for 
Did you mean: 
cancel
6994
Views
0
Helpful
10
Replies

Disconnect Cause (CC) : 47 and Disconnect Cause (SIP) : 407

selva kumar
Level 1
Level 1

Hi,

 

I am configuring the SIP trunk and having issue with Outgoing Calls.

 

When i try to Make SIP outgoing calls, Calls get's failled. Find the atached running Config.

 

Find the Below debug Log's. Anything which i would need to change from my end. Incoming calls are working.

 

*May 21 10:34:19.962: //375/7C63B8000000/SIP/Call/sipSPICallInfo:

The Call Setup Information is:

Call Control Block (CCB) : 0x0x43D063C0

State of The Call        : STATE_DEAD

TCP Sockets Used         : NO

Calling Number           : 09609001415

Called Number            : 00919686217788

Source IP Address (Sig  ): 202.84.43.194

Destn SIP Req Addr:Port  : 202.84.38.24:5060

Destn SIP Resp Addr:Port : 202.84.38.24:5060

Destination Name         : 202.84.38.24

 

*May 21 10:34:19.962: //375/7C63B8000000/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): 202.84.43.194

Source IP Port    (Media): 16918

Destn  IP Address (Media):  -

Destn  IP Port    (Media): 0

Orig Destn IP Address:Port (Media): [ - ]:0

 

*May 21 10:34:19.962: //375/7C63B8000000/SIP/Call/sipSPICallInfo:

Disconnect Cause (CC)    : 47

Disconnect Cause (SIP)   : 407

 

*May 21 10:34:20.506: //374/7C63B8000000/SIP/Call/sipSPICallInfo:

The Call Setup Information is:

Call Control Block (CCB) : 0x0x43CFFDB8

State of The Call        : STATE_DEAD

TCP Sockets Used         : YES

Calling Number           : 09609001415

Called Number            : 00919686217788

Source IP Address (Sig  ): 10.193.240.10

Destn SIP Req Addr:Port  : 162.44.127.147:5060

Destn SIP Resp Addr:Port : 162.44.127.147:37835

Destination Name         : 162.44.127.147

 

*May 21 10:34:20.506: //374/7C63B8000000/SIP/Call/sipSPIMediaCallInfo:

Number of Media Streams: 1

Media Stream             : 1

Negotiated Codec         : No Codecs

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

Source IP Port    (Media): 16916

Destn  IP Address (Media):  -

Destn  IP Port    (Media): 0

Orig Destn IP Address:Port (Media): [ - ]:0

 

*May 21 10:34:20.506: //374/7C63B8000000/SIP/Call/sipSPICallInfo:

Disconnect Cause (CC)    : 16

Disconnect Cause (SIP)   : 407

 

Regards

Selva

10 Replies 10

Ronak Agarwal
Level 1
Level 1

Hi Selva,

As per the problem description, it seems to be some codec issue.

Number of Media Streams: 1

Media Stream             : 1

Negotiated Codec         : No Codec

- See more at: https://supportforums.cisco.com/discussion/12513436/disconnect-cause-cc-47-and-disconnect-cause-sip-407#sthash.HDvkl4Gd.dpuf

Number of Media Streams: 1

Media Stream             : 1

Negotiated Codec         : No Codec

- See more at: https://supportforums.cisco.com/discussion/12513436/disconnect-cause-cc-47-and-disconnect-cause-sip-407#sthash.HDvkl4Gd.dpuf

Number of Media Streams: 1

Media Stream             : 1

Negotiated Codec         : No Codec

- See more at: https://supportforums.cisco.com/discussion/12513436/disconnect-cause-cc-47-and-disconnect-cause-sip-407#sthash.HDvkl4Gd.dpuf

Number of Media Streams: 1

Media Stream             : 1

Negotiated Codec         : No Codec

 

In the dial-peer 2000, can you remove voice class codec and hard code g711alaw (similar to 1000 dial peer).

 

Let me know if this resolves the issue. If no, then please help me understand the complete call flow and complete debugs from the gateway. (debug ccsip messages, debug voip ccapi inout).

 

Regards,

Ronak Agarwal

 

Thanks for your reply Ronak Agarwal.

Call Flow

I have a route Pattern in CUCM and send it to Voip gateway.

And its matching the Dial-peer 2000 to send the calls to Provider network.

But as per service provider they are not receiving the SIP Invite.

Find the below debug CCSIP Message and debug voip ccsip inout logs.

*May 21 17:19:24.788: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
INVITE sip:00919686217788@10.193.240.10:5060 SIP/2.0
Via: SIP/2.0/TCP 162.44.127.147:5060;branch=z9hG4bK15ad9735102239
From: "Mohammad Rajibul Alam Joarder" <sip:09609001415@162.44.127.147>;tag=21267291~ce33eaa0-f4b4-4530-bbec-20f8fa27ac43-91294956
To: <sip:00919686217788@10.193.240.10>
Date: Thu, 21 May 2015 17:23:25 GMT
Call-ID: 15162a00-55e1148d-150cad-937f2ca2@162.44.127.147
Supported: timer,resource-priority,replaces
Min-SE:  1800
User-Agent: Cisco-CUCM9.1
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
Cisco-Guid: 0353774080-0000065536-0000000114-2474585250
Session-Expires:  1800
P-Asserted-Identity: "Mohammad Rajibul Alam Joarder" <sip:09609001415@162.44.127.147>
Remote-Party-ID: "Mohammad Rajibul Alam Joarder" <sip:09609001415@162.44.127.147>;party=calling;screen=yes;privacy=off
Contact: <sip:09609001415@162.44.127.147:5060;transport=tcp>
Max-Forwards: 70
Content-Type: application/sdp
Content-Length: 219

v=0
o=CiscoSystemsCCM-SIP 21267291 1 IN IP4 162.44.127.147
s=SIP Call
c=IN IP4 10.193.240.10
t=0 0
m=audio 16978 RTP/AVP 8 101
a=rtpmap:8 PCMA/8000
a=ptime:20
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15

*May 21 17:19:24.796: //416/15162A000000/SIP/Msg/ccsipDisplayMsg:
Sent:
INVITE sip:00919686217788@202.84.38.24:5060 SIP/2.0
Via: SIP/2.0/UDP 202.84.43.194:5060;branch=z9hG4bK6019EB
Remote-Party-ID: "Mohammad Rajibul Alam Joarder" <sip:09609001415@202.84.43.194>;party=calling;screen=yes;privacy=off
From: "Mohammad Rajibul Alam Joarder" <sip:09609001415@202.84.43.194>;tag=2AA56F3C-18E7
To: <sip:00919686217788@202.84.38.24>
Date: Thu, 21 May 2015 17:19:24 GMT
Call-ID: 5CB7A6A0-FF1411E4-83708FA4-AF1AA63@202.84.43.194
Supported: timer,resource-priority,replaces,sdp-anat
Min-SE:  1800
Cisco-Guid: 0353774080-0000065536-0000000114-2474585250
User-Agent: Cisco-SIPGateway/IOS-15.3.3.M4
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER
CSeq: 101 INVITE
Timestamp: 1432228764
Contact: <sip:09609001415@202.84.43.194:5060>
Expires: 180
Allow-Events: telephone-event
Max-Forwards: 69
Session-Expires:  1800
Content-Type: application/sdp
Content-Disposition: session;handling=required
Content-Length: 250

v=0
o=CiscoSystemsSIP-GW-UserAgent 3220 6525 IN IP4 202.84.43.194
s=SIP Call
c=IN IP4 202.84.43.194
t=0 0
m=audio 16982 RTP/AVP 8 101
c=IN IP4 202.84.43.194
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:20

*May 21 17:19:24.796: //415/15162A000000/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 100 Trying
Via: SIP/2.0/TCP 162.44.127.147:5060;branch=z9hG4bK15ad9735102239
From: "Mohammad Rajibul Alam Joarder" <sip:09609001415@162.44.127.147>;tag=21267291~ce33eaa0-f4b4-4530-bbec-20f8fa27ac43-91294956
To: <sip:00919686217788@10.193.240.10>
Date: Thu, 21 May 2015 17:19:24 GMT
Call-ID: 15162a00-55e1148d-150cad-937f2ca2@162.44.127.147
CSeq: 101 INVITE
Allow-Events: kpml, telephone-event
Server: Cisco-SIPGateway/IOS-15.3.3.M4
Content-Length: 0


*May 21 17:19:24.796: //416/15162A000000/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 407 Proxy Authentication Required
Via: SIP/2.0/UDP 202.84.43.194:5060;branch=z9hG4bK6019EB
From: "Mohammad Rajibul Alam Joarder"  <sip:09609001415@202.84.43.194>;tag=2AA56F3C-18E7
To: <sip:00919686217788@202.84.38.24>
Contact: <sip:09609001415@202.84.38.24:5060>
Call-Id: 5CB7A6A0-FF1411E4-83708FA4-AF1AA63@202.84.43.194
CSeq: 101 INVITE
Proxy-Authenticate: Digest realm="202.84.38.24", nonce="387874a40b42be5a9be4a2d38ac81a17", algorithm=MD5
Content-Length: 0


*May 21 17:19:24.800: //415/15162A000000/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 407 Proxy Authentication Required
Via: SIP/2.0/TCP 162.44.127.147:5060;branch=z9hG4bK15ad9735102239
From: "Mohammad Rajibul Alam Joarder" <sip:09609001415@162.44.127.147>;tag=21267291~ce33eaa0-f4b4-4530-bbec-20f8fa27ac43-91294956
To: <sip:00919686217788@10.193.240.10>;tag=2AA56F3C-17B
Date: Thu, 21 May 2015 17:19:24 GMT
Call-ID: 15162a00-55e1148d-150cad-937f2ca2@162.44.127.147
CSeq: 101 INVITE
Allow-Events: kpml, telephone-event
Server: Cisco-SIPGateway/IOS-15.3.3.M4
Proxy-Authenticate: Digest realm="202.84.38.24", nonce="387874a40b42be5a9be4a2d38ac81a17", algorithm=MD5
Content-Length: 0


*May 21 17:19:24.800: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
ACK sip:00919686217788@202.84.38.24:5060 SIP/2.0
Via: SIP/2.0/UDP 202.84.43.194:5060;branch=z9hG4bK6019EB
From: "Mohammad Rajibul Alam Joarder" <sip:09609001415@202.84.43.194>;tag=2AA56F3C-18E7
To: <sip:00919686217788@202.84.38.24>
Date: Thu, 21 May 2015 17:19:24 GMT
Call-ID: 5CB7A6A0-FF1411E4-83708FA4-AF1AA63@202.84.43.194
Max-Forwards: 70
CSeq: 101 ACK
Allow-Events: telephone-event
Content-Length: 0


*May 21 17:19:25.068: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
ACK sip:00919686217788@10.193.240.10:5060 SIP/2.0
Via: SIP/2.0/TCP 162.44.127.147:5060;branch=z9hG4bK15ad9735102239
From: "Mohammad Rajibul Alam Joarder" <sip:09609001415@162.44.127.147>;tag=21267291~ce33eaa0-f4b4-4530-bbec-20f8fa27ac43-91294956
To: <sip:00919686217788@10.193.240.10>;tag=2AA56F3C-17B
Date: Thu, 21 May 2015 17:23:25 GMT
Call-ID: 15162a00-55e1148d-150cad-937f2ca2@162.44.127.147
Max-Forwards: 70
CSeq: 101 ACK
Allow-Events: presence, kpml
Content-Length: 0


voip ccapi inout debugging is on
bddhavoip#
bddhavoip#
bddhavoip#
bddhavoip#
*May 21 17:21:36.675: //-1/xxxxxxxxxxxx/CCAPI/ccIFCallSetupRequestPrivate:
   Interface=0x42930B54, Interface Type=9, Destination=0.0.0.0, Mode=0x0,
   Call Params(Calling Number=,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,
   Subscriber Type Str=, FinalDestinationFlag=FALSE, Outgoing Dial-peer=0, Call Count On=FALSE,
   Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)
*May 21 17:21:36.675: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*May 21 17:21:36.675: :cc_get_feature_vsa malloc success
*May 21 17:21:36.675: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*May 21 17:21:36.675:  cc_get_feature_vsa count is 63
*May 21 17:21:36.675: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*May 21 17:21:36.675: :FEATURE_VSA attributes are: feature_name:0,feature_time:346576672,feature_id:406
*May 21 17:21:36.675: //417/xxxxxxxxxxxx/CCAPI/ccIFCallSetupRequestPrivate:
   SPI Call Setup Request Is Success; Interface Type=9, FlowMode=1
*May 21 17:21:36.675: //417/xxxxxxxxxxxx/CCAPI/ccCallSetContext:
   Context=0x41ED1854
*May 21 17:21:36.675: //-1/xxxxxxxxxxxx/CCAPI/ccIFCallSetupRequestPrivate:
   Interface=0x133D8AB8, Interface Type=25, Destination=, Mode=0x0,
   Call Params(Calling Number=,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,
   Subscriber Type Str=, FinalDestinationFlag=FALSE, Outgoing Dial-peer=0, Call Count On=FALSE,
   Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)
*May 21 17:21:36.675: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*May 21 17:21:36.675: :cc_get_feature_vsa malloc success
*May 21 17:21:36.675: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*May 21 17:21:36.675:  cc_get_feature_vsa count is 64
*May 21 17:21:36.675: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*May 21 17:21:36.675: :FEATURE_VSA attributes are: feature_name:0,feature_time:346576896,feature_id:407
*May 21 17:21:36.675: //418/xxxxxxxxxxxx/CCAPI/cc_api_call_connected:
   Interface=0x133D8AB8, Data Bitmask=0x0, Progress Indication=NULL(0),
   Connection Handle=0
*May 21 17:21:36.675: //418/xxxxxxxxxxxx/CCAPI/cc_api_call_connected:
   Call Entry(Connected=TRUE, Responsed=TRUE, Retry Count=0)
*May 21 17:21:36.675: //418/xxxxxxxxxxxx/CCAPI/ccIFCallSetupRequestPrivate:
   SPI Call Setup Request Is Success; Interface Type=25, FlowMode=1
*May 21 17:21:36.675: //418/xxxxxxxxxxxx/CCAPI/ccCallSetContext:
   Context=0x41ED1878
*May 21 17:21:36.675: //417/xxxxxxxxxxxx/CCAPI/cc_api_call_connected:
   Interface=0x42930B54, Data Bitmask=0x0, Progress Indication=NULL(0),
   Connection Handle=0
*May 21 17:21:36.675: //417/xxxxxxxxxxxx/CCAPI/cc_api_call_connected:
   Call Entry(Connected=TRUE, Responsed=TRUE, Retry Count=0)
*May 21 17:21:36.675: //418/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:
   (confID=0xFFFFFFFF, callID1=0x1A2, gcid=0-0-0-0, tag=0x0)
*May 21 17:21:36.675: //417/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:
   (confID=0xFFFFFFFF, callID2=0x1A1, gcid=0-0-0-0, tag=0x0)
*May 21 17:21:36.675: //418/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:
   Conference Id=0xFFFFFFFF, Call Id1=418, Call Id2=417, Tag=0x0
*May 21 17:21:36.675: //418/xxxxxxxxxxxx/CCAPI/cc_api_bridge_done:
   Conference Id=0x78, Source Interface=0x133D8AB8, Source Call Id=418,
   Destination Call Id=417, Disposition=0x0, Tag=0x0
*May 21 17:21:36.675: //417/xxxxxxxxxxxx/CCAPI/cc_api_ha_call_active_notify:

*May 21 17:21:36.675: call_info mainst_callID:0x1A1, peer_callID:0x1A2, confID:0x78, spi_type:6, media_flo_thru:1,num_streams:1, swmtpmsp_present:0

*May 21 17:21:36.675: //417/xxxxxxxxxxxx/CCAPI/cc_api_ha_call_active_notify:

*May 21 17:21:36.675:   stream[0]: callid:0x1A1, media_passthrough:1
*May 21 17:21:36.675: //417/xxxxxxxxxxxx/CCAPI/cc_api_bridge_done:
   Conference Id=0x78, Source Interface=0x42930B54, Source Call Id=417,
   Destination Call Id=418, Disposition=0x0, Tag=0x0
*May 21 17:21:36.675: //418/xxxxxxxxxxxx/CCAPI/cc_generic_bridge_done:
   Conference Id=0x78, Source Interface=0x42930B54, Source Call Id=417,
   Destination Call Id=418, Disposition=0x0, Tag=0x0
*May 21 17:21:36.675: //418/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:
   Call Entry(Conference Id=0x78, Destination Call Id=417)
*May 21 17:21:36.675: //417/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:
   Call Entry(Conference Id=0x78, Destination Call Id=418)
*May 21 17:21:36.675: //418/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:

*May 21 17:21:36.675: confID:0x78; callEntry1 callID1:0x1A2, type:25; callEntry2 callID2:0x1A1, type:9

*May 21 17:21:36.675: //417/xxxxxxxxxxxx/CCAPI/ccCallModify:
   Nominator=0x0, Params=0x43937DE0, Call Id=417
*May 21 17:21:36.675: //418/xxxxxxxxxxxx/CCAPI/cc_process_notify_bridge_done:
   Conference Id=0x78, Call Id1=418, Call Id2=417
*May 21 17:21:36.675: //417/xxxxxxxxxxxx/CCAPI/cc_api_call_modify_done:
   Result=0, Interface=0x42930B54, Call Id=417
*May 21 17:21:36.675: //417/xxxxxxxxxxxx/CCAPI/cc_api_ha_call_active_notify:

*May 21 17:21:36.675: call_info mainst_callID:0x1A1, peer_callID:0x1A2, confID:0x78, spi_type:6, media_flo_thru:1,num_streams:1, swmtpmsp_present:0

*May 21 17:21:36.675: //417/xxxxxxxxxxxx/CCAPI/cc_api_ha_call_active_notify:

*May 21 17:21:36.675:   stream[0]: callid:0x1A1, media_passthrough:1
*May 21 17:21:36.675: //417/xxxxxxxxxxxx/CCAPI/ccCallModifyExtended:
   Nominator=0x439383E0, Params=0x439383F0, Call Id=417
*May 21 17:21:36.947: //-1/63C3C4000000/CCAPI/cc_api_display_ie_subfields:
   cc_api_call_setup_ind_common:
   cisco-username=09609001415
   ----- ccCallInfo IE subfields -----
   cisco-ani=09609001415
   cisco-anitype=0
   cisco-aniplan=0
   cisco-anipi=0
   cisco-anisi=1
   dest=00919686217788
   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 21 17:21:36.947: //-1/63C3C4000000/CCAPI/cc_api_call_setup_ind_common:
   Interface=0x1B298B4, Call Info(
   Calling Number=09609001415,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),
   Called Number=00919686217788(TON=Unknown, NPI=Unknown),
   Calling Translated=FALSE, Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE,
   Incoming Dial-peer=0, Progress Indication=NULL(0), Calling IE Present=TRUE,
   Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=419
*May 21 17:21:36.947: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*May 21 17:21:36.947: :cc_get_feature_vsa malloc success
*May 21 17:21:36.947: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*May 21 17:21:36.947:  cc_get_feature_vsa count is 65
*May 21 17:21:36.947: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*May 21 17:21:36.947: :FEATURE_VSA attributes are: feature_name:0,feature_time:346576000,feature_id:408
*May 21 17:21:36.947: //419/63C3C4000000/CCAPI/cc_api_call_setup_ind_common:
   Set Up Event Sent;
   Call Info(Calling Number=09609001415(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),
   Called Number=00919686217788(TON=Unknown, NPI=Unknown))
*May 21 17:21:36.947: //419/63C3C4000000/CCAPI/cc_process_call_setup_ind:
   Event=0x4395C850
*May 21 17:21:36.947: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search:
   Try with the demoted called number 00919686217788
*May 21 17:21:36.947: //419/63C3C4000000/CCAPI/ccCallSetContext:
   Context=0x41F2B6F4
*May 21 17:21:36.951: //419/63C3C4000000/CCAPI/cc_process_call_setup_ind:
   >>>>CCAPI handed cid 419 with tag 0 to app "_ManagedAppProcess_Default"
*May 21 17:21:36.951: //419/63C3C4000000/CCAPI/ccCallProceeding:
   Progress Indication=NULL(0)
*May 21 17:21:36.951: //419/63C3C4000000/CCAPI/ccCallSetupRequest:
   Destination=, Calling IE Present=TRUE, Mode=0,
   Outgoing Dial-peer=2000, Params=0x41F2CCB4, Progress Indication=NULL(0)
*May 21 17:21:36.951: //419/63C3C4000000/CCAPI/ccCheckClipClir:
   In: Calling Number=09609001415(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)
*May 21 17:21:36.951: //419/63C3C4000000/CCAPI/ccCheckClipClir:
   Out: Calling Number=09609001415(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)
*May 21 17:21:36.951: //419/63C3C4000000/CCAPI/ccCallSetupRequest:
   Destination Pattern=00T, Called Number=00919686217788, Digit Strip=FALSE
*May 21 17:21:36.951: //419/63C3C4000000/CCAPI/ccCallSetupRequest:
   Calling Number=09609001415(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),
   Called Number=00919686217788(TON=Unknown, NPI=Unknown),
   Redirect Number=, Display Info=Mohammad Rajibul Alam Joarder
   Account Number=09609001415, Final Destination Flag=TRUE,
   Guid=63C3C400-0001-0000-0000-0073937F2CA2, Outgoing Dial-peer=2000
*May 21 17:21:36.951: //419/63C3C4000000/CCAPI/cc_api_display_ie_subfields:
   ccCallSetupRequest:
   cisco-username=09609001415
   ----- ccCallInfo IE subfields -----
   cisco-ani=09609001415
   cisco-anitype=0
   cisco-aniplan=0
   cisco-anipi=0
   cisco-anisi=1
   dest=00919686217788
   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 21 17:21:36.951: //419/63C3C4000000/CCAPI/ccIFCallSetupRequestPrivate:
   Interface=0x1B298B4, Interface Type=3, Destination=, Mode=0x0,
   Call Params(Calling Number=09609001415,(Calling Name=Mohammad Rajibul Alam Joarder)(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),
   Called Number=00919686217788(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,
   Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE, Outgoing Dial-peer=2000, Call Count On=FALSE,
   Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)
*May 21 17:21:36.951: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*May 21 17:21:36.951: :cc_get_feature_vsa malloc success
*May 21 17:21:36.951: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*May 21 17:21:36.951:  cc_get_feature_vsa count is 66
*May 21 17:21:36.951: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*May 21 17:21:36.951: :FEATURE_VSA attributes are: feature_name:0,feature_time:346575776,feature_id:409
*May 21 17:21:36.951: //419/63C3C4000000/CCAPI/cc_api_event_indication:
   Event=101, Call Id=419
*May 21 17:21:36.951: //419/63C3C4000000/CCAPI/cc_api_event_indication:
   Event Is Sent To Conferenced SPI(s) Directly
*May 21 17:21:36.951: //420/63C3C4000000/CCAPI/ccIFCallSetupRequestPrivate:
   SPI Call Setup Request Is Success; Interface Type=3, FlowMode=1
*May 21 17:21:36.951: //420/63C3C4000000/CCAPI/ccCallSetContext:
   Context=0x41F2CC64
*May 21 17:21:36.951: //419/63C3C4000000/CCAPI/ccSaveDialpeerTag:
   Outgoing Dial-peer=2000
*May 21 17:21:36.951: //420/63C3C4000000/CCAPI/ccGetMediaClassTag:
   media class tag 0
*May 21 17:21:36.951: //420/63C3C4000000/CCAPI/ccSetMediaclassIp2ipTags:
   media class tags set: NR 0, ASP 0
*May 21 17:21:36.951: //419/63C3C4000000/CCAPI/ccGetMediaClassTag:
   no peer tag found, use the default media class tag
*May 21 17:21:36.951: //419/63C3C4000000/CCAPI/ccSetMediaclassIp2ipTags:
   media class tags set: NR 0, ASP 0
*May 21 17:21:36.951: //420/63C3C4000000/CCAPI/ccGet_xc_nr_asp_info:
   media class tags: NR 0, ASP 0
*May 21 17:21:36.951: //419/63C3C4000000/CCAPI/ccGet_xc_nr_asp_info:
   media class tags: NR 0, ASP 0
*May 21 17:21:36.951: //420/63C3C4000000/CCAPI/cc_api_event_indication:
   Event=193, Call Id=420
*May 21 17:21:36.951: //420/63C3C4000000/CCAPI/cc_api_event_indication:
   Event Is Sent To Conferenced SPI(s) Directly
*May 21 17:21:36.951: //419/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

*May 21 17:21:36.951: cc_api_get_xcode_stream : 4936
*May 21 17:21:36.951: //420/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

*May 21 17:21:36.951: cc_api_get_xcode_stream : 4936
*May 21 17:21:36.951: //419/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

*May 21 17:21:36.951: cc_api_get_xcode_stream : 4936
*May 21 17:21:36.951: //419/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

*May 21 17:21:36.951: cc_api_get_xcode_stream : 4936
*May 21 17:21:36.951: //420/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

*May 21 17:21:36.951: cc_api_get_xcode_stream : 4936
*May 21 17:21:36.951: //419/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

*May 21 17:21:36.951: cc_api_get_xcode_stream : 4936
*May 21 17:21:36.951: //420/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

*May 21 17:21:36.951: cc_api_get_xcode_stream : 4936
*May 21 17:21:36.951: //420/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

*May 21 17:21:36.951: cc_api_get_xcode_stream : 4936
*May 21 17:21:36.951: //420/63C3C4000000/CCAPI/cc_api_call_proceeding:
   Interface=0x1B298B4, Progress Indication=NULL(0)
*May 21 17:21:36.955: //420/63C3C4000000/CCAPI/cc_api_call_disconnected:
   Cause Value=47, Interface=0x1B298B4, Call Id=420
*May 21 17:21:36.955: //420/63C3C4000000/CCAPI/cc_api_call_disconnected:
   Call Entry(Responsed=TRUE, Cause Value=47, Retry Count=0)
*May 21 17:21:36.959: //419/63C3C4000000/CCAPI/ccCallReleaseResources:
   release reserved xcoding resource.
*May 21 17:21:36.959: //420/63C3C4000000/CCAPI/ccCallSetAAA_Accounting:
   Accounting=0, Call Id=420
*May 21 17:21:36.959: //420/63C3C4000000/CCAPI/ccCallDisconnect:
   Cause Value=47, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=47)
*May 21 17:21:36.959: //420/63C3C4000000/CCAPI/ccCallDisconnect:
   Cause Value=47, Call Entry(Responsed=TRUE, Cause Value=47)
*May 21 17:21:36.959: //420/63C3C4000000/CCAPI/cc_api_call_disconnect_done:
   Disposition=0, Interface=0x1B298B4, Tag=0x0, Call Id=420,
   Call Entry(Disconnect Cause=47, Voice Class Cause Code=0, Retry Count=0)
*May 21 17:21:36.959: //420/63C3C4000000/CCAPI/cc_api_call_disconnect_done:
   Call Disconnect Event Sent
*May 21 17:21:36.959: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

*May 21 17:21:36.959: :cc_free_feature_vsa freeing 14A85398
*May 21 17:21:36.959: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

*May 21 17:21:36.959:  vsacount in free is 65
*May 21 17:21:36.959: //419/63C3C4000000/CCAPI/ccCallDisconnect:
   Cause Value=47, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)
*May 21 17:21:36.959: //419/63C3C4000000/CCAPI/ccCallDisconnect:
   Cause Value=47, Call Entry(Responsed=TRUE, Cause Value=47)
*May 21 17:21:37.227: //418/xxxxxxxxxxxx/CCAPI/ccConferenceDestroy:
   Conference Id=0x78, Tag=0x0
*May 21 17:21:37.227: //418/xxxxxxxxxxxx/CCAPI/ccConferenceDestroy:

*May 21 17:21:37.227: confID:0x78; callEntry1 callID1:0x1A2, type:25; callEntry2 callID2:0x1A1, type:9

*May 21 17:21:37.227: //418/xxxxxxxxxxxx/CCAPI/cc_api_bridge_drop_done:
   Conference Id=0x78, Source Interface=0x133D8AB8, Source Call Id=418,
   Destination Call Id=417, Disposition=0x0, Tag=0x0
*May 21 17:21:37.227: //417/xxxxxxxxxxxx/CCAPI/cc_api_bridge_drop_done:
   Conference Id=0x78, Source Interface=0x42930B54, Source Call Id=417,
   Destination Call Id=418, Disposition=0x0, Tag=0x0
*May 21 17:21:37.227: //418/xxxxxxxxxxxx/CCAPI/cc_generic_bridge_done:
   Conference Id=0x78, Source Interface=0x42930B54, Source Call Id=417,
   Destination Call Id=418, Disposition=0x0, Tag=0x0
*May 21 17:21:37.227: //417/xxxxxxxxxxxx/CCAPI/ccCallDisconnect:
   Cause Value=0, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)
*May 21 17:21:37.227: //417/xxxxxxxxxxxx/CCAPI/ccCallDisconnect:
   Cause Value=0, Call Entry(Responsed=TRUE, Cause Value=0)
*May 21 17:21:37.227: //417/xxxxxxxxxxxx/CCAPI/cc_api_call_disconnect_done:
   Disposition=0, Interface=0x42930B54, Tag=0x0, Call Id=417,
   Call Entry(Disconnect Cause=0, Voice Class Cause Code=0, Retry Count=0)
*May 21 17:21:37.227: //417/xxxxxxxxxxxx/CCAPI/cc_api_call_disconnect_done:
   Call Disconnect Event Sent
*May 21 17:21:37.227: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

*May 21 17:21:37.227: :cc_free_feature_vsa freeing 14A85718
*May 21 17:21:37.227: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

*May 21 17:21:37.227:  vsacount in free is 64
*May 21 17:21:37.227: //418/xxxxxxxxxxxx/CCAPI/ccCallDisconnect:
   Cause Value=0, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)
*May 21 17:21:37.227: //418/xxxxxxxxxxxx/CCAPI/ccCallDisconnect:
   Cause Value=0, Call Entry(Responsed=TRUE, Cause Value=0)
*May 21 17:21:37.227: //418/xxxxxxxxxxxx/CCAPI/cc_api_call_disconnect_done:
   Disposition=0, Interface=0x133D8AB8, Tag=0x0, Call Id=418,
   Call Entry(Disconnect Cause=0, Voice Class Cause Code=0, Retry Count=0)
*May 21 17:21:37.227: //418/xxxxxxxxxxxx/CCAPI/cc_api_call_disconnect_done:
   Call Disconnect Event Sent
*May 21 17:21:37.227: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

*May 21 17:21:37.227: :cc_free_feature_vsa freeing 14A857F8
*May 21 17:21:37.227: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

*May 21 17:21:37.227:  vsacount in free is 63

 

Selva

Hi Selva,

I beleive the call flow here is:
IP phone -- CUCM -- CUBE -- PSTN

Invite + SDP from CUCM to CUBE:
--------------------------------------

*May 21 17:19:24.788: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
INVITE sip:00919686217788@10.193.240.10:5060 SIP/2.0
Via: SIP/2.0/TCP 162.44.127.147:5060;branch=z9hG4bK15ad9735102239
From: "Mohammad Rajibul Alam Joarder" <sip:09609001415@162.44.127.147>;tag=21267291~ce33eaa0-f4b4-4530-bbec-20f8fa27ac43-91294956
To: <sip:00919686217788@10.193.240.10>
Date: Thu, 21 May 2015 17:23:25 GMT
Call-ID: 15162a00-55e1148d-150cad-937f2ca2@162.44.127.147

v=0
o=CiscoSystemsCCM-SIP 21267291 1 IN IP4 162.44.127.147
s=SIP Call
c=IN IP4 10.193.240.10                
t=0 0
m=audio 16978 RTP/AVP 8 101
a=rtpmap:8 PCMA/8000
a=ptime:20
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15

 

Invite + SDP sent to provider by CUBE
--------------------------------------
*May 21 17:19:24.796: //416/15162A000000/SIP/Msg/ccsipDisplayMsg:
Sent:
INVITE sip:00919686217788@202.84.38.24:5060 SIP/2.0
Via: SIP/2.0/UDP 202.84.43.194:5060;branch=z9hG4bK6019EB
Remote-Party-ID: "Mohammad Rajibul Alam Joarder" <sip:09609001415@202.84.43.194>;party=calling;screen=yes;privacy=off
From: "Mohammad Rajibul Alam Joarder" <sip:09609001415@202.84.43.194>;tag=2AA56F3C-18E7
To: <sip:00919686217788@202.84.38.24>
Date: Thu, 21 May 2015 17:19:24 GMT
Call-ID: 5CB7A6A0-FF1411E4-83708FA4-AF1AA63@202.84.43.194

v=0
o=CiscoSystemsSIP-GW-UserAgent 3220 6525 IN IP4 202.84.43.194
s=SIP Call
c=IN IP4 202.84.43.194
t=0 0
m=audio 16982 RTP/AVP 8 101
c=IN IP4 202.84.43.194
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:20

 

CUBE to CUCM

---------------------

Sent:
SIP/2.0 100 Trying
Call-ID: 15162a00-55e1148d-150cad-937f2ca2@162.44.127.147

Instead of 100 Trying, we are receiving "407 Proxy Authentication Required" from Provider. Not sure if you have something else between CUBE and provider. If yes, configure it properly.
---------------------------------------------------------------------------------------------------------------------------------------------------------
Received:
SIP/2.0 407 Proxy Authentication Required
Call-Id: 5CB7A6A0-FF1411E4-83708FA4-AF1AA63@202.84.43.194

CUBE To CUCM
------------
Sent:
SIP/2.0 407 Proxy Authentication Required
Via: SIP/2.0/TCP 162.44.127.147:5060;branch=z9hG4bK15ad9735102239

Ack from CUCM to CUBE
-------------------------
Received:
ACK sip:00919686217788@10.193.240.10:5060 SIP/2.0
Call-ID: 15162a00-55e1148d-150cad-937f2ca2@162.44.127.147


Ack from CUBE to provider
--------------------------
*May 21 17:19:24.800: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
ACK sip:00919686217788@202.84.38.24:5060 SIP/2.0
Call-ID: 5CB7A6A0-FF1411E4-83708FA4-AF1AA63@202.84.43.194

>> Debugs are not complete. Do you know who is sending the disconnect? Please post the complete debugs again.

>> Debugs:     debug voip ccapi inout
            debug ccsip all
            
>> Also share the output of "show dspfarm all"

>> In dial-peer 2000, remove "dtmf-relay h245-signal rtp-nte" (as this is not a H323 dial peer) and add "dtmf-relay rtp-nte"

Regards,
Ronak Agarwal

I have tried removing the dtmf-relay h245-signal rtp-nte and added the dtmf-relay rtp-nte in Dial _peer. Still have the same Problem.

 

Find the below Debug Logs.

 

bddhavoip#debug voip ccapi inout
voip ccapi inout debugging is on

*May 22 11:44:42.853: //-1/xxxxxxxxxxxx/CCAPI/ccIFCallSetupRequestPrivate:
   Interface=0x42930B54, Interface Type=9, Destination=0.0.0.0, Mode=0x0,
   Call Params(Calling Number=,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,
   Subscriber Type Str=, FinalDestinationFlag=FALSE, Outgoing Dial-peer=0, Call Count On=FALSE,
   Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)
*May 22 11:44:42.853: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
  
*May 22 11:44:42.853: :cc_get_feature_vsa malloc success
*May 22 11:44:42.853: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
  
*May 22 11:44:42.853:  cc_get_feature_vsa count is 83
*May 22 11:44:42.853: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
  
*May 22 11:44:42.853: :FEATURE_VSA attributes are: feature_name:0,feature_time:346575552,feature_id:464
*May 22 11:44:42.853: //475/xxxxxxxxxxxx/CCAPI/ccIFCallSetupRequestPrivate:
   SPI Call Setup Request Is Success; Interface Type=9, FlowMode=1
*May 22 11:44:42.853: //475/xxxxxxxxxxxx/CCAPI/ccCallSetContext:
   Context=0x41ED1BD8
*May 22 11:44:42.853: //-1/xxxxxxxxxxxx/CCAPI/ccIFCallSetupRequestPrivate:
   Interface=0x133D8AB8, Interface Type=25, Destination=, Mode=0x0,
   Call Params(Calling Number=,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,
   Subscriber Type Str=, FinalDestinationFlag=FALSE, Outgoing Dial-peer=0, Call Count On=FALSE,
   Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)
*May 22 11:44:42.853: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
  
*May 22 11:44:42.853: :cc_get_feature_vsa malloc success
*May 22 11:44:42.853: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
  
*May 22 11:44:42.853:  cc_get_feature_vsa count is 84
*May 22 11:44:42.853: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
  
*May 22 11:44:42.853: :FEATURE_VSA attributes are: feature_name:0,feature_time:346575776,feature_id:465
*May 22 11:44:42.853: //476/xxxxxxxxxxxx/CCAPI/cc_api_call_connected:
   Interface=0x133D8AB8, Data Bitmask=0x0, Progress Indication=NULL(0),
   Connection Handle=0
*May 22 11:44:42.857: //476/xxxxxxxxxxxx/CCAPI/cc_api_call_connected:
   Call Entry(Connected=TRUE, Responsed=TRUE, Retry Count=0)
*May 22 11:44:42.857: //476/xxxxxxxxxxxx/CCAPI/ccIFCallSetupRequestPrivate:
   SPI Call Setup Request Is Success; Interface Type=25, FlowMode=1
*May 22 11:44:42.857: //476/xxxxxxxxxxxx/CCAPI/ccCallSetContext:
   Context=0x41ED1BFC
*May 22 11:44:42.857: //475/xxxxxxxxxxxx/CCAPI/cc_api_call_connected:
   Interface=0x42930B54, Data Bitmask=0x0, Progress Indication=NULL(0),
   Connection Handle=0
*May 22 11:44:42.857: //475/xxxxxxxxxxxx/CCAPI/cc_api_call_connected:
   Call Entry(Connected=TRUE, Responsed=TRUE, Retry Count=0)
*May 22 11:44:42.857: //476/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:
   (confID=0xFFFFFFFF, callID1=0x1DC, gcid=0-0-0-0, tag=0x0)
*May 22 11:44:42.857: //475/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:
   (confID=0xFFFFFFFF, callID2=0x1DB, gcid=0-0-0-0, tag=0x0)
*May 22 11:44:42.857: //476/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:
   Conference Id=0xFFFFFFFF, Call Id1=476, Call Id2=475, Tag=0x0
*May 22 11:44:42.857: //476/xxxxxxxxxxxx/CCAPI/cc_api_bridge_done:
   Conference Id=0x86, Source Interface=0x133D8AB8, Source Call Id=476,
   Destination Call Id=475, Disposition=0x0, Tag=0x0
*May 22 11:44:42.857: //475/xxxxxxxxxxxx/CCAPI/cc_api_ha_call_active_notify:
  
*May 22 11:44:42.857: call_info mainst_callID:0x1DB, peer_callID:0x1DC, confID:0x86, spi_type:6, media_flo_thru:1,num_streams:1, swmtpmsp_present:0

*May 22 11:44:42.857: //475/xxxxxxxxxxxx/CCAPI/cc_api_ha_call_active_notify:
  
*May 22 11:44:42.857:   stream[0]: callid:0x1DB, media_passthrough:1
*May 22 11:44:42.857: //475/xxxxxxxxxxxx/CCAPI/cc_api_bridge_done:
   Conference Id=0x86, Source Interface=0x42930B54, Source Call Id=475,
   Destination Call Id=476, Disposition=0x0, Tag=0x0
*May 22 11:44:42.857: //476/xxxxxxxxxxxx/CCAPI/cc_generic_bridge_done:
   Conference Id=0x86, Source Interface=0x42930B54, Source Call Id=475,
   Destination Call Id=476, Disposition=0x0, Tag=0x0
*May 22 11:44:42.857: //476/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:
   Call Entry(Conference Id=0x86, Destination Call Id=475)
*May 22 11:44:42.857: //475/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:
   Call Entry(Conference Id=0x86, Destination Call Id=476)
*May 22 11:44:42.857: //476/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:
  
*May 22 11:44:42.857: confID:0x86; callEntry1 callID1:0x1DC, type:25; callEntry2 callID2:0x1DB, type:9

*May 22 11:44:42.857: //475/xxxxxxxxxxxx/CCAPI/ccCallModify:
   Nominator=0x0, Params=0x43937DE0, Call Id=475
*May 22 11:44:42.857: //476/xxxxxxxxxxxx/CCAPI/cc_process_notify_bridge_done:
   Conference Id=0x86, Call Id1=476, Call Id2=475
*May 22 11:44:42.857: //475/xxxxxxxxxxxx/CCAPI/cc_api_call_modify_done:
   Result=0, Interface=0x42930B54, Call Id=475
*May 22 11:44:42.857: //475/xxxxxxxxxxxx/CCAPI/cc_api_ha_call_active_notify:
  
*May 22 11:44:42.857: call_info mainst_callID:0x1DB, peer_callID:0x1DC, confID:0x86, spi_type:6, media_flo_thru:1,num_streams:1, swmtpmsp_present:0

*May 22 11:44:42.857: //475/xxxxxxxxxxxx/CCAPI/cc_api_ha_call_active_notify:
  
*May 22 11:44:42.857:   stream[0]: callid:0x1DB, media_passthrough:1
*May 22 11:44:42.857: //475/xxxxxxxxxxxx/CCAPI/ccCallModifyExtended:
   Nominator=0x439383E0, Params=0x439383F0, Call Id=475
*May 22 11:44:43.137: //-1/81456C000000/CCAPI/cc_api_display_ie_subfields:
   cc_api_call_setup_ind_common:
   cisco-username=9609001415
   ----- ccCallInfo IE subfields -----
   cisco-ani=9609001415
   cisco-anitype=0
   cisco-aniplan=0
   cisco-anipi=0
   cisco-anisi=1
   dest=00919686217788
   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 22 11:44:43.137: //-1/81456C000000/CCAPI/cc_api_call_setup_ind_common:
   Interface=0x1B298B4, Call Info(
   Calling Number=9609001415,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),
   Called Number=00919686217788(TON=Unknown, NPI=Unknown),
   Calling Translated=FALSE, Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE,
   Incoming Dial-peer=5500, Progress Indication=NULL(0), Calling IE Present=TRUE,
   Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=477
*May 22 11:44:43.137: //-1/81456C000000/CCAPI/ccCheckClipClir:
   In: Calling Number=9609001415(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)
*May 22 11:44:43.137: //-1/81456C000000/CCAPI/ccCheckClipClir:
   Out: Calling Number=9609001415(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)
*May 22 11:44:43.137: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
  
*May 22 11:44:43.137: :cc_get_feature_vsa malloc success
*May 22 11:44:43.137: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
  
*May 22 11:44:43.137:  cc_get_feature_vsa count is 85
*May 22 11:44:43.137: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
  
*May 22 11:44:43.137: :FEATURE_VSA attributes are: feature_name:0,feature_time:346571520,feature_id:466
*May 22 11:44:43.137: //477/81456C000000/CCAPI/cc_api_call_setup_ind_common:
   Set Up Event Sent;
   Call Info(Calling Number=9609001415(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),
   Called Number=00919686217788(TON=Unknown, NPI=Unknown))
*May 22 11:44:43.141: //477/81456C000000/CCAPI/cc_process_call_setup_ind:
   Event=0x4395DE60
*May 22 11:44:43.141: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search:
   Try with the demoted called number 00919686217788
*May 22 11:44:43.141: //477/81456C000000/CCAPI/ccCallSetContext:
   Context=0x10FE0564
*May 22 11:44:43.141: //477/81456C000000/CCAPI/cc_process_call_setup_ind:
   >>>>CCAPI handed cid 477 with tag 5500 to app "_ManagedAppProcess_Default"
*May 22 11:44:43.141: //477/81456C000000/CCAPI/ccCallProceeding:
   Progress Indication=NULL(0)
*May 22 11:44:43.141: //477/81456C000000/CCAPI/ccCallSetupRequest:
   Destination=, Calling IE Present=TRUE, Mode=0,
   Outgoing Dial-peer=6600, Params=0x10FE1B24, Progress Indication=NULL(0)
*May 22 11:44:43.141: //477/81456C000000/CCAPI/ccCheckClipClir:
   In: Calling Number=9609001415(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)
*May 22 11:44:43.141: //477/81456C000000/CCAPI/ccCheckClipClir:
   Out: Calling Number=9609001415(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)
*May 22 11:44:43.141: //477/81456C000000/CCAPI/ccCallSetupRequest:
   Destination Pattern=00919686217788, Called Number=00919686217788, Digit Strip=FALSE
*May 22 11:44:43.141: //477/81456C000000/CCAPI/ccCallSetupRequest:
   Calling Number=9609001415(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),
   Called Number=00919686217788(TON=Unknown, NPI=Unknown),
   Redirect Number=, Display Info=Mohammad Rajibul Alam Joarder
   Account Number=9609001415, Final Destination Flag=TRUE,
   Guid=81456C00-0001-0000-0000-007E937F2CA2, Outgoing Dial-peer=6600
*May 22 11:44:43.141: //477/81456C000000/CCAPI/cc_api_display_ie_subfields:
   ccCallSetupRequest:
   cisco-username=9609001415
   ----- ccCallInfo IE subfields -----
   cisco-ani=9609001415
   cisco-anitype=0
   cisco-aniplan=0
   cisco-anipi=0
   cisco-anisi=1
   dest=00919686217788
   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 22 11:44:43.141: //477/81456C000000/CCAPI/ccIFCallSetupRequestPrivate:
   Interface=0x1B298B4, Interface Type=3, Destination=, Mode=0x0,
   Call Params(Calling Number=9609001415,(Calling Name=Mohammad Rajibul Alam Joarder)(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),
   Called Number=00919686217788(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,
   Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE, Outgoing Dial-peer=6600, Call Count On=FALSE,
   Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)
*May 22 11:44:43.141: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
  
*May 22 11:44:43.141: :cc_get_feature_vsa malloc success
*May 22 11:44:43.141: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
  
*May 22 11:44:43.141:  cc_get_feature_vsa count is 86
*May 22 11:44:43.141: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
  
*May 22 11:44:43.141: :FEATURE_VSA attributes are: feature_name:0,feature_time:346571296,feature_id:467
*May 22 11:44:43.141: //477/81456C000000/CCAPI/cc_api_event_indication:
   Event=101, Call Id=477
*May 22 11:44:43.141: //477/81456C000000/CCAPI/cc_api_event_indication:
   Event Is Sent To Conferenced SPI(s) Directly
*May 22 11:44:43.141: //478/81456C000000/CCAPI/ccIFCallSetupRequestPrivate:
   SPI Call Setup Request Is Success; Interface Type=3, FlowMode=1
*May 22 11:44:43.141: //478/81456C000000/CCAPI/ccCallSetContext:
   Context=0x10FE1AD4
*May 22 11:44:43.141: //477/81456C000000/CCAPI/ccSaveDialpeerTag:
   Outgoing Dial-peer=6600
*May 22 11:44:43.141: //478/81456C000000/CCAPI/ccGetMediaClassTag:
   media class tag 0
*May 22 11:44:43.141: //478/81456C000000/CCAPI/ccSetMediaclassIp2ipTags:
   media class tags set: NR 0, ASP 0
*May 22 11:44:43.141: //477/81456C000000/CCAPI/ccGetMediaClassTag:
   media class tag 0
*May 22 11:44:43.141: //477/81456C000000/CCAPI/ccSetMediaclassIp2ipTags:
   media class tags set: NR 0, ASP 0
*May 22 11:44:43.141: //478/81456C000000/CCAPI/ccGet_xc_nr_asp_info:
   media class tags: NR 0, ASP 0
*May 22 11:44:43.141: //477/81456C000000/CCAPI/ccGet_xc_nr_asp_info:
   media class tags: NR 0, ASP 0
*May 22 11:44:43.141: //478/81456C000000/CCAPI/cc_api_event_indication:
   Event=193, Call Id=478
*May 22 11:44:43.141: //478/81456C000000/CCAPI/cc_api_event_indication:
   Event Is Sent To Conferenced SPI(s) Directly
*May 22 11:44:43.141: //477/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:
  
*May 22 11:44:43.141: cc_api_get_xcode_stream : 4936
*May 22 11:44:43.141: //478/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:
  
*May 22 11:44:43.141: cc_api_get_xcode_stream : 4936
*May 22 11:44:43.141: //477/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:
  
*May 22 11:44:43.141: cc_api_get_xcode_stream : 4936
*May 22 11:44:43.141: //477/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:
  
*May 22 11:44:43.141: cc_api_get_xcode_stream : 4936
*May 22 11:44:43.141: //478/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:
  
*May 22 11:44:43.141: cc_api_get_xcode_stream : 4936
*May 22 11:44:43.141: //477/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:
  
*May 22 11:44:43.141: cc_api_get_xcode_stream : 4936
*May 22 11:44:43.141: //478/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:
  
*May 22 11:44:43.141: cc_api_get_xcode_stream : 4936
*May 22 11:44:43.141: //478/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:
  
*May 22 11:44:43.141: cc_api_get_xcode_stream : 4936
*May 22 11:44:43.145: //478/81456C000000/CCAPI/cc_api_call_proceeding:
   Interface=0x1B298B4, Progress Indication=NULL(0)
*May 22 11:44:43.149: //478/81456C000000/CCAPI/cc_api_call_disconnected:
   Cause Value=47, Interface=0x1B298B4, Call Id=478
*May 22 11:44:43.149: //478/81456C000000/CCAPI/cc_api_call_disconnected:
   Call Entry(Responsed=TRUE, Cause Value=47, Retry Count=0)
*May 22 11:44:43.149: //477/81456C000000/CCAPI/ccCallReleaseResources:
   release reserved xcoding resource.
*May 22 11:44:43.149: //478/81456C000000/CCAPI/ccCallSetAAA_Accounting:
   Accounting=1, Call Id=478
*May 22 11:44:43.149: //478/81456C000000/CCAPI/ccCallDisconnect:
   Cause Value=47, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=47)
*May 22 11:44:43.149: //478/81456C000000/CCAPI/ccCallDisconnect:
   Cause Value=47, Call Entry(Responsed=TRUE, Cause Value=47)
*May 22 11:44:43.149: //478/81456C000000/CCAPI/cc_api_call_disconnect_done:
   Disposition=0, Interface=0x1B298B4, Tag=0x0, Call Id=478,
   Call Entry(Disconnect Cause=47, Voice Class Cause Code=0, Retry Count=0)
*May 22 11:44:43.149: //478/81456C000000/CCAPI/cc_api_call_disconnect_done:
   Call Disconnect Event Sent
*May 22 11:44:43.149: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
  
*May 22 11:44:43.149: :cc_free_feature_vsa freeing 14A84218
*May 22 11:44:43.149: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
  
*May 22 11:44:43.149:  vsacount in free is 85
*May 22 11:44:43.149: //477/81456C000000/CCAPI/ccCallSetupRequest:
   Destination=, Calling IE Present=TRUE, Mode=0,
   Outgoing Dial-peer=2000, Params=0x10FE3094, Progress Indication=NULL(0)
*May 22 11:44:43.149: //477/81456C000000/CCAPI/ccCheckClipClir:
   In: Calling Number=9609001415(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)
*May 22 11:44:43.149: //477/81456C000000/CCAPI/ccCheckClipClir:
   Out: Calling Number=9609001415(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)
*May 22 11:44:43.149: //477/81456C000000/CCAPI/ccCallSetupRequest:
   Destination Pattern=00T, Called Number=00919686217788, Digit Strip=FALSE
*May 22 11:44:43.149: //477/81456C000000/CCAPI/ccCallSetupRequest:
   Calling Number=9609001415(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),
   Called Number=00919686217788(TON=Unknown, NPI=Unknown),
   Redirect Number=, Display Info=Mohammad Rajibul Alam Joarder
   Account Number=9609001415, Final Destination Flag=TRUE,
   Guid=81456C00-0001-0000-0000-007E937F2CA2, Outgoing Dial-peer=2000
*May 22 11:44:43.149: //477/81456C000000/CCAPI/cc_api_display_ie_subfields:
   ccCallSetupRequest:
   cisco-username=9609001415
   ----- ccCallInfo IE subfields -----
   cisco-ani=9609001415
   cisco-anitype=0
   cisco-aniplan=0
   cisco-anipi=0
   cisco-anisi=1
   dest=00919686217788
   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 22 11:44:43.149: //477/81456C000000/CCAPI/ccIFCallSetupRequestPrivate:
   Interface=0x1B298B4, Interface Type=3, Destination=, Mode=0x0,
   Call Params(Calling Number=9609001415,(Calling Name=Mohammad Rajibul Alam Joarder)(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),
   Called Number=00919686217788(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,
   Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE, Outgoing Dial-peer=2000, Call Count On=FALSE,
   Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)
*May 22 11:44:43.149: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
  
*May 22 11:44:43.149: :cc_get_feature_vsa malloc success
*May 22 11:44:43.149: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
  
*May 22 11:44:43.149:  cc_get_feature_vsa count is 86
*May 22 11:44:43.149: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
  
*May 22 11:44:43.149: :FEATURE_VSA attributes are: feature_name:0,feature_time:346571296,feature_id:468
*May 22 11:44:43.149: //479/81456C000000/CCAPI/ccIFCallSetupRequestPrivate:
   SPI Call Setup Request Is Success; Interface Type=3, FlowMode=1
*May 22 11:44:43.149: //479/81456C000000/CCAPI/ccCallSetContext:
   Context=0x10FE3044
*May 22 11:44:43.149: //477/81456C000000/CCAPI/ccSaveDialpeerTag:
   Outgoing Dial-peer=2000
*May 22 11:44:43.417: //476/xxxxxxxxxxxx/CCAPI/ccConferenceDestroy:
   Conference Id=0x86, Tag=0x0
*May 22 11:44:43.417: //476/xxxxxxxxxxxx/CCAPI/ccConferenceDestroy:
  
*May 22 11:44:43.417: confID:0x86; callEntry1 callID1:0x1DC, type:25; callEntry2 callID2:0x1DB, type:9

*May 22 11:44:43.417: //476/xxxxxxxxxxxx/CCAPI/cc_api_bridge_drop_done:
   Conference Id=0x86, Source Interface=0x133D8AB8, Source Call Id=476,
   Destination Call Id=475, Disposition=0x0, Tag=0x0
*May 22 11:44:43.417: //475/xxxxxxxxxxxx/CCAPI/cc_api_bridge_drop_done:
   Conference Id=0x86, Source Interface=0x42930B54, Source Call Id=475,
   Destination Call Id=476, Disposition=0x0, Tag=0x0
*May 22 11:44:43.417: //476/xxxxxxxxxxxx/CCAPI/cc_generic_bridge_done:
   Conference Id=0x86, Source Interface=0x42930B54, Source Call Id=475,
   Destination Call Id=476, Disposition=0x0, Tag=0x0
*May 22 11:44:43.417: //475/xxxxxxxxxxxx/CCAPI/ccCallDisconnect:
   Cause Value=0, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)
*May 22 11:44:43.417: //475/xxxxxxxxxxxx/CCAPI/ccCallDisconnect:
   Cause Value=0, Call Entry(Responsed=TRUE, Cause Value=0)
*May 22 11:44:43.417: //475/xxxxxxxxxxxx/CCAPI/cc_api_call_disconnect_done:
   Disposition=0, Interface=0x42930B54, Tag=0x0, Call Id=475,
   Call Entry(Disconnect Cause=0, Voice Class Cause Code=0, Retry Count=0)
*May 22 11:44:43.417: //475/xxxxxxxxxxxx/CCAPI/cc_api_call_disconnect_done:
   Call Disconnect Event Sent
*May 22 11:44:43.417: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
  
*May 22 11:44:43.417: :cc_free_feature_vsa freeing 14A852B8
*May 22 11:44:43.417: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
  
*May 22 11:44:43.417:  vsacount in free is 85
*May 22 11:44:43.417: //476/xxxxxxxxxxxx/CCAPI/ccCallDisconnect:
   Cause Value=0, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)
*May 22 11:44:43.417: //476/xxxxxxxxxxxx/CCAPI/ccCallDisconnect:
   Cause Value=0, Call Entry(Responsed=TRUE, Cause Value=0)
*May 22 11:44:43.417: //476/xxxxxxxxxxxx/CCAPI/cc_api_call_disconnect_done:
   Disposition=0, Interface=0x133D8AB8, Tag=0x0, Call Id=476,
   Call Entry(Disconnect Cause=0, Voice Class Cause Code=0, Retry Count=0)
*May 22 11:44:43.421: //476/xxxxxxxxxxxx/CCAPI/cc_api_call_disconnect_done:
   Call Disconnect Event Sent
*May 22 11:44:43.421: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
  
*May 22 11:44:43.421: :cc_free_feature_vsa freeing 14A85398
*May 22 11:44:43.421: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
  
*May 22 11:44:43.421:  vsacount in free is 84
bddhavoip#
bddhavoip#
bddhavoip#debug ccsip all
This may severely impact system performance. Continue? [confirm]
All SIP Call tracing is enabled

*May 22 11:45:42.957: //-1/xxxxxxxxxxxx/SIP/Transport/sip_find_connid_by_fd: Map fd 1 to index 47
 
*May 22 11:45:42.957: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_create: created msg=0x10FCAFD0 with refCount = 1
*May 22 11:45:42.957: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_create: created msg=0x12983D4C with refCount = 1
*May 22 11:45:42.957: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_free: Freed msg=0x10FCAFD0
*May 22 11:45:42.957: //-1/xxxxxxxxxxxx/SIP/Info/info/4096/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 2 for event 1
*May 22 11:45:42.957: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x0
*May 22 11:45:42.957: //-1/xxxxxxxxxxxx/SIP/Transport/sipConnectionManagerProcessNewConnMsg: gConnTab=0x4289FCC8, addr=162.44.127.147, port=52301, local_addr=, connid=47, transport=TCP
*May 22 11:45:42.957: //-1/xxxxxxxxxxxx/SIP/Info/info/4608/sipHolderGetConnInstance: Return existing connection for port 52301 connId 47
*May 22 11:45:42.957: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
INVITE sip:00919686217788@10.193.240.10:5060 SIP/2.0

Via: SIP/2.0/TCP 162.44.127.147:5060;branch=z9hG4bK15fcac67bf58b9

From: "Mohammad Rajibul Alam Joarder" <sip:9609001415@162.44.127.147>;tag=21584151~ce33eaa0-f4b4-4530-bbec-20f8fa27ac43-91303157

To: <sip:00919686217788@10.193.240.10>

Date: Fri, 22 May 2015 11:49:49 GMT

Call-ID: a508b200-55f117dd-155a80-937f2ca2@162.44.127.147

Supported: timer,resource-priority,replaces

Min-SE:  1800

User-Agent: Cisco-CUCM9.1

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

Cisco-Guid: 2768810496-0000065536-0000000127-2474585250

Session-Expires:  1800

P-Asserted-Identity: "Mohammad Rajibul Alam Joarder" <sip:9609001415@162.44.127.147>

Remote-Party-ID: "Mohammad Rajibul Alam Joarder" <sip:9609001415@162.44.127.147>;party=calling;screen=yes;privacy=off

Contact: <sip:9609001415@162.44.127.147:5060;transport=tcp>

Max-Forwards: 70

Content-Type: application/sdp

Content-Length: 219

 

v=0

o=CiscoSystemsCCM-SIP 21584151 1 IN IP4 162.44.127.147

s=SIP Call

c=IN IP4 10.193.240.10

t=0 0

m=audio 17064 RTP/AVP 8 101

a=rtpmap:8 PCMA/8000

a=ptime:20

a=rtpmap:101 telephone-event/8000

a=fmtp:101 0-15


*May 22 11:45:42.957: //-1/xxxxxxxxxxxx/SIP/Info/verbose/4096/ccsip_new_msg_preprocessor: Checking Invite Dialog
*May 22 11:45:42.957: //-1/xxxxxxxxxxxx/SIP/Info/verbose/4096/sipSPIAddContextToTable: Added context(0x43D0C9C8) with key=[244] to table
*May 22 11:45:42.957: //-1/000000000000/SIP/Info/info/4096/ccsip_ipip_media_service_init:
*May 22 11:45:42.957: //-1/000000000000/SIP/Info/info/4096/ccsip_tdmip_media_service_init:
*May 22 11:45:42.957: //-1/000000000000/SIP/Info/verbose/36864/ccsip_ipip_media_forking_init: MF: Queue is initialised..
*May 22 11:45:42.957: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Dialog Transaction Address 162.44.127.147,Port 52301, Transport 2, SentBy Port 5060
*May 22 11:45:42.957: //-1/000000000000/SIP/Info/verbose/4608/sipSPISipIncomingMsg: copy the natted transport info to ccb natted dest: 162.44.127.147:52301,natted src: 10.193.240.10:5060, natted transport: 2
*May 22 11:45:42.957: //-1/000000000000/SIP/Info/info/1024/sipSPISipIncomingMsg:  sip via host 162.44.127.147
*May 22 11:45:42.957: //-1/000000000000/SIP/Info/info/9216/sipSPISipIncomingMsg:  sip nat auto detect 0
*May 22 11:45:42.957: //-1/xxxxxxxxxxxx/SIP/Info/info/8192/resolve_sig_ip_address_to_bind: ip_best_local_address 10.193.240.10 for SIP
*May 22 11:45:42.957: //-1/xxxxxxxxxxxx/SIP/Info/info/8192/resolve_sig_ip_address_to_bind: return addr 10.193.240.10
*May 22 11:45:42.957: //-1/A508B2000000/SIP/State/sipSPIChangeState: 0x43D0C9C8 : State change from (STATE_NONE, SUBSTATE_NONE)  to (STATE_IDLE, SUBSTATE_NONE)
*May 22 11:45:42.957: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Dialog Transaction Address 162.44.127.147,Port 52301, Transport 2, SentBy Port 5060
*May 22 11:45:42.957: //-1/xxxxxxxxxxxx/SIP/Info/verbose/8192/sipSPISetDateHeader: Clock Time Zone is UTC, same as GMT: Using GMT
*May 22 11:45:42.957: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Dialog Transaction Address 162.44.127.147,Port 52301, Transport 2, SentBy Port 5060
*May 22 11:45:42.957: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_lock: Increment msg (0x12983D4C) counter, current msg->refCount = 2
*May 22 11:45:42.957: //-1/xxxxxxxxxxxx/SIP/Error/httpish_msg_free:
 Freeing NULL pointer!
*May 22 11:45:42.957: //-1/A508B2000000/SIP/Info/verbose/4096/sipSPIAssignCcbLastRequest: Current ccb(0x43D0C9C8)->last_request = 0x12983D4C, refCount = 2
*May 22 11:45:42.957: //-1/xxxxxxxxxxxx/SIP/Info/info/2048/sipSPICheckIpip: VOIP dialpeer (peer=0x11CCC5A8) found for sip_user: 00919686217788
*May 22 11:45:42.957: //-1/A508B2000000/SIP/Info/info/2048/sipSPICheckAssertedIdConfig: Dialpeer match is not yet done
*May 22 11:45:42.957: //-1/A508B2000000/SIP/Info/info/36864/sipSPIUpdateIdentity: MF: PAI url is present & make a copy..
*May 22 11:45:42.957: //-1/A508B2000000/SIP/Info/info/4096/sipSPIUpdateIdentity: SIP->PSTN: Setting Calling Name to Mohammad Rajibul Alam Joarder
*May 22 11:45:42.957: //-1/A508B2000000/SIP/Info/info/4096/sipSPIUpdateIdentity: PAI  genUrl is present..
*May 22 11:45:42.957: //-1/A508B2000000/SIP/Info/info/4096/sipSPIUpdateIdentity: SIP->PSTN: Setting Calling Number to 9609001415
*May 22 11:45:42.957: //-1/A508B2000000/SIP/Info/info/4096/sipSPIUpdateIdentity: PAI host = 162.44.127.147
*May 22 11:45:42.957: //-1/A508B2000000/SIP/Info/info/4096/sipSPISetCallingInfo: calling host comes from From: 162.44.127.147
*May 22 11:45:42.957: //-1/A508B2000000/SIP/Info/info/2048/sipSPICheckAssertedIdConfig: Dialpeer match is not yet done
*May 22 11:45:42.957: //-1/xxxxxxxxxxxx/SIP/Info/critical/4096/sipSPIGetContentGTD: No GTD found in inbound container
*May 22 11:45:42.957: //-1/xxxxxxxxxxxx/SIP/Info/critical/4096/sipSPIGetContentCSTA: No CSTA found in inbound container
*May 22 11:45:42.957: //-1/A508B2000000/SIP/Info/verbose/4096/sipSPIUaddCcbToTable: Added to table. ccb=0x43D0C9C8 key=a508b200-55f117dd-155a80-937f2ca2@162.44.127.14700919686217788 balance 1
*May 22 11:45:42.957: //-1/A508B2000000/SIP/Info/info/8192/sipSPIMatchSrcIpGroup: Match not found on carrier id
*May 22 11:45:42.957: //-1/A508B2000000/SIP/Info/critical/8192/sipSPIMatchSrcIpGroup: Match not found on Incoming called number: 00919686217788
*May 22 11:45:42.957: //-1/A508B2000000/SIP/Info/critical/8192/sipSPIMatchSrcIpGroup: Match not found on destination pattern: 9609001415
*May 22 11:45:42.957: //-1/A508B2000000/SIP/Info/info/12288/ccsipUpdateIncomingCallParams: ccCallInfo: Calling name Mohammad Rajibul Alam Joarder, number 9609001415, Calling oct3 0x00, oct_3a 0x81, Called number 00919686217788
*May 22 11:45:42.957: //-1/A508B2000000/SIP/Info/verbose/1024/sipSPIGetViaHostInURLFormat: VIA URL:sip:162.44.127.147:5060, Host:162.44.127.147
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/verbose/67584/sipSPIGetShrlPeer: Try match incoming dialpeer for Calling number: : 9609001415
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/critical/1024/sipSPIGetFromCalledPartyId: P-Called-Party-ID header not found
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/critical/1024/sipSPIGetPeerByCalledPartyId: P-Called-Party-ID not found or parse error
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/critical/10240/sipSPIGetCallConfig: No match found for P-Called-Party-ID
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/info/1024/ccsip_validate_and_update_calling_info: PAI/PPI not configuredi for this dial-peer(5500), use RPID/FROM header data
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/verbose/32768/ccsip_ipip_media_forking_copy_prev_best_rpid: MF: This is best rpid..
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/verbose/4096/sipSPIUpdateCallingInfoUsingRpidOrFrom: Updating Calling Info with RPID header data
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/verbose/4096/sipSPISetInfoFromRpid: calling host comes from rpid 162.44.127.147
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/info/4096/sipSPISetInfoFromRpid: Received current remote name: Mohammad Rajibul Alam Joarder, current remote number: 9609001415
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/info/4096/sipSPISetInfoFromRpid: Received ;screen=yes ;privacy=off -> Setting Octet3A 0x81, extended_privacy 0x00
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/info/2048/sipSPIGetCallConfig: Peer tag 5500 matched for incoming call
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/verbose/1024/sipSPIGetCallConfig: Precondition tag absent in Require/Supported header
*May 22 11:45:42.961: //-1/xxxxxxxxxxxx/SIP/Info/info/8192/resolve_sig_ip_address_to_bind: ip_best_local_address 10.193.240.10 for SIP
*May 22 11:45:42.961: //-1/xxxxxxxxxxxx/SIP/Info/info/8192/resolve_sig_ip_address_to_bind: return addr 10.193.240.10
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/verbose/1024/sipSPIGetCallConfig: Precondition tag absent in Require/Supported header
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/verbose/2048/sipSPIGetCallConfig: Media Antitrombone disabled
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/info/8192/sipSPISetMediaFlowMode: Storing the configured mode as FLOW-THROUGH
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/info/2304/sipSPISetMediaFlowMode: xcoder high-density disabled
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/info/8192/sipSPISetMediaFlowMode: Flow Mode set to FLOW_THROUGH
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/verbose/4/update_video_params_from_config: Checking Video Type Rate=-1 video_codec_allowed=1F
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Media/sipSPICopyStunConfigFromPeerToCCB: Firewall traversal is not enabled
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/verbose/12288/sipSPIGetModemInfoPerCall: peer_callID=0
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/critical/32768/ccsip_ipip_media_forking_update_preferred_codec: MF: Not a Forked SIP leg..
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/info/8704/sipSPIGetCallConfig: Incoming: No defer BYE for last
                              call stats
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/info/8192/sipSPIGetCallConfig: Media forking disabled
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/info/34816/ccsip_ipip_media_forking_anchor_leg_config: MF: en_p->encap_s.voIP.voipPeerCfgMediaClass = 0
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/critical/34816/ccsip_ipip_media_forking_anchor_leg_config: MF: Dial-peer has no media class recorder.
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/info/36864/sipSPIMFChangeState: MF: Prev state = 0 & New state = -1
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/info/32768/ccsip_ipip_media_forking_anchor_leg_reset: MF: Anchor leg config reset done...
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/info/32768/ccsip_ipip_media_forking_intra_frame_request_config: MF: FIR en_p->encap_s.voIP.voipPeerCfgMediaClass = 0
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/critical/11264/ccsipInitDSCPPolicyInfo: No DSCP Profile configured, No RPH 2 DSCP Mapping and DSCP policing
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/verbose/8192/sipSPIGetCallConfig: Initilise the DSCP policy
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/verbose/8192/sipSPICheckFAAnatAssymetricOrDO2EO: Not a SIP-SIP call or not in FA mode
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/notify/8192/sipSPISetOverlapConfiguration: Overlap signaling: FALSE: Endpt: SIP Trunk
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/verbose/10240/sipSPI_ipip_GetHdrPassthruCfg: Hdr passthrough config:1 tag:0
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/verbose/2048/sipSPI_ipip_GetCopyListCfg: Copy-list config:2 tag:0
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/notify/10240/sipSPI_ipip_build_consolidated_header_list: Both passthru and copylist are disabled
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/info/4096/sipSPIContinueNewMsgInvite: Calling name Mohammad Rajibul Alam Joarder, number 9609001415, Calling oct3 0x00, oct_3a 0x81, ext_priv 0x00, Called number 00919686217788, oct3 0x00
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/info/4096/sipSPIContinueNewMsgInvite: Carrier id code , prev_cid NONE, next_cid NONE, prev_tgrp NONE, next_tgrp NONE
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/critical/9216/sipSPIValidateRequestUri: Not Enabled
*May 22 11:45:42.961: //-1/A508B2000000/SIP/Info/info/131072/sipSPIRscmsmAvail: Value returned by check is = 0
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/critical/8192/sipSPI_ipip_IsSDPPassthruEnabled:  - 0
*May 22 11:45:42.961: //482/A508B2000000/SIP/Event/Session-Timer/sipSTSLMain: Event: E_STSL_SESSION_REFRESH_REQ
*May 22 11:45:42.961: //482/A508B2000000/SIP/Event/Session-Timer/sipSTSLMain: dir:2, method:102, resp_code:0, container:139B43A0
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/info/8192/Session-Timer/sipSTSLExtractSessionExpiresHdr:
Session-Expires value: 1800 refresher: none
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/info/8192/Session-Timer/sipSTSLExtractMinSEHdr: Min-SE Duration: 1800
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/info/8192/Session-Timer/sipSTSLGetInternalSREvent: E_STSL_INITIAL_SR_REQ
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/verbose/8192/Session-Timer/sipSTSLInitialSRReqPeerEventGen: sending received session expires to the peer leg
*May 22 11:45:42.961: //482/A508B2000000/SIP/Event/Session-Timer/sipSTSLPrintTDContainer: Peer-Event: E_STSL_PASS_ST_PARAMS, SE Value:1800, SE Refresher:none, Min-SE Value:1800, flags:2001
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/info/8192/Session-Timer/sipSTSLMain:
 SE: 1800;refresher:none peer refresher:none, flags:2001, posted event:E_STSL_INVALID_PEER_EVENT, reason:4
 Configured SE:1800, Configured Min-SE:1800
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/critical/1024/sipSPIProcessHistoryInfoHeader: No HI headers recvd from app container
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/critical/1024/sipSPIProcessDiversionHeader: No diversion headers recvd from app container
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/critical/16384/sipSPIProcessReplacesHeader: No replaces hdr found
*May 22 11:45:42.961: //-1/xxxxxxxxxxxx/SIP/Info/verbose/1024/sipSPIGetContentCPA: No CPA found in inbound container
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/verbose/1024/sipSPIProcessCPA: No x-cisco-cpa content found
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/verbose/1/sipSPIDoMediaNegotiation: Number of m-lines = 1
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/verbose/1/sipSPIValidateConnectionAddress: Dest port = 17064
SIP: (482) Attribute mid, level 1 instance 1 not found.
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/notify/6/sipSPIValidateStreamAddrType: stream:1, Mode : 1
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/verbose/513/resolve_media_ip_address_to_bind: peer_tag=5500
*May 22 11:45:42.961: //-1/xxxxxxxxxxxx/SIP/Info/info/8192/resolve_media_ip_address_to_bind: ip_best_local_address 10.193.240.10 for SIP
*May 22 11:45:42.961: //-1/xxxxxxxxxxxx/SIP/Info/info/8192/resolve_media_ip_address_to_bind: return addr 10.193.240.10
*May 22 11:45:42.961: //482/A508B2000000/SIP/Media/sipSPISetMediaSrcAddr: Media src addr for stream 1 = 10.193.240.10
*May 22 11:45:42.961: //-1/xxxxxxxxxxxx/SIP/Info/notify/1/sipSPICheckDynPayloadUse: Dynamic payload(101) reserved for codec No Codec  
*May 22 11:45:42.961: //-1/xxxxxxxxxxxx/SIP/Info/info/1/sipSPIUpdateDynamicPayloadunused: Unreserving dynamic payload type 96
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/notify/1/sipSPIDoAudioNegotiation: Codec (g711alaw) Negotiation Successful on Static Payload for m-line 1
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/verbose/1/sipSPIDoPtimeNegotiation: One ptime attribute found - value:20
*May 22 11:45:42.961: //-1/xxxxxxxxxxxx/SIP/Info/notify/1/convert_ptime_to_codec_bytes: Values :Codec: g711alaw ptime :20, codecbytes: 160
*May 22 11:45:42.961: //-1/xxxxxxxxxxxx/SIP/Info/notify/1/convert_codec_bytes_to_ptime: Values :Codec: g711alaw codecbytes :160, ptime: 20
*May 22 11:45:42.961: //482/A508B2000000/SIP/Media/sipSPIDoPtimeNegotiation: Offered ptime:20, Negotiated ptime:20 Negotiated codec bytes: 160 for codec g711alaw
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/info/8/sipSPISetFaxFlags: FAX_PASSTHROUGH = 0, END_FAX_PASSTHROUGH = 0
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/info/1/sipSPIDoDTMFRelayNegotiation: m-line index 1
*May 22 11:45:42.961: //-1/xxxxxxxxxxxx/SIP/Info/notify/1/sipSPICheckDynPayloadUse: Dynamic payload(101) reserved for codec
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/notify/1/sipSPIReserveRtpNtePayload: Reserved the payload type 101 for RTP-NTE
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/info/32/sipSPIDoDTMFRelayNegotiation: RTP-NTE DTMF relay option
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/info/1/sipSPIDoDTMFRelayNegotiation: Case of partial named event(NE) match in fmtp list of events.
*May 22 11:45:42.961: //-1/xxxxxxxxxxxx/SIP/Info/info/8209/sip_sdp_get_modem_relay_cap_params: V150 NSE payload = 0, SSE payload = 0, SPRT payload=0
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/critical/8193/sip_select_modem_relay_params: X-tmr not present in SDP. Disable modem relay
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/info/1/sipSPIGetSDPDirectionAttribute: No direction attribute present or multiple direction attributes that can't be handled for m-line:1 and num-a-lines:0
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/notify/1/sipSPIDoAudioNegotiation: Codec negotiation successful for media line 1
 payload_type=8, codec_bytes=160, codec=g711alaw, dtmf_relay=rtp-nte
 stream_type=voice+dtmf (1), dest_ip_address=10.193.240.10, dest_port=17064
*May 22 11:45:42.961: //482/A508B2000000/SIP/State/sipSPIChangeStreamState: Stream (callid =  -1)  State changed from (STREAM_DEAD) to (STREAM_ADDING)
*May 22 11:45:42.961: //482/A508B2000000/SIP/Media/sipSPIUpdCallWithSdpInfo:
 Preferred Codec        : g711alaw, bytes :160
 Preferred  DTMF relay  : rtp-nte
 Preferred NTE payload  : 101
 Early Media            : No
 Delayed Media          : No
 Bridge Done            : No
 New Media              : No
 DSP DNLD Reqd          : No

*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/notify/6/sipSPIValidateStreamAddrType: stream:1, Mode : 1
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/verbose/513/resolve_media_ip_address_to_bind: Media already bound, use existing source_media_ip_addr
*May 22 11:45:42.961: //482/A508B2000000/SIP/Media/sipSPISetMediaSrcAddr: Media src addr for stream 1 = 10.193.240.10
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/info/4096/ccsip_offer_ans_handle_rcvd_sdp:
*May 22 11:45:42.961: //482/A508B2000000/SIP/State/ccsip_cnfsm_debugs: OA:cur_container:ccsip_offer_ans_main_container, cur_state:S_SIP_EARLY_DIALOG_IDLE, event:E_SIP_INVITE_SDP_RCVD
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/info/4096/ccsip_offer_ans_is_invite_offer_valid:  TRUE
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/info/4096/ccsip_offer_ans_common_offer_rcvd_hdlr:
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/info/4096/ccsip_iwf_handle_network_event:
*May 22 11:45:42.961: //482/A508B2000000/SIP/State/ccsip_cnfsm_debugs: IWF:cur_container:sip_iwf_default_early_dialog_container, cur_state:S_SIP_IWF_SDP_IDLE, event:E_SIP_IWF_EV_RCVD_SDP
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/info/4096/sip_iwf_def_ed_rcvd_sdp_hdlr:
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/info/1/sipSPIAssignStreamCallId: Assigning streamid 482 to stream 1. Old streamid = -1
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/info/1/sipSPI_initialize_audio_channelInfo_from_sdp: stream_callid = 482, peer_stream_callid = -1
SIP: (482) setup attribute, level 1 instance 1 not found.
SIP: (482) connection attribute, level 1 instance 1 not found.
SIP: (482) Attribute label, level 1 instance 1 not found.
SIP: (482) a=framerate attribute, level 1 instance 1 not found.
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/verbose/1025/sipSPI_initialize_audio_channelInfo_from_sdp: Populating Address in channelInfo
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/info/1/sipSPI_initialize_audio_channelInfo_from_sdp: Media dest addr for stream 1='10.193.240.10', port=17064
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/info/1/sip_iwf_sip_copy_audio_sdp_to_local_channelInfo: Processing Media line = 1; Codec = g711alaw; PType = 8
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/info/1/codec_found: Codec to be matched: g711alaw(6)
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/info/1/codec_found:  codecs[i] = 6 & codec = 6 are same..
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/verbose/1/sip_iwf_sip_copy_audio_sdp_to_local_channelInfo: Add Channel for Codec g711alaw
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/notify/1/sip_iwf_sip_copy_audio_sdp_to_local_channelInfo: Media negotiation done for m-line=1: negotiated_ptime=20, negotiated_codec_bytes=160
*May 22 11:45:42.961: //-1/xxxxxxxxxxxx/SIP/Info/notify/1/convert_codec_bytes_to_ptime: Values :Codec: g711alaw codecbytes :160, ptime: 20
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/info/1/sipSPI_ipip_update_codec_params_in_stream_channelInfo: Adding negotiated codec g711alaw ptype 8 time 20,   bytes 160 as channel 0 mline 1 ss 1
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/info/131073/sipSPIBwCacCalcAudioBandwidth: calculated audio bandwidth : codec g711alaw  bw 64000
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/info/32/sipSPI_ipip_upd_2833_dtmf_params: setting ipip_caps DTMF to RFC2833: callid = 482, dtmf = 6
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/info/1/sip_iwf_sip_copy_audio_sdp_to_local_channelInfo: Processing Media line = 1; Codec = No Codec   ; PType = 101
*May 22 11:45:42.961: //-1/xxxxxxxxxxxx/SIP/Info/notify/1/convert_codec_bytes_to_ptime: Values :Codec: g711alaw codecbytes :160, ptime: 20
*May 22 11:45:42.961: //482/A508B2000000/SIP/Media/sipSPIDisplayStreamInfo:
   Stream type            : voice+dtmf
   Media line             : 1
   State                  : STREAM_ADDING (2)
   Stream address type    : 1
   Callid                 : 482
   Peer Callid            : -1
   RTP/SRTP Negotiated     : 8
   Negotiated Codec       : g711alaw, bytes :160
   Nego. Codec payload    : 8 (tx), 8 (rx)
   Negotiated DTMF relay  : rtp-nte
   Negotiated NTE payload : 101 (tx), 101 (rx)
   Negotiated CN payload  : 0
   Media Srce Addr/Port   : [10.193.240.10]:0
   Media Dest Addr/Port   : [10.193.240.10]:17064

*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/verbose/4097/sipSPI_ipip_calculate_channel_count: Number of streams to report = 1
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/critical/1/sip_iwf_sip_copy_sdp_to_stream_channelInfo: Not updating call entry.
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/info/1/sip_iwf_def_ed_rcvd_sdp_hdlr: Setting media_direction to 0
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/info/131072/sipSPIBwCacUpdateAccountedBw: bwcac update accounted BW Option 0 flow mode flow-through
audio bw 80000 bps video bw 0 bps fax bw 0 bps total bw 80000 bps  accounted bw 0 bps
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/info/131072/sipSPIBwCacUpdateInterfaceBw: bwcac acquiring interface GigabitEthernet0/0 bw 80
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/info/131072/sipSPIBwCacUpdateAccountedBw: bwcac update accounted bw (initial offer) accounted bw set to 80000
*May 22 11:45:42.961: //482/A508B2000000/SIP/State/ccsip_cnfsm_debugs: IWF:next_state:S_SIP_IWF_SDP_RCVD_AWAIT_PEER_EVENT
*May 22 11:45:42.961: //482/A508B2000000/SIP/State/ccsip_cnfsm_debugs: OA:next_state:S_SIP_EARLY_DIALOG_OFFER_RCVD
*May 22 11:45:42.961: //482/A508B2000000/SIP/Media/sipSPIUpdCallWithSdpInfo:
   Stream type            : voice+dtmf
   Media line             : 1
   State                  : STREAM_ADDING (2)
   Stream address type    : 1
   Callid                 : 482
   Negotiated Codec       : g711alaw, bytes :160
   Nego. Codec payload    : 8 (tx), 8 (rx)
   Negotiated DTMF relay  : rtp-nte
   Negotiated NTE payload : 101 (tx), 101 (rx)
   Negotiated CN payload  : 0
   Media Srce Addr/Port   : [10.193.240.10]:0
   Media Dest Addr/Port   : [10.193.240.10]:17064

*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/notify/33/sipSPIHandleInviteMedia:
Negotiated Codec       : g711alaw, bytes :160
Preferred Codec        : g711alaw, bytes :160
Preferred  DTMF relay 1 : 6
Preferred  DTMF relay 2 : 0
Negotiated DTMF relay   : 6
Preferred and Negotiated NTE payloads: 101 101
Preferred and Negotiated NSE payloads: 100 0
Preferred and Negotiated Modem Relay: 0 0
Preferred and Negotiated V150.1 Modem Passthrough: 0 0
Preferred and Negotiated V150.1 Modem Relay: 0 0
Preferred and Negotiated Modem Relay GwXid: 1 0

*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/info/133120/sipSPIBwCacIsDialPeerBwAvailable: bwcac NOP dial-peer bw available tag 5500
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/notify/1/sipSPIBwCacIsInterfaceBwAvailable: bwcac interface bw threshold not configured
*May 22 11:45:42.961: //482/A508B2000000/SIP/Info/info/131072/sipSPIBwCacVerifyBwThreshold: bwcac verify bw threshold, bw available allow call total bw 80000 bps
*May 22 11:45:42.965: //482/A508B2000000/SIP/Info/info/131073/sipSPIDoQoSNegotiationWithMediaLine: QOS negotiation for mline_index 1
*May 22 11:45:42.965: //482/A508B2000000/SIP/Info/notify/131072/sipSPIDoStreamQoSNegotiation: Best effort
*May 22 11:45:42.965: //482/A508B2000000/SIP/Info/notify/131072/sipSPICanSetFallbackFlag: Local Fallback is not active
*May 22 11:45:42.965: //-1/xxxxxxxxxxxx/SIP/Media/sipSPIReserveRtpPort: reserved port 17066 for stream 1
*May 22 11:45:42.965: //482/A508B2000000/SIP/Info/verbose/1/sipSPIUpdateSrcSdpFixedPart: Reserving rtp port for stream 1, src_port=17066
*May 22 11:45:42.965: //-1/xxxxxxxxxxxx/SIP/Info/notify/1/sipSPISetMediaDirectionForStream: Setting Media direction SENDRECV for stream 1
*May 22 11:45:42.965: //482/A508B2000000/SIP/Info/info/1/sipSPIUpdateSrcSdpVariablePart: Setting stream 1 portnum to 17066
*May 22 11:45:42.965: //482/A508B2000000/SIP/Info/notify/1/sipSPIUpdateSrcSdpVariablePart: SIP update src sdp, negoitated codec 6, payload type 8
*May 22 11:45:42.965: //482/A508B2000000/SIP/Info/notify/32/sipSPIUpdateSrcSdpVariablePart: Negotiated method of dtmf relayand pyld: 6 101

*May 22 11:45:42.965: //482/A508B2000000/SIP/Info/verbose/32/sipSPIUpdateSrcSdpVariablePart: max_event 16
*May 22 11:45:42.965: //482/A508B2000000/SIP/Info/verbose/4096/sipSPIAddBillingInfoToCcb: sipCallId for billing records = a508b200-55f117dd-155a80-937f2ca2@162.44.127.147
*May 22 11:45:42.965: //482/A508B2000000/SIP/Info/verbose/10240/sipSPI_ipip_GetHdrPassthruCfg: Hdr passthrough config:1 tag:0
*May 22 11:45:42.965: //482/A508B2000000/SIP/Info/critical/10240/sipSPI_ipip_ExtractPassthruCopyListHdrsFromSipContainer: Unsupported header passthru is not configured and no headers are present in hdr_hash_queue
*May 22 11:45:42.965: //482/A508B2000000/SIP/Info/critical/8192/sipSPI_ipip_IsContentPassthruEnabled:  - 0
*May 22 11:45:42.965: //482/A508B2000000/SIP/Info/notify/8192/sipSPI_ipip_ExtractPassthruContentFromSipContainer: Passthru Content Not Enabled
*May 22 11:45:42.965: //482/A508B2000000/SIP/Info/critical/4096/ccsip_api_call_setup_ind: Unable to add unsupp headers to container
*May 22 11:45:42.965: //482/A508B2000000/SIP/Info/verbose/4096/sipSPICopyAuthenticationHeadersToContainer: sipAuthInfo Initialized
*May 22 11:45:42.965: //482/A508B2000000/SIP/Info/verbose/4096/sipSPICopyAuthenticationHeadersToContainer: Set Authentication Tag to Container
*May 22 11:45:42.965: //482/A508B2000000/SIP/Info/verbose/4096/ccsip_api_call_setup_ind: Set Protocol information
*May 22 11:45:42.965: //482/A508B2000000/SIP/Info/verbose/4096/ccsip_ipip_media_service_get_event_data: Event id = 27
*May 22 11:45:42.965: //482/A508B2000000/SIP/Info/info/1/ccsip_api_call_setup_ind: Setting media_direction to 0
*May 22 11:45:42.965: //482/A508B2000000/SIP/Info/verbose/4096/sipSPI_ipip_store_channel_info: Store channelInfo in CallInfo
*May 22 11:45:42.965: //482/A508B2000000/SIP/Info/verbose/32/sipSPI_ipip_store_channel_info: dtmf negotiation done, storing negotiated dtmf = 6,
*May 22 11:45:42.965: //482/A508B2000000/SIP/Info/verbose/2048/sipSPI_ipip_store_config_info: Setting mid_call_config_info = 0x0 for callid = 482
*May 22 11:45:42.965: //482/A508B2000000/SIP/Media/sipSPIDisplayStreamInfo:
   Stream type            : voice+dtmf
   Media line             : 1
   State                  : STREAM_ADDING (2)
   Stream address type    : 1
   Callid                 : 482
   Peer Callid            : -1
   RTP/SRTP Negotiated     : 8
   Negotiated Codec       : g711alaw, bytes :160
   Nego. Codec payload    : 8 (tx), 8 (rx)
   Negotiated DTMF relay  : rtp-nte
   Negotiated NTE payload : 101 (tx), 101 (rx)
   Negotiated CN payload  : 0
   Media Srce Addr/Port   : [10.193.240.10]:17066
   Media Dest Addr/Port   : [10.193.240.10]:17064

*May 22 11:45:42.965: //482/A508B2000000/SIP/Info/verbose/4097/sipSPI_ipip_calculate_channel_count: Number of streams to report = 1
*May 22 11:45:42.965: //482/A508B2000000/SIP/Info/verbose/1/sipSPI_ipip_store_channel_info: Setting CHANNEL_COUNT = 1 for callid 482
*May 22 11:45:42.965: //482/A508B2000000/SIP/Info/verbose/67584/sipSPIShrlCall: Check peer: 5500 for Shared-Line call, callid: 482
*May 22 11:45:42.965: //482/A508B2000000/SIP/Info/info/8192/ccsip_set_bearer_capability:   Bearer Capability: Speech (0x00)
*May 22 11:45:42.965: //-1/xxxxxxxxxxxx/SIP/Info/critical/4096/sipSPIGetContentQSIG: No QSIG Body found in inbound containerACK sip:00919686217788@202.84.38.24:5060 SIP/2.0

Via: SIP/2.0/UDP 202.84.43.194:5060;branch=z9hG4bK70241E

From: "Mohammad Rajibul Alam Joarder" <sip:9609001415@202.84.43.194>;tag=2E9A4A74-236

To: <sip:00919686217788@202.84.38.24>

Date: Fri, 22 May 2015 11:45:42 GMT

Call-ID: E932327E-FFAE11E4-83EC8FA4-AF1AA63@202.84.43.194

Max-Forwards: 70

CSeq: 101 ACK

Allow-Events: telephone-event

Content-Length: 0

 


*May 22 11:45:42.985: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_free: Freed msg=0x10FC3FD4
*May 22 11:45:43.245: //-1/xxxxxxxxxxxx/SIP/Transport/sip_find_connid_by_fd: Map fd 1 to index 47
 
*May 22 11:45:43.245: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_create: created msg=0x10FC0A98 with refCount = 1
*May 22 11:45:43.245: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_create: created msg=0x41F65FB8 with refCount = 1
*May 22 11:45:43.245: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_free: Freed msg=0x10FC0A98
*May 22 11:45:43.245: //-1/xxxxxxxxxxxx/SIP/Info/info/4096/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 2 for event 1
*May 22 11:45:43.249: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x0
*May 22 11:45:43.249: //-1/xxxxxxxxxxxx/SIP/Transport/sipConnectionManagerProcessNewConnMsg: gConnTab=0x4289FCC8, addr=162.44.127.147, port=52301, local_addr=, connid=47, transport=TCP
*May 22 11:45:43.249: //-1/xxxxxxxxxxxx/SIP/Info/info/4608/sipHolderGetConnInstance: Return existing connection for port 52301 connId 47
*May 22 11:45:43.249: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
ACK sip:00919686217788@10.193.240.10:5060 SIP/2.0

Via: SIP/2.0/TCP 162.44.127.147:5060;branch=z9hG4bK15fcac67bf58b9

From: "Mohammad Rajibul Alam Joarder" <sip:9609001415@162.44.127.147>;tag=21584151~ce33eaa0-f4b4-4530-bbec-20f8fa27ac43-91303157

To: <sip:00919686217788@10.193.240.10>;tag=2E9A4A78-DB7

Date: Fri, 22 May 2015 11:49:49 GMT

Call-ID: a508b200-55f117dd-155a80-937f2ca2@162.44.127.147

Max-Forwards: 70

CSeq: 101 ACK

Allow-Events: presence, kpml

Content-Length: 0

 


*May 22 11:45:43.249: //-1/xxxxxxxxxxxx/SIP/Info/verbose/4096/ccsip_new_msg_preprocessor: Checking Invite Dialog
*May 22 11:45:43.249: //482/A508B2000000/SIP/Info/verbose/4096/sipSPIFindCcbUASRespTable: *****CCB found in UAS Response table. ccb=0x43D0C9C8
*May 22 11:45:43.249: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_lock: Increment msg (0x41F65FB8) counter, current msg->refCount = 2
*May 22 11:45:43.249: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Subsq Transaction Address 162.44.127.147,Port 52301, Transport 2, SentBy Port 5060
*May 22 11:45:43.249: //-1/xxxxxxxxxxxx/SIP/Info/verbose/8192/sipSPISetDateHeader: Clock Time Zone is UTC, same as GMT: Using GMT
*May 22 11:45:43.249: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Subsq Transaction Address 162.44.127.147,Port 52301, Transport 2, SentBy Port 5060
*May 22 11:45:43.249: //482/A508B2000000/SIP/Info/info/4096/sipSPISetCallingInfo: calling host comes from From: 162.44.127.147
*May 22 11:45:43.249: //482/A508B2000000/SIP/Info/verbose/4096/sipSPIUpdateCallingInfoUsingRpidOrFrom: Updating Calling Info with FROM header data
*May 22 11:45:43.249: //482/A508B2000000/SIP/Info/info/4096/sipSPISetCommonTimer: Started generic timer type 2 for 240000 millisecs
*May 22 11:45:43.249: //482/A508B2000000/SIP/Info/verbose/8192/sipSPIDeferCallClose: Not split dataplane, bail
*May 22 11:45:43.249: //482/A508B2000000/SIP/Info/verbose/8192/sipSPIWaitForStatsBforeCallClose: Not split dataplane, bail
*May 22 11:45:43.249: //482/A508B2000000/SIP/Info/verbose/4096/sipSPICallCloseAfterFinalStat:
sipSPICallCloseAfterFinalStat:
*May 22 11:45:43.249: //482/A508B2000000/SIP/Info/info/12288/sipSPIIcpifUpdate: CallState: 2 Playout: 0 DiscTime:78186381 ConnTime 0
*May 22 11:45:43.249: //482/A508B2000000/SIP/Media/sipSPIHandleDestroyRtpSession: stream:14AFF080
*May 22 11:45:43.249: //482/A508B2000000/SIP/State/sipSPIChangeState: 0x43D0C9C8 : State change from (STATE_DISCONNECTING, SUBSTATE_NONE)  to (STATE_DEAD, SUBSTATE_NONE)
*May 22 11:45:43.249: //482/A508B2000000/SIP/Call/sipSPICallInfo:
The Call Setup Information is:
Call Control Block (CCB) : 0x0x43D0C9C8
State of The Call        : STATE_DEAD
TCP Sockets Used         : YES
Calling Number           : 9609001415
Called Number            : 00919686217788
Source IP Address (Sig  ): 10.193.240.10
Destn SIP Req Addr:Port  : 162.44.127.147:5060
Destn SIP Resp Addr:Port : 162.44.127.147:52301
Destination Name         : 162.44.127.147

*May 22 11:45:43.249: //482/A508B2000000/SIP/Call/sipSPIMediaCallInfo:
Number of Media Streams: 1
Media Stream             : 1
Negotiated Codec         : g711alaw
Negotiated Codec Bytes   : 160
Nego. Codec payload      : 8 (tx), 8 (rx)
Negotiated Dtmf-relay    : 6
Dtmf-relay Payload       : 101 (tx), 101 (rx)
Source IP Address (Media): 10.193.240.10
Source IP Port    (Media): 17066
Destn  IP Address (Media): 10.193.240.10
Destn  IP Port    (Media): 17064
Orig Destn IP Address:Port (Media): [ - ]:0

*May 22 11:45:43.249: //482/A508B2000000/SIP/Call/sipSPICallInfo:
Disconnect Cause (CC)    : 16
Disconnect Cause (SIP)   : 407

*May 22 11:45:43.249: //482/A508B2000000/SIP/Info/verbose/4096/sipSPIUdeleteccCallIdFromTable: Removing call id 1E2
*May 22 11:45:43.249: //-1/xxxxxxxxxxxx/SIP/Info/verbose/4096/sipSPIDeleteContextFromTable: Context for key=[244] removed.
*May 22 11:45:43.249: //482/A508B2000000/SIP/Info/info/4096/sipSPIStopCommonTimer: Stopping Generic Timer 2
*May 22 11:45:43.249: //482/A508B2000000/SIP/Info/verbose/4096/sipSPIUdeleteCcbFromTable: Deleting from table. ccb=0x43D0C9C8 key=a508b200-55f117dd-155a80-937f2ca2@162.44.127.14700919686217788
*May 22 11:45:43.249: //482/A508B2000000/SIP/Info/verbose/4096/sipSPIUdeleteCcbFromTable: Deleting from table. ccb=0x43D0C9C8 key=a508b200-55f117dd-155a80-937f2ca2@162.44.127.1472E9A4A78-DB7
*May 22 11:45:43.249: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_free: Decrement msg (0x12983D4C) counter, current msg->refCount = 1
*May 22 11:45:43.249: //482/A508B2000000/SIP/Info/verbose/4096/sipSPIFlushEventBufferQueue: There are 0 events on the internal queue that are going to be free'd
*May 22 11:45:43.249: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_free: Decrement msg (0x41F65FB8) counter, current msg->refCount = 1
*May 22 11:45:43.249: //-1/xxxxxxxxxxxx/SIP/Transport/sipConnectionManagerUnregisterCtxtInConnection: gConnTab=0x4289FCC8, addr=162.44.127.147, port=52301, local_addr=, unregistering context=0x43D0C9C8
*May 22 11:45:43.249: //482/A508B2000000/SIP/Transport/sipSPITransportContextCleanup: Could not purge context gcb=0x43D0C9C8 from the connection; gcb might be locked
*May 22 11:45:43.249: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_free: Freed msg=0x12983D4C
*May 22 11:45:43.249: //482/A508B2000000/SIP/Info/verbose/1/sipSPI_ipip_free_codec_profile: Codec Profiles Freed
*May 22 11:45:43.249: //482/A508B2000000/SIP/Info/info/8192/sipSPIStopOverlapInfoTimer: Stopping Overlap Info Timer
*May 22 11:45:43.249: //482/A508B2000000/SIP/Info/info/133120/sipSPIBwCacReleaseDialPeerBw: bwcac dial-peer bw 80 Kbps released for tag 5500 active bw 0 Kbps
*May 22 11:45:43.249: //482/A508B2000000/SIP/Info/info/131072/sipSPIBwCacReleaseInterfaceBw: bwcac releasing interface GigabitEthernet0/0 bw 80 Kbps
*May 22 11:45:43.249: //482/A508B2000000/SIP/Info/info/131072/sipSPIBwCacReleaseAccountedBw: bwcac released accounted  bw 80000 bps
*May 22 11:45:43.249: //482/A508B2000000/SIP/Info/verbose/4096/sipSPIUfreeOneCCB: Freeing ccb 0x43D0C9C8
*May 22 11:45:43.249: //-1/xxxxxxxxxxxx/SIP/Info/verbose/4096/sipSPIGetContextFromTable: NO context for key[244]
*May 22 11:45:43.249: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_free: Freed msg=0x41F65FB8
bddhavoip#
bddhavoip#unde
bddhavoip#undebug all
All possible debugging has been turned off

 

Dspfarm Profile Configuration

 Profile ID = 1, Service = TRANSCODING, Resource ID = 1
 Profile Description : ** Dhaka Transcoding **
 Profile Service Mode : Non Secure
 Profile Admin State : UP
 Profile Operation State : ACTIVE
 Application : SCCP   Status : ASSOCIATED
 Resource Provider : FLEX_DSPRM   Status : UP
 Number of Resource Configured : 5
 Number of Resources Out of Service : 0
 Codec Configuration: num_of_codecs:6
 Codec : g729br8, Maximum Packetization Period : 60
 Codec : g729r8, Maximum Packetization Period : 60
 Codec : g711ulaw, Maximum Packetization Period : 30
 Codec : g711alaw, Maximum Packetization Period : 30
 Codec : g729ar8, Maximum Packetization Period : 60
 Codec : g729abr8, Maximum Packetization Period : 60
Dspfarm Profile Configuration

 Profile ID = 2, Service = CONFERENCING, Resource ID = 2
 Profile Description : ** Dhaka conference **
 Profile Service Mode : Non Secure
 Profile Admin State : UP
 Profile Operation State : ACTIVE
 Application : SCCP   Status : ASSOCIATED
 Resource Provider : FLEX_DSPRM   Status : UP
 Number of Resource Configured : 4
 Number of Resources Out of Service : 0
 Maximum conference participants : 8
 Codec Configuration: num_of_codecs:6
 Codec : g729br8, Maximum Packetization Period : 60 , Transcoder: Not Required
 Codec : g729r8, Maximum Packetization Period : 60 , Transcoder: Not Required
 Codec : g729abr8, Maximum Packetization Period : 60 , Transcoder: Not Required
 Codec : g729ar8, Maximum Packetization Period : 60 , Transcoder: Not Required
 Codec : g711alaw, Maximum Packetization Period : 30 , Transcoder: Not Required
 Codec : g711ulaw, Maximum Packetization Period : 30 , Transcoder: Not Required
Dspfarm Profile Configuration

 Profile ID = 3, Service = MTP, Resource ID = 3
 Profile Description :
 Profile Service Mode : Non Secure
 Profile Admin State : UP
 Profile Operation State : ACTIVE
 Application : SCCP   Status : ASSOCIATED
 Resource Provider : FLEX_DSPRM   Status : UP
 Number of Resource Configured : 70
 Number of Resources Out of Service : 0
 Hardware Configured Resources : 70
 Hardware Available Resources : 70
 Software Resources : 0
 Codec Configuration: num_of_codecs:2
 Codec : pass-through, Maximum Packetization Period : 0
 Codec : g711ulaw, Maximum Packetization Period : 30

 

 

Provider was saying that, they are not receiving the SIP Invite from us.

 

Selva

Selva,

 

These debugs look different from the earlier.

Incoming dial peer used is 5500, which is not there in the show run of the router that you shared earlier. I beleive, you have another router setup the same way and using redundancy.

 Calling Number=9609001415,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),
   Called Number=00919686217788(TON=Unknown, NPI=Unknown),
   Calling Translated=FALSE, Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE,
   Incoming Dial-peer=5500, Progress Indication=NULL(0), Calling IE Present=TRUE,
   
Then it uses outbound Dial peer 6600, which is also not there, hence the call disconnects.
Outgoing Dial-peer=6600, Params=0x10FE1B24, Progress Indication=NULL(0) with cause value 47 (resource issue).

Then it tries to use Dial peer 2000 but then the call fails.
 Outgoing Dial-peer=2000, Params=0x10FE3094, Progress Indication=NULL(0)
 
Also the calling number is 9609001415. In the previous debugs, it was 09609001415

Are you collecting both the debug simultaneously, because this is what I want you to do? Run the debugs, then recreate the issue, then un all.

Also do you have multiple gateways for the call to go out?

Try using the hardware transcoder in the MRGL of the SIP trunk.

Regards,
Ronak Agarwal

I have resolved this issue. after i have added the below commanand issue got sorted.

 

sip-ua

nat symmetric check-media-src

no remote-party-id

retry invite 4

retry response 3

retry bye 2

retry cancel 2

retry register 5

timers register 250

registrar ipv4:X.X.X.X expires 3600

sip-server ipv4:X.X.X.X:5060

connection-reuse

 

Selva

Glad to see that the issue is resolved!!

 

Regards,

Ronak Agarwal

Hi,

 

Could any one help me on how to configure SRST and SRST Fallback in CUBE Router.

Dear Selva,

Where you added the above commands ,

In ISP CUBE router or local Voice gateway ?

 

Local Voice gateway.