cancel
Showing results for 
Search instead for 
Did you mean: 
cancel
3422
Views
1
Helpful
15
Replies

Having issues with DTMF transfer on UC520 configured with SIP Trunk.

lukekrouse
Level 1
Level 1

All,

I am having an issue with my dtmf not recognizing when a number is pressed on a phone. We have the ability to transfer phone calls to our operator if the recipient presses 1. However, when the recipient presses 1 the call is not transferred and eventually the call is dropped. I have turned on debugging for voip ccapi inout ; ccsip messages ; and voip ftp session named-event. I have attached the debug logs. Any help would be greatly appreciated.

UC520#
329272: *Aug 25 01:24:24.418: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
INVITE sip:915558091234@192.168.0.2:5060 SIP/2.0
From: MyTest<sip:5551234567@127.0.0.1>;tag=b4473b8-0-13c4-50022-699f9-6e1c0fd3-699f9
To: <sip:915558091234@192.168.0.2>
Call-ID: 2798949081-0b4d6028-0b457e48-00000145@192.168.0.122
CSeq: 1 INVITE
Via: SIP/2.0/UDP 192.168.0.122:5060;branch=z9hG4bK-699f9-19c975c9-bd6d60
x-sid: d42ac1ec1a30ee8f0eb22f194f92a4ad
x-voxeo-aom: true
Max-Forwards: 70
User-Agent: VCS9.0.41716.0
Contact: <sip:5551234567@192.168.0.122:5060>
Content-Type: application/sdp
Content-Length: 282

v=0
o=- 432590925948 432590925948 IN IP4 127.0.0.1
s=voxeo
c=IN IP4 192.168.0.122
t=0 0
m=audio 10002 RTP/AVP 0 8 3 112 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:3 GSM/8000
a=rtpmap:112 L16/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:20

329273: *Aug 25 01:24:24.422: //47958/xxxxxxxxxxxx/CCAPI/cc_api_caps_ind:
   Call Entry Is Not Found
329274: *Aug 25 01:24:24.422: //-1/546501659166/CCAPI/cc_api_display_ie_subfields:
   cc_api_call_setup_ind_common:
   cisco-username=5551234567
   ----- ccCallInfo IE subfields -----
   cisco-ani=5551234567
   cisco-anitype=0
   cisco-aniplan=0
   cisco-anipi=0
   cisco-anisi=0
   dest=ABCD915558091234
   cisco-desttype=0
   cisco-destplan=0
   cisco-rdie=FFFFFFFF
   cisco-rdn=
   cisco-lastrdn=
   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

329275: *Aug 25 01:24:24.426: //-1/546501659166/CCAPI/cc_api_call_setup_ind_common:
   Interface=0x85FBBD18, Call Info(
   Calling Number=5551234567,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=ABCD915558091234(TON=Unknown, NPI=Unknown),
   Calling Translated=FALSE, Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE,
   Incoming Dial-peer=1003, Progress Indication=NULL(0), Calling IE Present=TRUE,
   Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=47958
329276: *Aug 25 01:24:24.426: //-1/546501659166/CCAPI/ccCheckClipClir:
   In: Calling Number=5551234567(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
329277: *Aug 25 01:24:24.426: //-1/546501659166/CCAPI/ccCheckClipClir:
   Out: Calling Number=5551234567(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
329278: *Aug 25 01:24:24.426: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

329279: *Aug 25 01:24:24.426: :cc_get_feature_vsa malloc success
329280: *Aug 25 01:24:24.426: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

329281: *Aug 25 01:24:24.426:  cc_get_feature_vsa count is 3
329282: *Aug 25 01:24:24.426: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

329283: *Aug 25 01:24:24.426: :FEATURE_VSA attributes are: feature_name:0,feature_time:2297170352,feature_id:54256
329284: *Aug 25 01:24:24.426: //47958/546501659166/CCAPI/cc_api_call_setup_ind_common:
   Set Up Event Sent;
   Call Info(Calling Number=5551234567(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=ABCD915558091234(TON=Unknown, NPI=Unknown))
329285: *Aug 25 01:24:24.426: //-1/xxxxxxxxxxxx/CCAPI/cc_build_feature_vsa:

329286: *Aug 25 01:24:24.426: :Inside cc_build_feature_vsa
329287: *Aug 25 01:24:24.426: //-1/xxxxxxxxxxxx/CCAPI/cc_build_feature_vsa:

329288: *Aug 25 01:24:24.426:  feature call basic
329289: *Aug 25 01:24:24.426: //-1/xxxxxxxxxxxx/CCAPI/cc_build_feature_vsa:

329290: *Aug 25 01:24:24.426: cc_build_feature_vsa attr is fn:TWC,ft:08/24/2010

20:24:24.426,cgn:5551234567,cdn:ABCD915558091234,frs:0,fid:54256,fcid:54650165AF1E11DF91668E74D60711A1,legID:BB56
329291: *Aug 25 01:24:24.430: //47958/546501659166/CCAPI/cc_process_call_setup_ind:
   Event=0x8675A2A0
329292: *Aug 25 01:24:24.430: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search:
   Try with the demoted called number ABCD915558091234
329293: *Aug 25 01:24:24.430: //47958/546501659166/CCAPI/ccCallSetContext:
   Context=0x88EF6FAC
329294: *Aug 25 01:24:24.430: //47958/546501659166/CCAPI/cc_process_call_setup_ind:
   >>>>CCAPI handed cid 47958 with tag 1003 to app "_ManagedAppProcess_Default"
329295: *Aug 25 01:24:24.430: //47958/546501659166/CCAPI/ccCallProceeding:
   Progress Indication=NULL(0)
329296: *Aug 25 01:24:24.434: //47958/546501659166/CCAPI/ccCallSetupRequest:
   Destination=, Calling IE Present=TRUE, Mode=0,
   Outgoing Dial-peer=1027, Params=0x88EEB1AC, Progress Indication=NULL(0)
329297: *Aug 25 01:24:24.434: //47958/546501659166/CCAPI/ccCheckClipClir:
   In: Calling Number=5551234567(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
329298: *Aug 25 01:24:24.434: //47958/546501659166/CCAPI/ccCheckClipClir:
   Out: Calling Number=5551234567(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
329299: *Aug 25 01:24:24.434: //47958/546501659166/CCAPI/ccCallSetupRequest:
   Destination Pattern=[7,9]1[2-9]..[2-9]......, Called Number=1XXXXXXXXXX, Digit Strip=FALSE
329300: *Aug 25 01:24:24.434: //47958/546501659166/CCAPI/ccCallSetupRequest:
   Calling Number=5551234567(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=1XXXXXXXXXX(TON=Unknown, NPI=Unknown),
   Redirect Number=, Display Info=MyTest
   Account Number=5551234567, Final Destination Flag=TRUE,
   Guid=54650165-AF1E-11DF-9166-8E74D60711A1, Outgoing Dial-peer=1027
329301: *Aug 25 01:24:24.434: //47958/546501659166/CCAPI/cc_api_display_ie_subfields:
   ccCallSetupRequest:
   cisco-username=5551234567
   ----- ccCallInfo IE subfields -----
   cisco-ani=5551234567
   cisco-anitype=0
   cisco-aniplan=0
   cisco-anipi=0
   cisco-anisi=0
   dest=1XXXXXXXXXX
   cisco-desttype=0
   cisco-destplan=0
   cisco-rdie=FFFFFFFF
   cisco-rdn=
   cisco-lastrdn=
   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

329302: *Aug 25 01:24:24.434: //47958/546501659166/CCAPI/ccIFCallSetupRequestPrivate:
   Interface=0x85FBBD18, Interface Type=3, Destination=, Mode=0x0,
   Call Params(Calling Number=5551234567,(Calling Name=MyTest)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=1XXXXXXXXXX(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,
   Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE, Outgoing Dial-peer=1027, Call Count On=FALSE,
   Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)
329303: *Aug 25 01:24:24.438: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

329304: *Aug 25 01:24:24.438: :cc_get_feature_vsa malloc success
329305: *Aug 25 01:24:24.438: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

329306: *Aug 25 01:24:24.438:  cc_get_feature_vsa count is 4
329307: *Aug 25 01:24:24.438: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

329308: *Aug 25 01:24:24.438: :FEATURE_VSA attributes are: feature_name:0,feature_time:2297175056,feature_id:54257
329309: *Aug 25 01:24:24.438: //47959/546501659166/CCAPI/ccIFCallSetupRequestPrivate:
   SPI Call Setup Request Is Success; Interface Type=3, FlowMode=1
329310: *Aug 25 01:24:24.438: //47959/546501659166/CCAPI/ccCallSetContext:
   Context=0x88EEB15C
329311: *Aug 25 01:24:24.438: //47958/546501659166/CCAPI/ccSaveDialpeerTag:
   Outgoing Dial-peer=1027
329312: *Aug 25 01:24:24.438: //47959/546501659166/CCAPI/cc_api_call_proceeding:
   Interface=0x85FBBD18, Progress Indication=NULL(0)
329313: *Aug 25 01:24:24.442: //-1/xxxxxxxxxxxx/CCAPI/cc_build_feature_vsa:

329314: *Aug 25 01:24:24.442: :Inside cc_build_feature_vsa
329315: *Aug 25 01:24:24.442: //-1/xxxxxxxxxxxx/CCAPI/cc_build_feature_vsa:

329316: *Aug 25 01:24:24.442:  feature call basic
329317: *Aug 25 01:24:24.442: //-1/xxxxxxxxxxxx/CCAPI/cc_build_feature_vsa:

329318: *Aug 25 01:24:24.442: cc_build_feature_vsa attr is fn:TWC,ft:08/24/2010

20:24:24.438,cgn:5551234567,cdn:1XXXXXXXXXX,frs:0,fid:54257,fcid:54650165AF1E11DF91668E74D60711A1,legID:BB57
329319: *Aug 25 01:24:24.446: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 100 Trying
Date: Wed, 25 Aug 2010 01:24:24 GMT
From: MyTest<sip:5551234567@127.0.0.1>;tag=b4473b8-0-13c4-50022-699f9-6e1c0fd3-699f9
Allow-Events: telephone-event
Content-Length: 0
To: <sip:915558091234@192.168.0.2>
Call-ID: 2798949081-0b4d6028-0b457e48-00000145@192.168.0.122
Via: SIP/2.0/UDP 192.168.0.122:5060;branch=z9hG4bK-699f9-19c975c9-bd6d60
CSeq: 1 INVITE
Server: Cisco-SIPGateway/IOS-12.x


329320: *Aug 25 01:24:24.450: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
INVITE sip:1XXXXXXXXXX@sipconnect.dal0.cbeyond.net:5060 SIP/2.0
Date: Wed, 25 Aug 2010 01:24:24 GMT
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER
From: "MyTest" <sip:5551234567@sipconnect.dal0.cbeyond.net>;tag=5D0E3984-1CCB
Allow-Events: telephone-event
Supported: 100rel,timer,resource-priority,replaces,sdp-anat
Min-SE:  1800
Cisco-Guid: 1415905637-2937983455-2439417460-3590787489
Timestamp: 1282699464
Content-Length: 244
User-Agent: Cisco-SIPGateway/IOS-12.x
To: <sip:1XXXXXXXXXX@sipconnect.dal0.cbeyond.net>
Contact: <sip:5551234567@192.168.0.2:5060>
Expires: 180
Content-Disposition: session;handling=required
Content-Type: application/sdp
Call-ID: 54680EC6-AF1E11DF-916C8E74-D60711A1@sipconnect.dal0.cbeyond.net
Via: SIP/2.0/UDP 192.168.0.2:5060;branch=z9hG4bK8D36A1F
CSeq: 101 INVITE
Max-Forwards: 69

v=0
o=CiscoSystemsSIP-GW-UserAgent 6174 8806 IN IP4 192.168.0.2
s=SIP Call
c=IN IP4 192.168.0.2
t=0 0
m=audio 16596 RTP/AVP 0 101
c=IN IP4 192.168.0.2
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:20

329321: *Aug 25 01:24:24.502: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 401 Unauthorized
Via:SIP/2.0/UDP 192.168.0.2:5060;branch=z9hG4bK8D36A1F
From:"MyTest"<sip:5551234567@sipconnect.dal0.cbeyond.net>;tag=5D0E3984-1CCB
To:<sip:1XXXXXXXXXX@sipconnect.dal0.cbeyond.net>;tag=1109735805-1282699203431
Call-ID:54680EC6-AF1E11DF-916C8E74-D60711A1@sipconnect.dal0.cbeyond.net
CSeq:101 INVITE
WWW-Authenticate:DIGEST qop="auth",nonce="BroadWorksXgd9hzjonT6dyj2BW",algorithm=MD5,realm="BroadWorks"
Content-Length:0


329322: *Aug 25 01:24:24.506: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
ACK sip:1XXXXXXXXXX@sipconnect.dal0.cbeyond.net:5060 SIP/2.0
Date: Wed, 25 Aug 2010 01:24:24 GMT
From: "MyTest" <sip:5551234567@sipconnect.dal0.cbeyond.net>;tag=5D0E3984-1CCB
Allow-Events: telephone-event
Content-Length: 0
To: <sip:1XXXXXXXXXX@sipconnect.dal0.cbeyond.net>;tag=1109735805-1282699203431
Call-ID: 54680EC6-AF1E11DF-916C8E74-D60711A1@sipconnect.dal0.cbeyond.net
Via: SIP/2.0/UDP 192.168.0.2:5060;branch=z9hG4bK8D36A1F
CSeq: 101 ACK
Max-Forwards: 70


329323: *Aug 25 01:24:24.506: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
INVITE sip:1XXXXXXXXXX@sipconnect.dal0.cbeyond.net:5060 SIP/2.0
Date: Wed, 25 Aug 2010 01:24:24 GMT
Authorization: Digest

username="5551234567",realm="BroadWorks",uri="sip:1XXXXXXXXXX@sipconnect.dal0.cbeyond.net:5060",response="ed07fd5f574561091d4e95cb42f84b02",nonce="Broad

WorksXgd9hzjonT6dyj2BW",cnonce="BE20888B",qop=auth,algorithm=MD5,nc=00000001
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER
From: "MyTest" <sip:5551234567@sipconnect.dal0.cbeyond.net>;tag=5D0E3984-1CCB
Allow-Events: telephone-event
Supported: 100rel,timer,resource-priority,replaces,sdp-anat
Min-SE:  1800
Cisco-Guid: 1415905637-2937983455-2439417460-3590787489
Timestamp: 1282699464
Content-Length: 244
User-Agent: Cisco-SIPGateway/IOS-12.x
To: <sip:1XXXXXXXXXX@sipconnect.dal0.cbeyond.net>
Contact: <sip:5551234567@192.168.0.2:5060>
Expires: 180
Content-Disposition: session;handling=required
Content-Type: application/sdp
Call-ID: 54680EC6-AF1E11DF-916C8E74-D60711A1@sipconnect.dal0.cbeyond.net
Via: SIP/2.0/UDP 192.168.0.2:5060;branch=z9hG4bK8D371580
CSeq: 102 INVITE
Max-Forwards: 69

v=0
o=CiscoSystemsSIP-GW-UserAgent 6174 8806 IN IP4 192.168.0.2
s=SIP Call
c=IN IP4 192.168.0.2
t=0 0
m=audio 16596 RTP/AVP 0 101
c=IN IP4 192.168.0.2
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:20

329324: *Aug 25 01:24:24.558: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 100 Trying
Via:SIP/2.0/UDP 192.168.0.2:5060;branch=z9hG4bK8D371580
From:"MyTest"<sip:5551234567@sipconnect.dal0.cbeyond.net>;tag=5D0E3984-1CCB
To:<sip:1XXXXXXXXXX@sipconnect.dal0.cbeyond.net>
Call-ID:54680EC6-AF1E11DF-916C8E74-D60711A1@sipconnect.dal0.cbeyond.net
CSeq:102 INVITE
Content-Length:0


329325: *Aug 25 01:24:27.011: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 180 Ringing
Via:SIP/2.0/UDP 192.168.0.2:5060;branch=z9hG4bK8D371580
From:"MyTest"<sip:5551234567@sipconnect.dal0.cbeyond.net>;tag=5D0E3984-1CCB
To:<sip:1XXXXXXXXXX@sipconnect.dal0.cbeyond.net>;tag=599900672-1282699205943
Call-ID:54680EC6-AF1E11DF-916C8E74-D60711A1@sipconnect.dal0.cbeyond.net
CSeq:102 INVITE
Allow:ACK,BYE,CANCEL,INFO,INVITE,OPTIONS,PRACK,REFER,NOTIFY
Supported:
Contact:<sip:bwas1-vir.atl0.cbeyond.net>
Content-Type:application/sdp
Content-Length:362

v=0
o=BroadWorks 202540560 1 IN IP4 192.168.44.145
s=-
c=IN IP4 192.168.44.145
t=0 0
m=audio 19206 RTP/AVP 0 101 100
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=rtpmap:100 X-NSE/8000
a=fmtp:100 192-194,200-202
a=sqn:0
a=cdsc: 1 audio RTP/AVP 100
a=cpar: a=rtpmap:100 X-NSE/8000
a=cpar: a=fmtp:100 192-194,200-202
a=cdsc: 2 image udptl t38

329326: *Aug 25 01:24:27.011: //47959/546501659166/CCAPI/cc_api_caps_ind:
   Destination Interface=0x0, Destination Call Id=-1, Source Call Id=47959,
   Caps(Codec=0x1, Fax Rate=0x2, Vad=0x2,
   Modem=0x0, Codec Bytes=20, Signal Type=2)
329327: *Aug 25 01:24:27.015: //47959/546501659166/CCAPI/cc_api_caps_ind:
   Caps(Playout Mode=1, Playout Initial=60(ms), Playout Min=40(ms),
   Playout Max=1000(ms), Fax Nom=300(ms))
329328: *Aug 25 01:24:27.015: //47958/546501659166/CCAPI/cc_api_caps_ack:
   Destination Interface=0x0, Destination Call Id=-1, Source Call Id=47958,
   Caps(Codec=g711ulaw(0x1), Fax Rate=FAX_RATE_VOICE(0x2), Vad=OFF(0x1),
   Modem=OFF(0x0), Codec Bytes=160, Signal Type=2, Seq Num Start=1)
329329: *Aug 25 01:24:27.015: //47959/546501659166/CCAPI/cc_api_event_indication:
   Event=155, Call Id=47959
329330: *Aug 25 01:24:27.015: //47959/546501659166/CCAPI/cc_api_event_indication:
   Event Is Sent To Conferenced SPI(s) Directly
329331: *Aug 25 01:24:27.015: //47959/546501659166/CCAPI/cc_api_call_alert:
   Interface=0x85FBBD18, Progress Indication=INBAND(8), Signal Indication=SIGNAL RINGBACK(1)
329332: *Aug 25 01:24:27.015: //47959/546501659166/CCAPI/cc_api_call_alert:
   Call Entry(Retry Count=0, Responsed=TRUE)
329333: *Aug 25 01:24:27.015: //47958/546501659166/CCAPI/ccCallAlert:
   Progress Indication=INBAND(8), Signal Indication=SIGNAL RINGBACK(1)
329334: *Aug 25 01:24:27.015: //47958/546501659166/CCAPI/ccCallAlert:
   Call Entry(Responsed=TRUE, Alert Sent=TRUE)
329335: *Aug 25 01:24:27.015: //47958/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:
   (confID=0x8902B884, callID1=0xBB56, callID2=0xBB57, tag=0x0)
329336: *Aug 25 01:24:27.015: //47958/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:
   (confID=0x8902B884, callID1=0xBB56, gcid=54659D8D-AF1E11DF-91698E74-D60711A1, tag=0x0)
329337: *Aug 25 01:24:27.015: //47959/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:
   (confID=0x8902B884, callID2=0xBB57, gcid=54659D8D-AF1E11DF-91698E74-D60711A1, tag=0x0)
329338: *Aug 25 01:24:27.015: //47958/546501659166/CCAPI/ccConferenceCreate:
   Conference Id=0x8902B884, Call Id1=47958, Call Id2=47959, Tag=0x0
329339: *Aug 25 01:24:27.015: //47958/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:

329340: *Aug 25 01:24:27.015: ccConferenceCreate: ret1=0, codecMask1=1, bytes1=160, negot1=1, dtmf1=8
                    ret2=0, codecMask2=1, bytes2=160, negot2=1, dtmf2=6,
                    tx_dynamic_pt1=0, rx_dynamic_pt1=0, codec_mode1=0, params_bitmap1 =0
                    tx_dynamic_pt2=0, rx_dynamic_pt2=0, codec_mode2=0, params_bitmap2 =0
329341: *Aug 25 01:24:27.015: //47958/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:
   delay media to slow start case, codec negotation is not done
329342: *Aug 25 01:24:27.015: //47958/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

329343: *Aug 25 01:24:27.015: cc_api_get_xcode_stream : 4534
329344: *Aug 25 01:24:27.015: //47958/xxxxxxxxxxxx/CCAPI/cc_api_bridge_done:
   Conference Id=0x1827, Source Interface=0x85FBBD18, Source Call Id=47958,
   Destination Call Id=47959, Disposition=0x0, Tag=0x0
329345: *Aug 25 01:24:27.019: //47959/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

329346: *Aug 25 01:24:27.019: cc_api_get_xcode_stream : 4534
329347: *Aug 25 01:24:27.019: //47959/xxxxxxxxxxxx/CCAPI/cc_api_bridge_done:
   Conference Id=0x1827, Source Interface=0x85FBBD18, Source Call Id=47959,
   Destination Call Id=47958, Disposition=0x0, Tag=0x0
329348: *Aug 25 01:24:27.019: //47958/546501659166/CCAPI/cc_generic_bridge_done:
   Conference Id=0x1827, Source Interface=0x85FBBD18, Source Call Id=47959,
   Destination Call Id=47958, Disposition=0x0, Tag=0x0
329349: *Aug 25 01:24:27.019: //47958/546501659166/CCAPI/ccConferenceCreate:
   Call Entry(Conference Id=0x1827, Destination Call Id=47959)
329350: *Aug 25 01:24:27.019: //47959/546501659166/CCAPI/ccConferenceCreate:
   Call Entry(Conference Id=0x1827, Destination Call Id=47958)
329351: *Aug 25 01:24:27.019: //47958/546501659166/CCAPI/cc_process_notify_bridge_done:
   Conference Id=0x1827, Call Id1=47958, Call Id2=47959
329352: *Aug 25 01:24:27.023: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 183 Session Progress
Date: Wed, 25 Aug 2010 01:24:24 GMT
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER
From: MyTest<sip:5551234567@127.0.0.1>;tag=b4473b8-0-13c4-50022-699f9-6e1c0fd3-699f9
Allow-Events: telephone-event
Supported: sdp-anat
Content-Length: 186
To: <sip:915558091234@192.168.0.2>;tag=5D0E4390-1BAF
Contact: <sip:915558091234@192.168.0.2:5060>
Content-Disposition: session;handling=required
Content-Type: application/sdp
Call-ID: 2798949081-0b4d6028-0b457e48-00000145@192.168.0.122
Via: SIP/2.0/UDP 192.168.0.122:5060;branch=z9hG4bK-699f9-19c975c9-bd6d60
CSeq: 1 INVITE
Server: Cisco-SIPGateway/IOS-12.x

v=0
o=CiscoSystemsSIP-GW-UserAgent 2277 96 IN IP4 192.168.0.2
s=SIP Call
c=IN IP4 192.168.0.2
t=0 0
m=audio 19560 RTP/AVP 0
c=IN IP4 192.168.0.2
a=rtpmap:0 PCMU/8000
a=ptime:20

329353: *Aug 25 01:24:45.159: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 200 OK
Via:SIP/2.0/UDP 192.168.0.2:5060;branch=z9hG4bK8D371580
From:"MyTest"<sip:5551234567@sipconnect.dal0.cbeyond.net>;tag=5D0E3984-1CCB
To:<sip:1XXXXXXXXXX@sipconnect.dal0.cbeyond.net>;tag=599900672-1282699205943
Call-ID:54680EC6-AF1E11DF-916C8E74-D60711A1@sipconnect.dal0.cbeyond.net
CSeq:102 INVITE
Supported:
Contact:<sip:bwas1-vir.atl0.cbeyond.net>
Allow:ACK,BYE,CANCEL,INFO,INVITE,OPTIONS,PRACK,REFER,NOTIFY,UPDATE
Accept:multipart/mixed,application/media_control+xml,application/sdp
Content-Type:application/sdp
Content-Length:362

v=0
o=BroadWorks 202540560 1 IN IP4 192.168.44.145
s=-
c=IN IP4 192.168.44.145
t=0 0
m=audio 19206 RTP/AVP 0 101 100
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=rtpmap:100 X-NSE/8000
a=fmtp:100 192-194,200-202
a=sqn:0
a=cdsc: 1 audio RTP/AVP 100
a=cpar: a=rtpmap:100 X-NSE/8000
a=cpar: a=fmtp:100 192-194,200-202
a=cdsc: 2 image udptl t38

329354: *Aug 25 01:24:45.163: //47959/546501659166/CCAPI/cc_api_call_connected:
   Interface=0x85FBBD18, Data Bitmask=0x1, Progress Indication=NULL(0),
   Connection Handle=0
329355: *Aug 25 01:24:45.163: //47959/546501659166/CCAPI/cc_api_call_connected:
   Call Entry(Connected=TRUE, Responsed=TRUE, Retry Count=0)
329356: *Aug 25 01:24:45.167: //47958/546501659166/CCAPI/ccCallConnect:
   Progress Indication=NULL(0), Data Bitmask=0x1
329357: *Aug 25 01:24:45.167: //47958/546501659166/CCAPI/ccCallConnect:
   Call Entry(Connected=TRUE, Responsed=TRUE)
329358: *Aug 25 01:24:45.171: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
ACK sip:bwas1-vir.atl0.cbeyond.net:5060 SIP/2.0
Date: Wed, 25 Aug 2010 01:24:24 GMT
Authorization: Digest

username="5551234567",realm="BroadWorks",uri="sip:1XXXXXXXXXX@sipconnect.dal0.cbeyond.net:5060",response="ed07fd5f574561091d4e95cb42f84b02",nonce="Broad

WorksXgd9hzjonT6dyj2BW",cnonce="BE20888B",qop=auth,algorithm=MD5,nc=00000001
From: "MyTest" <sip:5551234567@sipconnect.dal0.cbeyond.net>;tag=5D0E3984-1CCB
Allow-Events: telephone-event
Content-Length: 0
To: <sip:1XXXXXXXXXX@sipconnect.dal0.cbeyond.net>;tag=599900672-1282699205943
Call-ID: 54680EC6-AF1E11DF-916C8E74-D60711A1@sipconnect.dal0.cbeyond.net
Via: SIP/2.0/UDP 192.168.0.2:5060;branch=z9hG4bK8D381CC3
CSeq: 102 ACK
Max-Forwards: 70


329359: *Aug 25 01:24:45.171: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 200 OK
Date: Wed, 25 Aug 2010 01:24:24 GMT
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER
From: MyTest<sip:5551234567@127.0.0.1>;tag=b4473b8-0-13c4-50022-699f9-6e1c0fd3-699f9
Allow-Events: telephone-event
Supported: replaces
Supported: sdp-anat
Content-Length: 186
To: <sip:915558091234@192.168.0.2>;tag=5D0E4390-1BAF
Contact: <sip:915558091234@192.168.0.2:5060>
Content-Disposition: session;handling=required
Content-Type: application/sdp
Call-ID: 2798949081-0b4d6028-0b457e48-00000145@192.168.0.122
Via: SIP/2.0/UDP 192.168.0.122:5060;branch=z9hG4bK-699f9-19c975c9-bd6d60
CSeq: 1 INVITE
Server: Cisco-SIPGateway/IOS-12.x

v=0
o=CiscoSystemsSIP-GW-UserAgent 2277 96 IN IP4 192.168.0.2
s=SIP Call
c=IN IP4 192.168.0.2
t=0 0
m=audio 19560 RTP/AVP 0
c=IN IP4 192.168.0.2
a=rtpmap:0 PCMU/8000
a=ptime:20

329360: *Aug 25 01:24:45.175: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
ACK sip:915558091234@192.168.0.2:5060 SIP/2.0
From: MyTest<sip:5551234567@127.0.0.1>;tag=b4473b8-0-13c4-50022-699f9-6e1c0fd3-699f9
To: <sip:915558091234@192.168.0.2>;tag=5D0E4390-1BAF
Call-ID: 2798949081-0b4d6028-0b457e48-00000145@192.168.0.122
CSeq: 1 ACK
Via: SIP/2.0/UDP 192.168.0.122:5060;branch=z9hG4bK-69a0e-19c9c6e2-1de1c729
Max-Forwards: 70
x-sid: d42ac1ec1a30ee8f0eb22f194f92a4ad
Contact: <sip:5551234567@192.168.0.122:5060>
Content-Length: 0


This is when the recipient attempted to transfer the call.


329361: *Aug 25 01:25:16.172:          s=VoIP d=DSP payload 0x65 ssrc 0x1B1F2C91 sequence 0xACFF timestamp 0x3B396E9C
329362: *Aug 25 01:25:16.172:  <<<Rcv> Pt:101    Evt:2       Pkt:09 00 00
329363: *Aug 25 01:25:16.172:          s=DSP d=VoIP payload 0x65 ssrc 0x1B1F2C91 sequence 0xACFF timestamp 0x3B396E9C
329364: *Aug 25 01:25:16.172:          Pt:101    Evt:2       Pkt:09 00 00  <Snd>>>
329365: *Aug 25 01:25:16.172:          s=VoIP d=DSP payload 0x65 ssrc 0x1B1F2C91 sequence 0xAD00 timestamp 0x3B396E9C
329366: *Aug 25 01:25:16.172:  <<<Rcv> Pt:101    Evt:2       Pkt:09 00 00
329367: *Aug 25 01:25:16.172:          s=DSP d=VoIP payload 0x65 ssrc 0x1B1F2C91 sequence 0xAD00 timestamp 0x3B396E9C
329368: *Aug 25 01:25:16.172:          Pt:101    Evt:2       Pkt:09 00 00  <Snd>>>
329369: *Aug 25 01:25:16.172:          s=VoIP d=DSP payload 0x65 ssrc 0x1B1F2C91 sequence 0xAD01 timestamp 0x3B396E9C
329370: *Aug 25 01:25:16.172:  <<<Rcv> Pt:101    Evt:2       Pkt:09 00 00
329371: *Aug 25 01:25:16.172:          s=DSP d=VoIP payload 0x65 ssrc 0x1B1F2C91 sequence 0xAD01 timestamp 0x3B396E9C
329372: *Aug 25 01:25:16.172:          Pt:101    Evt:2       Pkt:09 00 00  <Snd>>>
329373: *Aug 25 01:25:16.172: //47959/xxxxxxxxxxxx/CCAPI/cc_api_call_digit_begin:
   Consume mask is not set. Relaying Digit 2 to dstCallId 0xBB56
329374: *Aug 25 01:25:16.172: //47959/xxxxxxxxxxxx/CCAPI/cc_relay_digit_begin_for_3way_conference:
   Check DTMF relay digit begin for 3way conf
329375: *Aug 25 01:25:16.220:          s=VoIP d=DSP payload 0x65 ssrc 0x1B1F2C91 sequence 0xAD02 timestamp 0x3B396E9C
329376: *Aug 25 01:25:16.220:  <<<Rcv> Pt:101    Evt:2       Pkt:09 01 90
329377: *Aug 25 01:25:16.220:          s=DSP d=VoIP payload 0x65 ssrc 0x1B1F2C91 sequence 0xAD02 timestamp 0x3B396E9C
329378: *Aug 25 01:25:16.220:          Pt:101    Evt:2       Pkt:09 01 90  <Snd>>>
329379: *Aug 25 01:25:16.268:          s=VoIP d=DSP payload 0x65 ssrc 0x1B1F2C91 sequence 0xAD03 timestamp 0x3B396E9C
329380: *Aug 25 01:25:16.268:  <<<Rcv> Pt:101    Evt:2       Pkt:09 03 20
329381: *Aug 25 01:25:16.268:          s=DSP d=VoIP payload 0x65 ssrc 0x1B1F2C91 sequence 0xAD03 timestamp 0x3B396E9C
329382: *Aug 25 01:25:16.268:          Pt:101    Evt:2       Pkt:09 03 20  <Snd>>>
329383: *Aug 25 01:25:16.320:          s=VoIP d=DSP payload 0x65 ssrc 0x1B1F2C91 sequence 0xAD04 timestamp 0x3B396E9C
329384: *Aug 25 01:25:16.320:  <<<Rcv> Pt:101    Evt:2       Pkt:09 04 B0
329385: *Aug 25 01:25:16.320:          s=DSP d=VoIP payload 0x65 ssrc 0x1B1F2C91 sequence 0xAD04 timestamp 0x3B396E9C
329386: *Aug 25 01:25:16.320:          Pt:101    Evt:2       Pkt:09 04 B0  <Snd>>>
329387: *Aug 25 01:25:16.360:          s=VoIP d=DSP payload 0x65 ssrc 0x1B1F2C91 sequence 0xAD05 timestamp 0x3B396E9C
329388: *Aug 25 01:25:16.360:  <<<Rcv> Pt:101    Evt:2       Pkt:89 05 88
329389: *Aug 25 01:25:16.360:          s=DSP d=VoIP payload 0x65 ssrc 0x1B1F2C91 sequence 0xAD05 timestamp 0x3B396E9C
329390: *Aug 25 01:25:16.360:          Pt:101    Evt:2       Pkt:89 05 88  <Snd>>>
329391: *Aug 25 01:25:16.360:          s=VoIP d=DSP payload 0x65 ssrc 0x1B1F2C91 sequence 0xAD06 timestamp 0x3B396E9C
329392: *Aug 25 01:25:16.360:  <<<Rcv> Pt:101    Evt:2       Pkt:89 05 88
329393: *Aug 25 01:25:16.360:          s=DSP d=VoIP payload 0x65 ssrc 0x1B1F2C91 sequence 0xAD06 timestamp 0x3B396E9C
329394: *Aug 25 01:25:16.360:          Pt:101    Evt:2       Pkt:89 05 88  <Snd>>>
329395: *Aug 25 01:25:16.360:          s=VoIP d=DSP payload 0x65 ssrc 0x1B1F2C91 sequence 0xAD07 timestamp 0x3B396E9C
329396: *Aug 25 01:25:16.360:  <<<Rcv> Pt:101    Evt:2       Pkt:89 05 88
329397: *Aug 25 01:25:16.360:          s=DSP d=VoIP payload 0x65 ssrc 0x1B1F2C91 sequence 0xAD07 timestamp 0x3B396E9C
329398: *Aug 25 01:25:16.360:          Pt:101    Evt:2       Pkt:89 05 88  <Snd>>>
329399: *Aug 25 01:25:16.360: //47959/xxxxxxxxxxxx/CCAPI/cc_api_call_digit_end:
   Consume mask is not set. Relaying Digit 2 to dstCallId 0xBB56
329400: *Aug 25 01:25:16.360: //47959/xxxxxxxxxxxx/CCAPI/cc_relay_digit_end_for_3way_conference:
   Check DTMF relay digit end for 3way conf
329401: *Aug 25 01:25:24.648:          s=VoIP d=DSP payload 0x65 ssrc 0x1B1F2C91 sequence 0xAEA6 timestamp 0x3B3A7774
329402: *Aug 25 01:25:24.648:  <<<Rcv> Pt:101    Evt:1       Pkt:0A 00 00
329403: *Aug 25 01:25:24.648:          s=DSP d=VoIP payload 0x65 ssrc 0x1B1F2C91 sequence 0xAEA6 timestamp 0x3B3A7774
329404: *Aug 25 01:25:24.648:          Pt:101    Evt:1       Pkt:0A 00 00  <Snd>>>
329405: *Aug 25 01:25:24.648:          s=VoIP d=DSP payload 0x65 ssrc 0x1B1F2C91 sequence 0xAEA7 timestamp 0x3B3A7774
329406: *Aug 25 01:25:24.648:  <<<Rcv> Pt:101    Evt:1       Pkt:0A 00 00
329407: *Aug 25 01:25:24.648:          s=DSP d=VoIP payload 0x65 ssrc 0x1B1F2C91 sequence 0xAEA7 timestamp 0x3B3A7774
329408: *Aug 25 01:25:24.648:          Pt:101    Evt:1       Pkt:0A 00 00  <Snd>>>
329409: *Aug 25 01:25:24.648:          s=VoIP d=DSP payload 0x65 ssrc 0x1B1F2C91 sequence 0xAEA8 timestamp 0x3B3A7774
329410: *Aug 25 01:25:24.648:  <<<Rcv> Pt:101    Evt:1       Pkt:0A 00 00
329411: *Aug 25 01:25:24.648:          s=DSP d=VoIP payload 0x65 ssrc 0x1B1F2C91 sequence 0xAEA8 timestamp 0x3B3A7774
329412: *Aug 25 01:25:24.648:          Pt:101    Evt:1       Pkt:0A 00 00  <Snd>>>
329413: *Aug 25 01:25:24.648: //47959/xxxxxxxxxxxx/CCAPI/cc_api_call_digit_begin:
   Consume mask is not set. Relaying Digit 1 to dstCallId 0xBB56
329414: *Aug 25 01:25:24.648: //47959/xxxxxxxxxxxx/CCAPI/cc_relay_digit_begin_for_3way_conference:
   Check DTMF relay digit begin for 3way conf
329415: *Aug 25 01:25:24.696:          s=VoIP d=DSP payload 0x65 ssrc 0x1B1F2C91 sequence 0xAEA9 timestamp 0x3B3A7774
329416: *Aug 25 01:25:24.696:  <<<Rcv> Pt:101    Evt:1       Pkt:0A 01 90
329417: *Aug 25 01:25:24.696:          s=DSP d=VoIP payload 0x65 ssrc 0x1B1F2C91 sequence 0xAEA9 timestamp 0x3B3A7774
329418: *Aug 25 01:25:24.696:          Pt:101    Evt:1       Pkt:0A 01 90  <Snd>>>
329419: *Aug 25 01:25:24.744:          s=VoIP d=DSP payload 0x65 ssrc 0x1B1F2C91 sequence 0xAEAA timestamp 0x3B3A7774
329420: *Aug 25 01:25:24.744:  <<<Rcv> Pt:101    Evt:1       Pkt:0A 03 20
329421: *Aug 25 01:25:24.744:          s=DSP d=VoIP payload 0x65 ssrc 0x1B1F2C91 sequence 0xAEAA timestamp 0x3B3A7774
329422: *Aug 25 01:25:24.744:          Pt:101    Evt:1       Pkt:0A 03 20  <Snd>>>
329423: *Aug 25 01:25:24.792:          s=VoIP d=DSP payload 0x65 ssrc 0x1B1F2C91 sequence 0xAEAB timestamp 0x3B3A7774
329424: *Aug 25 01:25:24.792:  <<<Rcv> Pt:101    Evt:1       Pkt:0A 04 B0
329425: *Aug 25 01:25:24.792:          s=DSP d=VoIP payload 0x65 ssrc 0x1B1F2C91 sequence 0xAEAB timestamp 0x3B3A7774
329426: *Aug 25 01:25:24.792:          Pt:101    Evt:1       Pkt:0A 04 B0  <Snd>>>
329427: *Aug 25 01:25:24.832:          s=VoIP d=DSP payload 0x65 ssrc 0x1B1F2C91 sequence 0xAEAC timestamp 0x3B3A7774
329428: *Aug 25 01:25:24.832:  <<<Rcv> Pt:101    Evt:1       Pkt:8A 05 90
329429: *Aug 25 01:25:24.832:          s=DSP d=VoIP payload 0x65 ssrc 0x1B1F2C91 sequence 0xAEAC timestamp 0x3B3A7774
329430: *Aug 25 01:25:24.832:          Pt:101    Evt:1       Pkt:8A 05 90  <Snd>>>
329431: *Aug 25 01:25:24.832:          s=VoIP d=DSP payload 0x65 ssrc 0x1B1F2C91 sequence 0xAEAD timestamp 0x3B3A7774
329432: *Aug 25 01:25:24.832:  <<<Rcv> Pt:101    Evt:1       Pkt:8A 05 90
329433: *Aug 25 01:25:24.832:          s=DSP d=VoIP payload 0x65 ssrc 0x1B1F2C91 sequence 0xAEAD timestamp 0x3B3A7774
329434: *Aug 25 01:25:24.832:          Pt:101    Evt:1       Pkt:8A 05 90  <Snd>>>
329435: *Aug 25 01:25:24.832:          s=VoIP d=DSP payload 0x65 ssrc 0x1B1F2C91 sequence 0xAEAE timestamp 0x3B3A7774
329436: *Aug 25 01:25:24.832:  <<<Rcv> Pt:101    Evt:1       Pkt:8A 05 90
329437: *Aug 25 01:25:24.832:          s=DSP d=VoIP payload 0x65 ssrc 0x1B1F2C91 sequence 0xAEAE timestamp 0x3B3A7774
329438: *Aug 25 01:25:24.832:          Pt:101    Evt:1       Pkt:8A 05 90  <Snd>>>
329439: *Aug 25 01:25:24.832: //47959/xxxxxxxxxxxx/CCAPI/cc_api_call_digit_end:
   Consume mask is not set. Relaying Digit 1 to dstCallId 0xBB56
329440: *Aug 25 01:25:24.832: //47959/xxxxxxxxxxxx/CCAPI/cc_relay_digit_end_for_3way_conference:
   Check DTMF relay digit end for 3way conf

Thanks,

15 Replies 15

Changing the CUE DTMF is so you don't break DTMF for CUE outcall scenarios, since the dial-peer that will be matched for these calls will now expect RTP-NTE.

Getting Started

Find answers to your questions by entering keywords or phrases in the Search bar above. New here? Use these resources to familiarize yourself with the community: