Hi all, Here's is a link to the log of 2 calls. First part is a call that has one-way audio and the second is a call that has great bi-directional audio. https://pastebin.com/ggUFUmsp
Appreciate if someone can identify if opensips config is ok pls, or suggestions on how to fix pls. On Sat, Jan 21, 2023 at 3:34 PM HS <[email protected]> wrote: > 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. >
_______________________________________________ Users mailing list [email protected] http://lists.opensips.org/cgi-bin/mailman/listinfo/users
