[c-nsp] ISDN PRI to SIP in 2811, RTP fails one way AFTER first DTMF is sent?

Thu Jul 1 10:54:49 EDT 2010

Hi

I have a very strange issue.

Using a Cisco 2811 router with PRI connecting to customers PBX. SIP trunk
towards Verizon.
Incoming and outgoing calls are working just fine, using G.729 codec.
DTMF RFC288 configured, and I can see in the SIP invites and 200ok messages
that it is indeed using RFC2833.

However, when customer makes an outgoing call, and the press any key, I can
hear the tone, and I see the DTMF in the router with debug voip rtp session
but after that, RTP is dead in the outbound direction.

IOS: c2800nm-advipservicesk9-mz.124-22.T5.bin

voice rtp send-recv
!
voice service voip
  fax protocol pass-through g711alaw
 sip
  bind control source-interface Loopback0
  bind media source-interface Loopback0

voice class codec 1
 codec preference 1 g729r8
 codec preference 2 g711alaw
 codec preference 3 g711ulaw

dial-peer voice 100 voip
 description Inbound and Outbound VoIP
 service session
 destination-pattern .T
 rtp payload-type cisco-codec-fax-ack 114
 rtp payload-type cisco-codec-fax-ind 113
 rtp payload-type nte 98
 voice-class codec 1
 session protocol sipv2
 session target sip-server
 incoming called-number 41.......
 dtmf-relay rtp-nte
 ip qos dscp cs5 media
 ip qos dscp cs3 signaling
 no vad

some debugs:

invite:

v=0
o=CiscoSystemsSIP-GW-UserAgent 9659 7570 IN IP4 a.b.c.d
s=SIP Call
c=IN IP4 a.b.c.d
t=0 0
m=audio 17130 RTP/AVP 18 8 0 101
c=IN IP4 194.98.111.122
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
*a=rtpmap:101 telephone-event/8000*
a=fmtp:101 0-16

200ok:

v=0
o=BroadWorks 22417778 1 IN IP4 x.y.z.z
s=-
c=IN IP4x.y.z.z
t=0 0
m=audio 25174 RTP/AVP 18 101
*a=rtpmap:101 telephone-event/8000*
a=fmtp:101 0-15
a=ptime:20
a=fmtp:18 annexb=no

Jul  1 10:59:14.258: //501/825D605A808B/CCAPI/ccSaveDialpeerTag:
   Outgoing Dial-peer=100
Jul  1 10:59:14.258: //502/825D605A808B/CCAPI/ccSaveDialpeerTag:
   Incoming Dial-peer=10
Jul  1 10:59:14.270: ISDN Se0/0/0:15 Q921: Net RX <- RR sapi=0 tei=0 nr=48
Jul  1 10:59:14.270: ISDN Se0/0/0:15 Q921: Net RX <- INFO sapi=0 tei=0,
ns=48 nr=48
Jul  1 10:59:14.270: ISDN Se0/0/0:15 Q931: CONNECT_ACK pd = 8  callref =
0x005B
Jul  1 10:59:14.274: ISDN Se0/0/0:15 Q921: Net TX -> RR sapi=0 tei=0 nr=49
Jul  1 10:59:21.230:          s=DSP d=VoIP payload 0x65 ssrc 0x19FA sequence
0x1DF4 timestamp 0xB97203B6
Jul  1 10:59:21.230:          Pt:101    Evt:7       Pkt:09 00 00  <Snd>>>
Jul  1 10:59:21.230: //501/xxxxxxxxxxxx/CCAPI/cc_api_call_digit_begin:
   Consume mask is not set. Relaying Digit 7 to dstCallId 0x1F6
Jul  1 10:59:21.230:
//501/xxxxxxxxxxxx/CCAPI/cc_relay_digit_begin_for_3way_conference:
   Check DTMF relay digit begin for 3way conf
Jul  1 10:59:21.238:          s=DSP d=VoIP payload 0x65 ssrc 0x19FA sequence
0x1DF5 timestamp 0xB97203B6
Jul  1 10:59:21.238:          Pt:101    Evt:7       Pkt:09 00 00  <Snd>>>
Jul  1 10:59:21.250:          s=DSP d=VoIP payload 0x65 ssrc 0x19FA sequence
0x1DF6 timestamp 0xB97203B6
Jul  1 10:59:21.250:          Pt:101    Evt:7       Pkt:09 00 00  <Snd>>>
Jul  1 10:59:21.278:          s=DSP d=VoIP payload 0x65 ssrc 0x19FA sequence
0x1DF7 timestamp 0xB97203B6
Jul  1 10:59:21.278:          Pt:101    Evt:7       Pkt:09 01 90  <Snd>>>
Jul  1 10:59:21.330:          s=DSP d=VoIP payload 0x65 ssrc 0x19FA sequence
0x1DF8 timestamp 0xB97203B6
Jul  1 10:59:21.330:          Pt:101    Evt:7       Pkt:09 03 20  <Snd>>>
Jul  1 10:59:21.378:          s=DSP d=VoIP payload 0x65 ssrc 0x19FA sequence
0x1DF9 timestamp 0xB97203B6
Jul  1 10:59:21.378:          Pt:101    Evt:7       Pkt:09 04 B0  <Snd>>>
Jul  1 10:59:21.402: //501/xxxxxxxxxxxx/CCAPI/cc_api_call_digit_end:
   Consume mask is not set. Relaying Digit 7 to dstCallId 0x1F6
Jul  1 10:59:21.402:
//501/xxxxxxxxxxxx/CCAPI/cc_relay_digit_end_for_3way_conference:
   Check DTMF relay digit end for 3way conf
Jul  1 10:59:21.410:          s=DSP d=VoIP payload 0x65 ssrc 0x19FA sequence
0x1DFA timestamp 0xB97203B6
Jul  1 10:59:21.410:          Pt:101    Evt:7       Pkt:89 04 B0  <Snd>>>
Jul  1 10:59:21.418:          s=DSP d=VoIP payload 0x65 ssrc 0x19FA sequence
0x1DFB timestamp 0xB97203B6
Jul  1 10:59:21.418:          Pt:101    Evt:7       Pkt:89 04 B0  <Snd>>>
Jul  1 10:59:21.430:          s=DSP d=VoIP payload 0x65 ssrc 0x19FA sequence
0x1DFC timestamp 0xB97203B6
Jul  1 10:59:21.430:          Pt:101    Evt:7       Pkt:89 04 B0  <Snd>>>
Jul  1 10:59:24.270: ISDN Se0/0/0:15 Q921: Net TX -> RRp sapi=0 tei=0 nr=49
Jul  1 10:59:24.270: ISDN Se0/0/0:15 Q921: Net RX <- RRp sapi=0 tei=0 nr=48
Jul  1 10:59:24.274: ISDN Se0/0/0:15 Q921: Net TX -> RRf sapi=0 tei=0 nr=49
Jul  1 10:59:24.274: ISDN Se0/0/0:15 Q921: Net RX <- RRf sapi=0 tei=0 nr=48
Jul  1 10:59:34.270: ISDN Se0/0/0:15 Q921: Net RX <- RRp sapi=0 tei=0 nr=48
Jul  1 10:59:34.274: ISDN Se0/0/0:15 Q921: Net TX -> RRf sapi=0 tei=0 nr=49

Any tips?

I've tried G711, IOS upgrade, all dtmf-relay methods available, no go =( I'm
starting to thing its something with the PBX..