cancel
Showing results for 
Search instead for 
Did you mean: 
cancel
3710
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,

1 Accepted Solution

Accepted Solutions

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.

View solution in original post

15 Replies 15

ADAM CRISP
Level 4
Level 4

Well, If we accept that the three common ways of transporting DTMF are:

1. Named telepone events - Inband RTP-NTE

2. SIP Info

3. in audio (we're ignore this one)

then we need to look to see what isn't working.

There are no SIP INFO messages anywhere, so let's concentrate on rtp-net

1. The Outgoing call to the SIP trunk INVITE looks like this:

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" <>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: <>1XXXXXXXXXX@sipconnect.dal0.cbeyond.net>
Contact: <5551234567>
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

and the 200 OK of this call like this:

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"<>5551234567@sipconnect.dal0.cbeyond.net>;tag=5D0E3984-1CCB
To:<>1XXXXXXXXXX@sipconnect.dal0.cbeyond.net>;tag=599900672-1282699205943
Call-ID:54680EC6-AF1E11DF-916C8E74-D60711A1@sipconnect.dal0.cbeyond.net
CSeq:102 INVITE
Supported:
Contact:
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

so the outgoing call agrees on RTP-NTE

2. The INVITE received from your phone looks like this:

INVITE sip:915558091234@192.168.0.2:5060 SIP/2.0
From: MyTest<5551234567>;tag=b4473b8-0-13c4-50022-699f9-6e1c0fd3-699f9
To: <915558091234>
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: <5551234567>
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

and the 200 OK provided by the UC5XX

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<5551234567>;tag=b4473b8-0-13c4-50022-699f9-6e1c0fd3-699f9
Allow-Events: telephone-event
Supported: replaces
Supported: sdp-anat
Content-Length: 186
To: <915558091234>;tag=5D0E4390-1BAF
Contact: <915558091234>
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

So we have no negotiation of RTP-NTE between the phone and your Cisco

I would suggest looking at the incoming dial-peer for the phone and making sure it includes dtmf-relay rtp-nte.

SIP INFO isn't enabled, and we're not transcoding audio, so inband audio is no good to us,

Adam

Adam,

That is a great help. I have a little stuck on which inbound dial-peer is incorrect. I have attached my UC config. Do you mind taking a look.

Thanks

yes. Ok,

It's a bit unclear to me too.

If you have a SIP phone that's connecting to the CCME part of the UC5XX, then it's possible there there's a setting somewhere in the config for this that I'm not familiar with, but by the look of your trace, you could just be sending a SIP call to the UC5XX for forwarding

Your dialled number was 915558091234

so to find out whether this theory is correct, why not create a dial-peer for testing

EG

!

dial-peer voice 915 voip

description incoming dial peer for calls sent to 915

voice-class codec 1
session protocol sipv2
incoming called-number 915.+
dtmf-relay rtp-nte

!

Adam

Adam,

Not sure if this is what you wanted to hear but I created that dial-peer and still was unable to transfer the call. I have attached the new log files

Oh no!,

Can you please tell me what you're using to make the call.

i.e. Is this a phone that's registered on the UC560, or is it an external device ?

Adam

It is an automated system which initiates the phone call using the UC5xx. Does that help?

OK, When you press 1, you're expecting this to send the DTMF the the called party, like if you were calling an IVR ?

That is correct. In fact the system is an IVR to transfer the call to different departments.

Steven Holl
Cisco Employee
Cisco Employee

You are matching dial-peer 1003 inbound:

dial-peer voice 1003 voip
description ** Passthrough Inbound Calls from CUE **
translation-profile incoming SIP_Passthrough
b2bua
session protocol sipv2
session target ipv4:10.1.10.1
incoming called-number ABCDT
dtmf-relay sip-notify
codec g711ulaw
no vad

That dial-peer has sip-notify configured on it, but the inbound SDP from the other side for that leg is doing rtp-nte:

a=rtpmap:101 telephone-event/8000

You can either change 1003's dtmf-relay to rtp-nte, or you can add a more specific inbound peer for this call:

dial-peer voice 6000 voip

incoming called-number ABCD915558091234

  translation-profile incoming SIP_Passthrough
  b2bua
  session protocol sipv2
  dtmf-relay rtp-nte
  codec g711ulaw
  no vad

-Steve

Steve,

Isn't the 1003 dial-peer for incoming calls? In this case the IVR is telling the UC5xx to place the outbound phone call to this particular client. So it would be difficult to set a specific dial-peer b/c the number will always be different.

Does that make sense?

If I am missing something and in fact changing that 1003 dial-peer is the solution I will do that. However, if I change that dial-peer it will not affect AA will it?

You can see that you are matching this peer here:

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

Anytime you make a call through a Cisco gateway, we always match both an inbound dial-peer, and an outbound dial-peer.  Regardless of whether it is an inbound, or an outbound call.  You can read on the inbound dial-peer matching algorithm here:

http://www.cisco.com/en/US/tech/tk652/tk90/technologies_tech_note09186a008010fed1.shtml

You would use either 'incoming called-number ' or 'answer-address ' to direct which inbound dial-peer you will want to match.

If you were to change peer 1003, it may mess up calls which are supposed to match 1003.  That would be any call generated by CUE.  Your alternative could be to configure CUE for rtp-nte under 'ccn subsystem sip' and then you can just do all of your inbound dial-peer matching for SIP calls with one peer configured for RTP-NTE and g711ulaw, and a statement of 'incoming called-number .'.

Steven,

I created a test dial-peer (mimicing yours) in which I hard coded the incoming called number to my number and the call transfer worked. So my question back to you is.

1) If I change the dial-peer 1003 to dtmf-relay rtp-nte

     a) will that still allow that dial-peer to work as before or could it possibly cause all phone calls to fail?

     b) would a command like this voice-class sip dtmf-relay force rtp-nte work?

or

2) If I can change the setting in ccn subsystem sip to be rtp-nte do I have to apply any changes to that dial-peer 1003? Will the dtmf-relay sip-notify still cause an issue?

Thanks,

You will want to do both.  Make 1003 configured for rtp-nte, and go under CUE's ccn subsystem sip and also configure dtmf-relay for rtp-nte there, as well.

I expect it to not break anything, but because I don't know your completely topology and potential call flows, after making the change, test call scenarios where CUE generates an outbound call (things like voicemail phone notification, and transfers out of an AA) to make sure calls and DTMF are still working.  It may be prudent to test all types of inbound SIP calls to the device, as well, just to make sure you're matching the intended dial-peers.

Steven,

That makes sense. However, why is it necessary to change the default ccn subsystem setting as well. When I created that test dial-peer everything worked just as expected.