[SR-Users] Kamailio with rtpproxy-ng and mediaproxy-ng: Error rewriting SDP

Olli Heiskanen ohjelmistoarkkitehti at gmail.com
Wed Jul 23 17:01:56 CEST 2014 

Thanks,

I think here's all of the call from before the called party answers:


Jul 22 19:36:31 u363id562 rtpengine[16930]: Got valid command from
127.0.0.1:39090: offer - { "sdp": "v=0#015#012o=- 4878041229845783313 2 IN
IP4 127.0.0.1#015#012s=-#015#012t=0 0#015#012a=group:BUNDLE
audio#015#012a=msid-semantic: WMS
a5c8QXN9lIWNnLI9gyw54a4ea3LY0iil8frd#015#012m=audio 56050 RTP/SAVPF 111 103
104 0 8 106 105 13 126#015#012c=IN IP4 2.2.2.2#015#012a=rtcp:56050 IN IP4
2.2.2.2#015#012a=candidate:3350409123 1 udp 2122260223 192.168.0.101 56050
typ host generation 0#015#012a=candidate:3350409123 2 udp 2122260223
192.168.0.101 56050 typ host generation 0#015#012a=candidate:2999745851 1
udp 2122194687 192.168.56.1 56051 typ host generation
0#015#012a=candidate:2999745851 2 udp 2122194687 192.168.56.1 56051 typ
host generation 0#015#012a=candidate:2301678419 1 tcp 1518280447
192.168.0.101 0 typ host generation 0#015#012a=candidate:2301678419 2 tcp
1518280447 192.168.0.101 0 typ host generation
0#015#012a=candidate:4233069003 1 tcp 1518214911 192.168.56.1 0 typ host
generation 0#015#012a=candidate:4233069003 2 tcp 1518214911 192.168.56.1 0
typ host generation 0#015#012a=candidate:1190865175 1 udp 1686052607
2.2.2.2 56050 typ srflx raddr 192.168.0.101 rport 56050 generation
0#015#012a=candidate:1190865175 2 udp 1686052607 2.2.2.2 56050 typ srflx
raddr 192.168.0.101 rport 56050 generation
0#015#012a=ice-ufrag:/BpHYKAAtvbkO+46#015#012a=ice-pwd:JOPq6loMi7vLJMkwoN+06b9M#015#012a=ice-options:google-ice#015#012a=fingerprint:sha-256
03:48:83:8A:E5:CF:28:C5:28:43:8B:F2:3A:AF:0A:ED:6D:E7:63:EE:87:14:43:0B:61:C5:4F:BB:9F:96:90:AA#015#012a=setup:actpass#015#012a=mid:audio#015#012a=extmap:1
urn:ietf:params:rtp-hdrext:ssrc-audio-level#015#012a=extmap:3
http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time#015#012a=sendrecv#015#012a=rtcp-mux#015#012a=rtpmap:111
opus/48000/2#015#012a=fmtp:111 minptime=10#015#012a=rtpmap:103
ISAC/16000#015#012a=rtpmap:104 ISAC/32000#015#012a=rtpmap:0
PCMU/8000#015#012a=rtpmap:8 PCMA/8000#015#012a=rtpmap:106
CN/32000#015#012a=rtpmap:105 CN/16000#015#012a=rtpmap:13 CN/
Jul 22 19:36:31 u363id562 rtpengine[16930]: [35hkg7ct44fpndrs0gjt] Creating
new call
Jul 22 19:36:31 u363id562 rtpengine[16930]: [35hkg7ct44fpndrs0gjt]
Returning to SIP proxy: d3:sdp2175:v=0#015#012o=- 4878041229845783313 2 IN
IP4 127.0.0.1#015#012s=-#015#012t=0 0#015#012a=group:BUNDLE
audio#015#012a=msid-semantic: WMS
a5c8QXN9lIWNnLI9gyw54a4ea3LY0iil8frd#015#012m=audio 30144 RTP/SAVPF 111 103
104 0 8 106 105 13 126#015#012c=IN IP4
1.1.1.1#015#012a=candidate:3350409123 1 udp 2122260223 192.168.0.101 56050
typ host generation 0#015#012a=candidate:3350409123 2 udp 2122260223
192.168.0.101 56050 typ host generation 0#015#012a=candidate:2999745851 1
udp 2122194687 192.168.56.1 56051 typ host generation
0#015#012a=candidate:2999745851 2 udp 2122194687 192.168.56.1 56051 typ
host generation 0#015#012a=candidate:2301678419 1 tcp 1518280447
192.168.0.101 0 typ host generation 0#015#012a=candidate:2301678419 2 tcp
1518280447 192.168.0.101 0 typ host generation
0#015#012a=candidate:4233069003 1 tcp 1518214911 192.168.56.1 0 typ host
generation 0#015#012a=candidate:4233069003 2 tcp 1518214911 192.168.56.1 0
typ host generation 0#015#012a=candidate:1190865175 1 udp 1686052607
2.2.2.2 56050 typ srflx raddr 192.168.0.101 rport 56050 generation
0#015#012a=candidate:1190865175 2 udp 1686052607 2.2.2.2 56050 typ srflx
raddr 192.168.0.101 rport 56050 generation
0#015#012a=ice-ufrag:/BpHYKAAtvbkO+46#015#012a=ice-pwd:JOPq6loMi7vLJMkwoN+06b9M#015#012a=ice-options:google-ice#015#012a=fingerprint:sha-256
03:48:83:8A:E5:CF:28:C5:28:43:8B:F2:3A:AF:0A:ED:6D:E7:63:EE:87:14:43:0B:61:C5:4F:BB:9F:96:90:AA#015#012a=setup:actpass#015#012a=mid:audio#015#012a=extmap:1
urn:ietf:params:rtp-hdrext:ssrc-audio-level#015#012a=extmap:3
http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time#015#012a=rtpmap:111
opus/48000/2#015#012a=fmtp:111 minptime=10#015#012a=rtpmap:103
ISAC/16000#015#012a=rtpmap:104 ISAC/32000#015#012a=rtpmap:0
PCMU/8000#015#012a=rtpmap:8 PCMA/8000#015#012a=rtpmap:106
CN/32000#015#012a=rtpmap:105 CN/16000#015#012a=rtpmap:13
CN/8000#015#012a=rtpmap:126
telephone-event/8000#015#012a=maxptime:60#015#012a=
Jul 22 19:36:31 u363id562 rtpengine[16930]: Got valid command from
127.0.0.1:50012: delete - { "call-id": "35hkg7ct44fpndrs0gjt",
"received-from": [ "IP4", "2.2.2.2" ], "from-tag": "ulaa4af3s4", "command":
"delete" }
Jul 22 19:36:31 u363id562 rtpengine[16930]: [35hkg7ct44fpndrs0gjt] Deleting
full call
Jul 22 19:36:31 u363id562 rtpengine[16930]: [35hkg7ct44fpndrs0gjt] Final
packet stats:
Jul 22 19:36:31 u363id562 rtpengine[16930]: [35hkg7ct44fpndrs0gjt] --- Tag
'', created 0:00 ago, in dialogue with '(none)'
Jul 22 19:36:31 u363id562 rtpengine[16930]: [35hkg7ct44fpndrs0gjt] ------
Media #1, port 30146 <>    2.2.2.2:56050, 0 p, 0 b, 0 e
Jul 22 19:36:31 u363id562 rtpengine[16930]: [35hkg7ct44fpndrs0gjt] --- Tag
'ulaa4af3s4', created 0:00 ago, in dialogue with ''
Jul 22 19:36:31 u363id562 rtpengine[16930]: [35hkg7ct44fpndrs0gjt] ------
Media #1, port 30144 <>            [::]:0    , 0 p, 0 b, 0 e
Jul 22 19:36:31 u363id562 rtpengine[16930]: [35hkg7ct44fpndrs0gjt]
Returning to SIP proxy: d7:createdi1406043391e11:last
signali1406043391e4:tagsd10:ulaa4af3s4d3:tag10:ulaa4af3s47:createdi1406043391e16:in
dialogue
with0:6:mediasld5:indexi1e4:type5:audio8:protocol9:RTP/SAVPF7:streamsld10:local
porti30144e8:endpointd6:family4:IPv67:address2:::4:porti0ee19:advertised
endpointd6:family4:IPv67:address2:::4:porti0ee11:last
packeti1406043391e5:flagsl3:RTP4:RTCPe5:statsd7:packetsi0e5:bytesi0e6:errorsi0eeed10:local
porti30145e8:endpointd6:family4:IPv67:address2:::4:porti0ee19:advertised
endpointd6:family4:IPv67:address2:::4:porti0ee11:last
packeti1406043391e5:flagsl4:RTCP13:fallback
RTCPe5:statsd7:packetsi0e5:bytesi0e6:errorsi0eeee5:flagsl8:rtcp-mux11:passthrough3:ICEeeeee6:totalsd3:RTPd7:packetsi0e5:bytesi0e6:errorsi0ee4:RTCPd7:packetsi0e5:bytesi0e6:errorsi0eee6:result2:oke
Jul 22 19:36:31 u363id562 rtpengine[16930]: Got valid command from
127.0.0.1:50012: offer - { "sdp": "v=0#015#012o=- 4878041229845783313 2 IN
IP4 127.0.0.1#015#012s=-#015#012t=0 0#015#012a=group:BUNDLE
audio#015#012a=msid-semantic: WMS
a5c8QXN9lIWNnLI9gyw54a4ea3LY0iil8frd#015#012m=audio 56050 RTP/SAVPF 111 103
104 0 8 106 105 13 126#015#012c=IN IP4 2.2.2.2#015#012a=rtcp:56050 IN IP4
2.2.2.2#015#012a=candidate:3350409123 1 udp 2122260223 192.168.0.101 56050
typ host generation 0#015#012a=candidate:3350409123 2 udp 2122260223
192.168.0.101 56050 typ host generation 0#015#012a=candidate:2999745851 1
udp 2122194687 192.168.56.1 56051 typ host generation
0#015#012a=candidate:2999745851 2 udp 2122194687 192.168.56.1 56051 typ
host generation 0#015#012a=candidate:2301678419 1 tcp 1518280447
192.168.0.101 0 typ host generation 0#015#012a=candidate:2301678419 2 tcp
1518280447 192.168.0.101 0 typ host generation
0#015#012a=candidate:4233069003 1 tcp 1518214911 192.168.56.1 0 typ host
generation 0#015#012a=candidate:4233069003 2 tcp 1518214911 192.168.56.1 0
typ host generation 0#015#012a=candidate:1190865175 1 udp 1686052607
2.2.2.2 56050 typ srflx raddr 192.168.0.101 rport 56050 generation
0#015#012a=candidate:1190865175 2 udp 1686052607 2.2.2.2 56050 typ srflx
raddr 192.168.0.101 rport 56050 generation
0#015#012a=ice-ufrag:/BpHYKAAtvbkO+46#015#012a=ice-pwd:JOPq6loMi7vLJMkwoN+06b9M#015#012a=ice-options:google-ice#015#012a=fingerprint:sha-256
03:48:83:8A:E5:CF:28:C5:28:43:8B:F2:3A:AF:0A:ED:6D:E7:63:EE:87:14:43:0B:61:C5:4F:BB:9F:96:90:AA#015#012a=setup:actpass#015#012a=mid:audio#015#012a=extmap:1
urn:ietf:params:rtp-hdrext:ssrc-audio-level#015#012a=extmap:3
http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time#015#012a=sendrecv#015#012a=rtcp-mux#015#012a=rtpmap:111
opus/48000/2#015#012a=fmtp:111 minptime=10#015#012a=rtpmap:103
ISAC/16000#015#012a=rtpmap:104 ISAC/32000#015#012a=rtpmap:0
PCMU/8000#015#012a=rtpmap:8 PCMA/8000#015#012a=rtpmap:106
CN/32000#015#012a=rtpmap:105 CN/16000#015#012a=rtpmap:13 CN/
Jul 22 19:36:31 u363id562 rtpengine[16930]: [35hkg7ct44fpndrs0gjt] Creating
new call
Jul 22 19:36:31 u363id562 rtpengine[16930]: [35hkg7ct44fpndrs0gjt]
Returning to SIP proxy: d3:sdp750:v=0#015#012o=- 4878041229845783313 2 IN
IP4 1.1.1.1#015#012s=-#015#012t=0 0#015#012a=msid-semantic: WMS
a5c8QXN9lIWNnLI9gyw54a4ea3LY0iil8frd#015#012m=audio 30148 RTP/AVP 111 103
104 0 8 106 105 13 126#015#012c=IN IP4 1.1.1.1#015#012a=rtpmap:111
opus/48000/2#015#012a=fmtp:111 minptime=10#015#012a=rtpmap:103
ISAC/16000#015#012a=rtpmap:104 ISAC/32000#015#012a=rtpmap:0
PCMU/8000#015#012a=rtpmap:8 PCMA/8000#015#012a=rtpmap:106
CN/32000#015#012a=rtpmap:105 CN/16000#015#012a=rtpmap:13
CN/8000#015#012a=rtpmap:126
telephone-event/8000#015#012a=maxptime:60#015#012a=ssrc:570927802
cname:dYE3cgVVbH9kDELV#015#012a=ssrc:570927802
msid:a5c8QXN9lIWNnLI9gyw54a4ea3LY0iil8frd
ef55e410-eb48-4c6d-a270-de333bfe7ae2#015#012a=ssrc:570927802
mslabel:a5c8QXN9lIWNnLI9gyw54a4ea3LY0iil8frd#015#012a=ssrc:570927802
label:ef55e410-eb48-4c6d-a270-de333bfe7ae2#015#012a=sendrecv#015#012a=rtcp:30149#015#0126:result2:oke


There is something that might be relevant, after I started using dispatcher
for sending the requests to Asterisk servers, I couldn't get calls through
when routing INVITEs to Asterisk. Had errors with media servers not
responding, although my Asterisk was running fine. Not sure why that
happened but calls started flowing correctly after I
used t_on_failure("MANAGE_FAILURE") of the default config and adding there
a call to route("UA_FAILURE"), where I handle the 488 response.

So, my MANAGE_FAILURE route looks like this:

failure_route[MANAGE_FAILURE] {

        route(NATMANAGE);

        if (t_is_canceled()) {
                exit;
        }

#!ifdef WITH_BLOCK3XX
        # block call redirect based on 3xx replies.
        if (t_check_status("3[0-9][0-9]")) {
                t_reply("404","Not found");
                exit;
        }
#!endif

#!ifdef WITH_VOICEMAIL
        # serial forking
        # - route to voicemail on busy or no answer (timeout)
        if (t_check_status("486|408")) {
                $du = $null;
                route(TOVOICEMAIL);
                exit;
        }
#!endif

#!ifdef WITH_WEBSOCKETS
        route(UA_FAILURE);
#!endif

       # ... dispatcher for 500 reply or local timeout handling
}


cheers,
Olli




2014-07-23 16:32 GMT+03:00 Richard Fuchs <rfuchs at sipwise.com>:

> On 07/23/14 05:03, Olli Heiskanen wrote:
> >
> > Hi,
> >
> > Thanks very much for this, that solved the double-m-line issue. Now I'm
> > calling rtpengine_offer in a branch route.
> >
> > One issue still remains; the call still gets connected to the called
> > zoiper client, but it gets hung up right away. I traced this to be
> > caused by a BYE message from Kamailio, which I think may be caused by
> > the fact that the SDP returning to the chrome/websocket caller contains
> > RTP/AVP profile, which it doesn't support. What I don't know is why this
> > happens.
> ...
> > I suspect there is a 200 OK message going from Kamailio to the ws client
> > that has the RTP/AVP profile, as the Jssip library gets an error
> > stating: "Failed to set remote answer sdp: Failed to push down transport
> > description: Answerer must use either active or passive value for setup
> > attribute."
> >
> > Any idea on what's going wrong here?
>
> Yes, I see there's an a=setup:actpass in the answer, which shouldn't be
> there. Could you post the entire log for the whole call (just the
> rtpengine part) so I can see why it's putting that there?
>
> cheers
>
> _______________________________________________
> SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing list
> sr-users at lists.sip-router.org
> http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.sip-router.org/pipermail/sr-users/attachments/20140723/f75abc44/attachment.html>

More information about the sr-users mailing list