[OpenSIPS-Users] LATE SDP Script on Opensips 3.3

HS bullehs at gmail.com
Sat Jan 21 10:34:14 UTC 2023


Hi all.

I am trying to setup an Opensips 3.3 instance on AWS and have rtpengine
installed. I am using a modified version of the script here:

http://www.opensips.org/pub/docs/tutorials/websockets/opensips-late.cfg

Two issues.
1. When I call a browser (Firefox or chrome), the call is rejected and I
get the error: "Failed to get local SDP".
2. One-way audio in specific circumstances - log below. Investigating
further I found that if I use "t_on_reply("handle_nat");" the calls go
through fine. However, if I use "t_on_branch("handle_nat");" I see
behaviour below.

Thanks in advance.

I am using 2 UA - Microsip and Linphone. When I call from Microsip (Laptop)
to Linphone (Android) I have great audio and the logs show this:

Jan 20 16:11:06 ip-172-31-13-220 rtpengine[42387]: INFO:
[f75f1e374747457ca016e3a3a62ff4b3]: [control] Received command 'answer'
from 127.0.0.1:33919
Jan 20 16:11:06 ip-172-31-13-220 rtpengine[42387]: INFO:
[f75f1e374747457ca016e3a3a62ff4b3]: [control] Replying to 'answer' from
127.0.0.1:33919 (elapsed time 0.000268 sec)
Jan 20 16:11:06 ip-172-31-13-220 /usr/sbin/opensips[79601]: incoming reply
Jan 20 16:11:07 ip-172-31-13-220 dhclient[451]: DHCPREQUEST for
172.31.13.220 on ens5 to 172.31.0.1 port 67
Jan 20 16:11:07 ip-172-31-13-220 dhclient[451]: DHCPACK of 172.31.13.220
from 172.31.0.1
Jan 20 16:11:07 ip-172-31-13-220 dhclient[451]: bound to 172.31.13.220 --
renewal in 1607 seconds.
Jan 20 16:11:10 ip-172-31-13-220 rtpengine[42387]: INFO:
[f75f1e374747457ca016e3a3a62ff4b3 port 13215]: [core] Confirmed peer
address as My.Pub.IP.Add:4011
Jan 20 16:11:21 ip-172-31-13-220 rtpengine[42387]: INFO:
[f75f1e374747457ca016e3a3a62ff4b3]: [control] Received command 'delete'
from 127.0.0.1:33919
Jan 20 16:11:21 ip-172-31-13-220 rtpengine[42387]: INFO:
[f75f1e374747457ca016e3a3a62ff4b3]: [core] Scheduling deletion of call
branch 'bGUEC~8' (via-branch '') in 30 seconds
Jan 20 16:11:21 ip-172-31-13-220 rtpengine[42387]: INFO:
[f75f1e374747457ca016e3a3a62ff4b3]: [core] Scheduling deletion of call
branch '33a25bec39c742678ce74836e0ff40d1' (via-branch '') in 30 seconds
Jan 20 16:11:21 ip-172-31-13-220 rtpengine[42387]: INFO:
[f75f1e374747457ca016e3a3a62ff4b3]: [core] Scheduling deletion of entire
call in 30 seconds
Jan 20 16:11:21 ip-172-31-13-220 rtpengine[42387]: INFO:
[f75f1e374747457ca016e3a3a62ff4b3]: [control] Replying to 'delete' from
127.0.0.1:33919 (elapsed time 0.000179 sec)


However, when I call from Linphone to Microsip, there's one-way audio and
the following in the logs:

Jan 20 16:02:29 ip-172-31-13-220 rtpengine[42387]: INFO: [CjBB-HZqpe]:
[control] Received command 'offer' from 127.0.0.1:40022
Jan 20 16:02:29 ip-172-31-13-220 rtpengine[42387]: NOTICE: [CjBB-HZqpe]:
[core] Creating new call
Jan 20 16:02:29 ip-172-31-13-220 rtpengine[42387]: INFO: [CjBB-HZqpe]:
[control] Replying to 'offer' from 127.0.0.1:40022 (elapsed time 0.000500
sec)
Jan 20 16:02:37 ip-172-31-13-220 rtpengine[42387]: INFO: [CjBB-HZqpe]:
[control] Received command 'answer' from 127.0.0.1:40022
Jan 20 16:02:37 ip-172-31-13-220 rtpengine[42387]: INFO: [CjBB-HZqpe]:
[control] Replying to 'answer' from 127.0.0.1:40022 (elapsed time 0.000209
sec)
Jan 20 16:02:37 ip-172-31-13-220 /usr/sbin/opensips[79600]: incoming reply
Jan 20 16:02:38 ip-172-31-13-220 rtpengine[42387]: INFO: [CjBB-HZqpe]:
[control] Received command 'answer' from 127.0.0.1:40022
Jan 20 16:02:38 ip-172-31-13-220 rtpengine[42387]: INFO: [CjBB-HZqpe]:
[control] Replying to 'answer' from 127.0.0.1:40022 (elapsed time 0.000178
sec)
Jan 20 16:02:38 ip-172-31-13-220 /usr/sbin/opensips[79600]: incoming reply
Jan 20 16:02:39 ip-172-31-13-220 rtpengine[42387]: INFO: [CjBB-HZqpe]:
[control] Received command 'answer' from 127.0.0.1:40022
Jan 20 16:02:39 ip-172-31-13-220 rtpengine[42387]: INFO: [CjBB-HZqpe]:
[control] Replying to 'answer' from 127.0.0.1:40022 (elapsed time 0.000139
sec)
Jan 20 16:02:39 ip-172-31-13-220 /usr/sbin/opensips[79600]: incoming reply
Jan 20 16:02:44 ip-172-31-13-220 dhclient[524]: XMT: Solicit on ens5,
interval 111260ms.
Jan 20 16:02:45 ip-172-31-13-220 rtpengine[42387]: INFO: [CjBB-HZqpe port
13139]: [core] Confirmed peer address as My.Pub.IP.Add:4007
Jan 20 16:02:46 ip-172-31-13-220 rtpengine[42387]: INFO: [CjBB-HZqpe port
13146]: [core] Confirmed peer address as My.Pub.IP.Add:7078
Jan 20 16:02:46 ip-172-31-13-220 rtpengine[42387]: INFO: [CjBB-HZqpe port
13146]: [core] Kernelizing media stream: My.Pub.IP.Add:7078 ->
172.31.13.220:13146 | 172.31.13.220:13138 -> My.Pub.IP.Add:4006
Jan 20 16:02:51 ip-172-31-13-220 rtpengine[42387]: INFO:
[8fbde711f8864432ba7a37290d224a9a]: [core] Final packet stats:
Jan 20 16:02:51 ip-172-31-13-220 rtpengine[42387]: INFO:
[8fbde711f8864432ba7a37290d224a9a]: [core] --- Tag
'de22d68c1c7e4e759933a940e2f9eaa8', created 1:30 ago for branch ''
Jan 20 16:02:51 ip-172-31-13-220 rtpengine[42387]: INFO:
[8fbde711f8864432ba7a37290d224a9a]: [core] ---     subscribed to 'PCjqSrP'
Jan 20 16:02:51 ip-172-31-13-220 rtpengine[42387]: INFO:
[8fbde711f8864432ba7a37290d224a9a]: [core] ---     subscription for
'PCjqSrP'
Jan 20 16:02:51 ip-172-31-13-220 rtpengine[42387]: INFO:
[8fbde711f8864432ba7a37290d224a9a]: [core] ------ Media #1 (audio over
RTP/AVP) using opus/48000/2
Jan 20 16:02:51 ip-172-31-13-220 rtpengine[42387]: INFO:
[8fbde711f8864432ba7a37290d224a9a]: [core] --------- Port
172.31.13.220:13126 <>   My.Pub.IP.Add:4004 , SSRC 3cca2cda, in 4 p, 185 b,
0 e, 83 ts, out 2 p, 67 b, 0 e
Jan 20 16:02:51 ip-172-31-13-220 rtpengine[42387]: INFO:
[8fbde711f8864432ba7a37290d224a9a]: [core] --------- Port
172.31.13.220:13127 <>   My.Pub.IP.Add:4005  (RTCP), SSRC 3cca2cda, in 4 p,
276 b, 0 e, 83 ts, out 0 p, 0 b, 0 e
Jan 20 16:02:51 ip-172-31-13-220 rtpengine[42387]: INFO:
[8fbde711f8864432ba7a37290d224a9a]: [core] --- Tag 'PCjqSrP', created 1:30
ago for branch ''
Jan 20 16:02:51 ip-172-31-13-220 rtpengine[42387]: INFO:
[8fbde711f8864432ba7a37290d224a9a]: [core] ---     subscribed to
'de22d68c1c7e4e759933a940e2f9eaa8'
Jan 20 16:02:51 ip-172-31-13-220 rtpengine[42387]: INFO:
[8fbde711f8864432ba7a37290d224a9a]: [core] ---     subscription for
'de22d68c1c7e4e759933a940e2f9eaa8'
Jan 20 16:02:51 ip-172-31-13-220 rtpengine[42387]: INFO:
[8fbde711f8864432ba7a37290d224a9a]: [core] ------ Media #1 (audio over
RTP/AVP) using opus/48000/2
Jan 20 16:02:51 ip-172-31-13-220 rtpengine[42387]: INFO:
[8fbde711f8864432ba7a37290d224a9a]: [core] --------- Port
172.31.13.220:13112 <>   My.Pub.IP.Add:7078 , SSRC 1a445cd2, in 2 p, 67 b,
0 e, 83 ts, out 4 p, 185 b, 0 e
Jan 20 16:02:51 ip-172-31-13-220 rtpengine[42387]: INFO:
[8fbde711f8864432ba7a37290d224a9a]: [core] --------- Port
172.31.13.220:13113 <>   My.Pub.IP.Add:7079  (RTCP), SSRC 0, in 2 p, 40 b,
2 e, 83 ts, out 4 p, 276 b, 0 e
Jan 20 16:02:52 ip-172-31-13-220 rtpengine[42387]: INFO: [CjBB-HZqpe port
13138]: [core] Confirmed peer address as My.Pub.IP.Add:4006
Jan 20 16:02:52 ip-172-31-13-220 rtpengine[42387]: INFO: [CjBB-HZqpe port
13138]: [core] Kernelizing media stream: My.Pub.IP.Add:4006 ->
172.31.13.220:13138 | 172.31.13.220:13146 -> My.Pub.IP.Add:7078
Jan 20 16:02:59 ip-172-31-13-220 rtpengine[42387]: INFO: [CjBB-HZqpe]:
[control] Received command 'delete' from 127.0.0.1:40022
Jan 20 16:02:59 ip-172-31-13-220 rtpengine[42387]: INFO: [CjBB-HZqpe]:
[core] Scheduling deletion of call branch '8Cn0Y-HU7' (via-branch '') in 30
seconds
Jan 20 16:02:59 ip-172-31-13-220 rtpengine[42387]: INFO: [CjBB-HZqpe]:
[core] Scheduling deletion of call branch
'eaaabeb8d95e4b849c4ebc092e9aee47' (via-branch '') in 30 seconds
Jan 20 16:02:59 ip-172-31-13-220 rtpengine[42387]: INFO: [CjBB-HZqpe]:
[core] Scheduling deletion of entire call in 30 seconds
Jan 20 16:02:59 ip-172-31-13-220 rtpengine[42387]: INFO: [CjBB-HZqpe]:
[control] Replying to 'delete' from 127.0.0.1:40022 (elapsed time 0.000111
sec)
Jan 20 16:03:01 ip-172-31-13-220 CRON[79619]: (root) CMD ((cd
/var/www/html/opensips-cp/; /usr/bin/php cron_job/get_opensips_stats.php))
Jan 20 16:03:01 ip-172-31-13-220 CRON[79618]: (CRON) info (No MTA
installed, discarding output)
Jan 20 16:03:29 ip-172-31-13-220 rtpengine[42387]: INFO: [CjBB-HZqpe]:
[core] Final packet stats:
Jan 20 16:03:29 ip-172-31-13-220 rtpengine[42387]: INFO: [CjBB-HZqpe]:
[core] --- Tag '8Cn0Y-HU7', created 1:00 ago for branch ''
Jan 20 16:03:29 ip-172-31-13-220 rtpengine[42387]: INFO: [CjBB-HZqpe]:
[core] ---     subscribed to 'eaaabeb8d95e4b849c4ebc092e9aee47'
Jan 20 16:03:29 ip-172-31-13-220 rtpengine[42387]: INFO: [CjBB-HZqpe]:
[core] ---     subscription for 'eaaabeb8d95e4b849c4ebc092e9aee47'
Jan 20 16:03:29 ip-172-31-13-220 rtpengine[42387]: INFO: [CjBB-HZqpe]:
[core] ------ Media #1 (audio over RTP/AVP) using opus/48000/2
Jan 20 16:03:29 ip-172-31-13-220 rtpengine[42387]: INFO: [CjBB-HZqpe]:
[core] --------- Port   172.31.13.220:13146 <>   My.Pub.IP.Add:7078 , SSRC
3b8965ac, in 6 p, 242 b, 0 e, 35 ts, out 7 p, 322 b, 0 e
Jan 20 16:03:29 ip-172-31-13-220 rtpengine[42387]: INFO: [CjBB-HZqpe]:
[core] --------- Port   172.31.13.220:13147 <>   My.Pub.IP.Add:7079
 (RTCP), SSRC 3b8965ac, in 5 p, 228 b, 4 e, 49 ts, out 12 p, 916 b, 0 e
Jan 20 16:03:29 ip-172-31-13-220 rtpengine[42387]: INFO: [CjBB-HZqpe]:
[core] --- Tag 'eaaabeb8d95e4b849c4ebc092e9aee47', created 1:00 ago for
branch ''
Jan 20 16:03:29 ip-172-31-13-220 rtpengine[42387]: INFO: [CjBB-HZqpe]:
[core] ---     subscribed to '8Cn0Y-HU7'
Jan 20 16:03:29 ip-172-31-13-220 rtpengine[42387]: INFO: [CjBB-HZqpe]:
[core] ---     subscription for '8Cn0Y-HU7'
Jan 20 16:03:29 ip-172-31-13-220 rtpengine[42387]: INFO: [CjBB-HZqpe]:
[core] ------ Media #1 (audio over RTP/AVP) using opus/48000/2
Jan 20 16:03:29 ip-172-31-13-220 rtpengine[42387]: INFO: [CjBB-HZqpe]:
[core] --------- Port   172.31.13.220:13138 <>   My.Pub.IP.Add:4006 , SSRC
52e506de, in 7 p, 322 b, 0 e, 37 ts, out 6 p, 242 b, 0 e
Jan 20 16:03:29 ip-172-31-13-220 rtpengine[42387]: INFO: [CjBB-HZqpe]:
[core] --------- Port   172.31.13.220:13139 <>   My.Pub.IP.Add:4007
 (RTCP), SSRC 52e506de, in 12 p, 916 b, 0 e, 29 ts, out 1 p, 148 b, 0 e
Jan 20 16:03:29 ip-172-31-13-220 rtpengine[42387]: INFO: [CjBB-HZqpe]:
[core] Removing media stream from kernel: local 172.31.13.220:13138
Jan 20 16:03:29 ip-172-31-13-220 rtpengine[42387]: INFO: [CjBB-HZqpe]:
[core] Removing media stream from kernel: local 172.31.13.220:13146

Appreciate any feedback.
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.opensips.org/pipermail/users/attachments/20230121/183af4e0/attachment.html>


More information about the Users mailing list