From mail4arunkr@gmail.com Thu Mar  9 16:31:53 2023
From: mail4arunkr@gmail.com
To: sr-users@lists.kamailio.org
Subject: [SR-Users] webrtc from public internet have no voice
Date: Thu, 09 Mar 2023 16:31:35 +0000
Message-ID: <167837949559.1439.8136434817586636553@main.kamailio.org>
MIME-Version: 1.0
Content-Type: multipart/mixed; boundary="===============0533717070=="

--===============0533717070==
Content-Type: text/plain; charset="utf-8"
Content-Transfer-Encoding: quoted-printable

Hello,
I have installed Kamailio 5.6 in debian 11 and RTPengine 11.3 also in the sam=
e server. I have configured kamailio to work as webrtc server and it forwards=
 the registration to asterisk. Now when I am trying call from jssip webrtc cl=
ient it reaches kamailio and route it through private interface to asterisk s=
erver. Asterisk then route it to the provider server. When i make a call aste=
risk server recives rtp from the provider and convert the rtp to srtp and sen=
ding back to kamailio. but there is no sound for webrtc from public internet =
. Also i am getting warning (SRTCP /RTP output wanted, but no crypto suite wa=
s negotiated)

webrtc from Local network works fine with VPN

For normal udp call without webrtc works fine.

Kamailio having two interfaces, interface1 is private 10.13.1.140 and interfa=
ce 2 is publi ip 100.x.x.x

webrtc client sends calls to the public ip interface 100.x.x.x and kamaiio ro=
utes the call to the asterisk via private interface 10.13.1.140.
asterisk server sends the call to remote server and gets the rtp back from th=
at
Asterisk server ---converts RTP to SRTP and forward to ----> kamailio 10.13.1=
.140
but there is nothing happens after that, please help me on this i am new to k=
amailio and rtpengine.

The issue is only for webrtc from public internet. But when using webrtc from=
 LAN works fine



below are the logs

Mar 9 20:21:02 debian /usr/local/sbin/kamailio[11778]: INFO: <script>: from d=
omain recived is 10.13.1.152
Mar 9 20:21:02 debian /usr/local/sbin/kamailio[11778]: INFO: <script>: 094963=
81412 has fromDomain recived is 10.13.1.152
Mar 9 20:21:02 debian /usr/local/sbin/kamailio[11778]: INFO: <script>: Reques=
t going to srtp customied arun
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [control] Adding a proxy for c=
ontrol ng stats:127.0.0.1
Mar 9 20:21:02 debian rtpengine[11823]: INFO: [ui7jc53b9lfbt9lf4nu7]: [contro=
l] Received command 'offer' from 127.0.0.1:53374
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [contr=
ol] Dump for 'offer' from 127.0.0.1:53374: { "supports": [ "load limit" ], "s=
dp": "v=3D0
Mar 9 20:21:02 debian rtpengine[11823]: o=3D- 7377619262916888262 2 IN IP4 12=
7.0.0.1
Mar 9 20:21:02 debian rtpengine[11823]: s=3D-
Mar 9 20:21:02 debian rtpengine[11823]: t=3D0 0
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dgroup:BUNDLE 0
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dextmap-allow-mixed
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dmsid-semantic: WMS mP5OKOsd0Yb5JQ=
ystk9oCQJVA8LOp4pWhuJB
Mar 9 20:21:02 debian rtpengine[11823]: m=3Daudio 9 UDP/TLS/RTP/SAVPF 111 63 =
9 0 8 13 110 126
Mar 9 20:21:02 debian rtpengine[11823]: c=3DIN IP4 0.0.0.0
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtcp:9 IN IP4 0.0.0.0
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dice-ufrag:NM2h
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dice-pwd:BF2WmB5sOZZWVIFppZ3YTiSH
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dice-options:trickle
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dfingerprint:sha-256 9F:FA:18:B0:8=
D:17:A5:14:FE:22:BA:1E:73:1E:3E:02:6F:17:EC:B5:FC:77:BD:E1:0B:51:DF:7F:61:B0:=
2F:55
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dsetup:actpass
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dmid:0
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dextmap:1 urn:ietf:params:rtp-hdre=
xt:ssrc-audio-level
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dextmap:2 http://www.webrtc.org/ex=
periments/rtp-hdrext/abs-send-time
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dextmap:3 http://www.ietf.org/id/d=
raft-holmer-rmcat-transport-wide-cc-extensions-01
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dextmap:4 urn:ietf:params:rtp-hdre=
xt:sdes:mid
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dsendrecv
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dmsid:mP5OKOsd0Yb5JQystk9oCQJVA8LO=
p4pWhuJB 6f36294e-5d92-4f0c-8ea2-ba415d0ec125
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtcp-mux
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtpmap:111 opus/48000/2
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtcp-fb:111 transport-cc
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dfmtp:111 minptime=3D10;useinbandf=
ec=3D1
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtpmap:63 red/48000/2
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dfmtp:63 111/111
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtpmap:9 G722/8000
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtpmap:0 PCMU/8000
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtpmap:8 PCMA/8000
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtpmap:13 CN/8000
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtpmap:110 telephone-event/48000
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtpmap:126 telephone-event/8000
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dssrc:2480159127 cname:FJAL1TGxCcn=
DMPXY
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dssrc:2480159127 msid:mP5OKOsd0Yb5=
JQystk9oCQJVA8LOp4pWhuJB 6f36294e-5d92-4f0c-8ea2-ba415d0ec125
Mar 9 20:21:02 debian rtpengine[11823]: ", "call-id": "ui7jc53b9lfbt9lf4nu7",=
 "received-from": [ "IP4", "223.190.206.123" ], "from-tag": "7n38ig1acl", "co=
mmand": "offer" }
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [core]=
 Using default bitrate of 32000 bps for 2-channel Opus
Mar 9 20:21:02 debian rtpengine[11823]: NOTICE: [ui7jc53b9lfbt9lf4nu7]: [core=
] Creating new call
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [core]=
 Subscribing '7n38ig1acl' to ''
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [core]=
 Subscribing '' to '7n38ig1acl'
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Updating codecs for offerer 7n38ig1acl #1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Adding codec opus/48000/2 (111)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Adding codec red/48000/2 (63)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Adding codec G722/8000 (9)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Adding codec PCMU/8000 (0)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Adding codec PCMA/8000 (8)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Adding codec CN/8000 (13)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Adding codec telephone-event/48000 (110)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Adding codec telephone-event/8000 (126)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Updating codecs for answerer #1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Adding codec opus/48000/2 (111)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Adding codec red/48000/2 (63)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Adding codec G722/8000 (9)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Adding codec PCMU/8000 (0)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Adding codec PCMA/8000 (8)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Adding codec CN/8000 (13)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Adding codec telephone-event/48000 (110)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Adding codec telephone-event/8000 (126)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Updating supplemental codecs for #1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Setting up codec handlers for #1 -> 7n38ig1acl #1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Default sink codec is opus/48000/2
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Checking receiver codec opus/48000/2 (111)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Creating codec handler for opus/48000/2 (111)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink codec for opus/48000/2 is opus/48000/2 (111)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink supports codec opus/48000/2 for passthrough
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Using passthrough handler for opus/48000/2 with DTMF 110, CN -1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Checking receiver codec red/48000/2 (63)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Creating codec handler for red/48000/2 (63)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] No codec support for red/48000/2
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Using passthrough handler for red/48000/2 with DTMF -1, CN -1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Checking receiver codec G722/8000/1 (9)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Creating codec handler for G722/8000 (9)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink codec for G722/8000 is G722/8000/1 (9)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink supports codec G722/8000 for passthrough
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Using passthrough handler for G722/8000 with DTMF 126, CN 13
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Checking receiver codec PCMU/8000/1 (0)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Creating codec handler for PCMU/8000 (0)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink codec for PCMU/8000 is PCMU/8000/1 (0)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink supports codec PCMU/8000 for passthrough
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Using passthrough handler for PCMU/8000 with DTMF 126, CN 13
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Checking receiver codec PCMA/8000/1 (8)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Creating codec handler for PCMA/8000 (8)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink codec for PCMA/8000 is PCMA/8000/1 (8)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink supports codec PCMA/8000 for passthrough
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Using passthrough handler for PCMA/8000 with DTMF 126, CN 13
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Checking receiver codec CN/8000/1 (13)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Creating codec handler for CN/8000 (13)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink codec for CN/8000 is CN/8000/1 (13)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink supports codec CN/8000 for passthrough
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Using passthrough handler for CN/8000 with DTMF 126, CN 13
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Checking receiver codec telephone-event/48000/1 (110)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Creating codec handler for telephone-event/48000 (110)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink codec for telephone-event/48000 is telephone-event/48000/1 (110)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink supports codec telephone-event/48000 for passthrough
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Using passthrough handler for telephone-event/48000 with DTMF 110, CN -1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Checking receiver codec telephone-event/8000/1 (126)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Creating codec handler for telephone-event/8000 (126)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink codec for telephone-event/8000 is telephone-event/8000/1 (126)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink supports codec telephone-event/8000 for passthrough
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Using passthrough handler for telephone-event/8000 with DTMF 126, CN 13
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Updating supplemental codecs for #1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Setting up codec handlers for #1 -> 7n38ig1acl #1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Default sink codec is opus/48000/2
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Checking receiver codec opus/48000/2 (111)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink codec for opus/48000/2 is opus/48000/2 (111)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink supports codec opus/48000/2 for passthrough
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Using passthrough handler for opus/48000/2 with DTMF 110, CN -1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Checking receiver codec red/48000/2 (63)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] No codec support for red/48000/2
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Using passthrough handler for red/48000/2 with DTMF -1, CN -1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Checking receiver codec G722/8000/1 (9)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink codec for G722/8000 is G722/8000/1 (9)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink supports codec G722/8000 for passthrough
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Using passthrough handler for G722/8000 with DTMF 126, CN 13
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Checking receiver codec PCMU/8000/1 (0)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink codec for PCMU/8000 is PCMU/8000/1 (0)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink supports codec PCMU/8000 for passthrough
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Using passthrough handler for PCMU/8000 with DTMF 126, CN 13
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Checking receiver codec PCMA/8000/1 (8)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink codec for PCMA/8000 is PCMA/8000/1 (8)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink supports codec PCMA/8000 for passthrough
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Using passthrough handler for PCMA/8000 with DTMF 126, CN 13
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Checking receiver codec CN/8000/1 (13)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink codec for CN/8000 is CN/8000/1 (13)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink supports codec CN/8000 for passthrough
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Using passthrough handler for CN/8000 with DTMF 126, CN 13
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Checking receiver codec telephone-event/48000/1 (110)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink codec for telephone-event/48000 is telephone-event/48000/1 (110)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink supports codec telephone-event/48000 for passthrough
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Using passthrough handler for telephone-event/48000 with DTMF 110, CN -1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Checking receiver codec telephone-event/8000/1 (126)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink codec for telephone-event/8000 is telephone-event/8000/1 (126)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink supports codec telephone-event/8000 for passthrough
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Using passthrough handler for telephone-event/8000 with DTMF 126, CN 13
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [core]=
 set FILLED flag for stream, local 10.13.1.127:30020 remote 0.0.0.0:9
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [crypt=
o] Creating active DTLS connection context
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [crypt=
o] Creating active DTLS connection context
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [core]=
 set FILLED flag for stream, local 10.13.1.127:30021 remote 0.0.0.0:9
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [crypt=
o] [10.13.1.127:30000] Initialized incoming SRTP with SDES crypto params:
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [crypt=
o] [1] Initialized outgoing SRTP with SDES crypto params: suite AEAD_AES_256_=
GCM, tag 1, key czR43Q05Tlky5pj/m6BomEKXh+b5okz/iSUDQqgvHDI=3D salt Vov9BA7SK=
ter2Ajj
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [crypt=
o] Creating passive DTLS connection context
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [crypt=
o] Creating passive DTLS connection context
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [crypt=
o] [10.13.1.127:30001] Initialized incoming SRTP with SDES crypto params:
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [crypt=
o] [2] Initialized outgoing SRTP with SDES crypto params: suite AEAD_AES_256_=
GCM, tag 1, key czR43Q05Tlky5pj/m6BomEKXh+b5okz/iSUDQqgvHDI=3D salt Vov9BA7SK=
ter2Ajj
Mar 9 20:21:02 debian rtpengine[11823]: INFO: [ui7jc53b9lfbt9lf4nu7]: [contro=
l] Replying to 'offer' from 127.0.0.1:53374 (elapsed time 0.022450 sec)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [contr=
ol] Response dump for 'offer' to 127.0.0.1:53374: { "sdp": "v=3D0
Mar 9 20:21:02 debian rtpengine[11823]: o=3D- 7377619262916888262 2 IN IP4 12=
7.0.0.1
Mar 9 20:21:02 debian rtpengine[11823]: s=3D-
Mar 9 20:21:02 debian rtpengine[11823]: t=3D0 0
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dextmap-allow-mixed
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dmsid-semantic: WMS mP5OKOsd0Yb5JQ=
ystk9oCQJVA8LOp4pWhuJB
Mar 9 20:21:02 debian rtpengine[11823]: m=3Daudio 30000 UDP/TLS/RTP/SAVPF 111=
 63 9 0 8 13 110 126
Mar 9 20:21:02 debian rtpengine[11823]: c=3DIN IP4 10.13.1.127
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dextmap:1 urn:ietf:params:rtp-hdre=
xt:ssrc-audio-level
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dextmap:2 http://www.webrtc.org/ex=
periments/rtp-hdrext/abs-send-time
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dextmap:3 http://www.ietf.org/id/d=
raft-holmer-rmcat-transport-wide-cc-extensions-01
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dextmap:4 urn:ietf:params:rtp-hdre=
xt:sdes:mid
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dmsid:mP5OKOsd0Yb5JQystk9oCQJVA8LO=
p4pWhuJB 6f36294e-5d92-4f0c-8ea2-ba415d0ec125
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dssrc:2480159127 cname:FJAL1TGxCcn=
DMPXY
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dssrc:2480159127 msid:mP5OKOsd0Yb5=
JQystk9oCQJVA8LOp4pWhuJB 6f36294e-5d92-4f0c-8ea2-ba415d0ec125
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dmid:0
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtpmap:111 opus/48000/2
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dfmtp:111 minptime=3D10;useinbandf=
ec=3D1
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtcp-fb:111 transport-cc
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtpmap:63 red/48000/2
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dfmtp:63 111/111
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtpmap:9 G722/8000
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtpmap:0 PCMU/8000
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtpmap:8 PCMA/8000
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtpmap:13 CN/8000
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtpmap:110 telephone-event/48000
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtpmap:126 telephone-event/8000
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dsendrecv
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtcp:30001
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtcp-mux
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dcrypto:1 AEAD_AES_256_GCM inline:=
czR43Q05Tlky5pj/m6BomEKXh+b5okz/iSUDQqgvHDJWi/0EDtIq16vYCOM
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dcrypto:2 AEAD_AES_128_GCM inline:=
5abyoU5PKLg1lNfmLg1aBLIqyNAgmKNEEo8J1w
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dcrypto:3 AES_256_CM_HMAC_SHA1_80 =
inline:i4O28fJjCyvBVQmwjCb7dySy5K20yeg5n1ky+uhPNSpbqkv8vxkcIaerkO9Gbg
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dcrypto:4 AES_256_CM_HMAC_SHA1_32 =
inline:OOydiBrJ9nMu23yaBP7JuYNddpbXX8sN/V9Ab/psnTZIBRZKXenHWVPvJSM9Fw
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dcrypto:5 AES_192_CM_HMAC_SHA1_80 =
inline:UtkHFdpsaZSO0nwvmEotIoGN+paLt3LHt7yMG4MfDv5rueBsb80
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dcrypto:6 AES_192_CM_HMAC_SHA1_32 =
inline:hgFJ9vS9Roz1vAMhnrCyviKC/TwCPgrk5jeKbxHlIEKtqSvLdK4
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dcrypto:7 AES_CM_128_HMAC_SHA1_80 =
inline:07Q9Z/8DguM0HJgDHv5HF3YDWHdp23hbz+TepHa8
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dcrypto:8 AES_CM_128_HMAC_SHA1_32 =
inline:djpscuSL/05sVtFNocQpHmr1x+NTcLXKu8ePb0q+
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dcrypto:9 F8_128_HMAC_SHA1_80 inli=
ne:5FqC2VY+q3vqaju3JwroIJO/OlCM1i6TNRE/3Atj
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dcrypto:10 F8_128_HMAC_SHA1_32 inl=
ine:kUfTs7OFD6ltRNpDi1dSG5ZjuQAFDeEQD5IvOwme
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dcrypto:11 NULL_HMAC_SHA1_80 inlin=
e:JZ2ruS0914NL4mmS7jxg+ngz0IQaE6FBRlet8abd
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dcrypto:12 NULL_HMAC_SHA1_32 inlin=
e:h21D+oGRkr1dDEoMm1+vEKmKsn+4GxNBwgIew2qA
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dsetup:actpass
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dfingerprint:sha-256 0C:67:09:6B:A=
E:6B:30:09:81:C5:9C:65:C6:EC:9E:CE:C2:6E:E2:EA:67:B4:B5:B3:40:C4:F1:0C:3E:05:=
96:79
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dtls-id:8100c85eb1c58be3580e8acd7f=
097000
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dice-ufrag:hcqW22Sc
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dice-pwd:QjHJKT4qNsfZm80zrcyh8SfI76
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dcandidate:GtpEjl9r4IzNpiXr 1 UDP =
2130706431 10.13.1.127 30000 typ host
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dcandidate:GtpEjl9r4IzNpiXr 2 UDP =
2130706430 10.13.1.127 30001 typ host
Mar 9 20:21:02 debian rtpengine[11823]: ", "result": "ok" }
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7//1 port =
30000]: [ice] Created candidate pair GtpEjl9r4IzNpiXr:6b1875839eb037b0:1 betw=
een 10.13.1.127 and 10.13.1.152:14450, type prflx
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7//1 port =
30000]: [ice] Triggering check for GtpEjl9r4IzNpiXr:6b1875839eb037b0:1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7//1 port =
30000]: [core] Successful STUN binding request from 10.13.1.152:14450
Mar 9 20:21:02 debian rtpengine[11823]: INFO: [ui7jc53b9lfbt9lf4nu7]: [contro=
l] Received command 'answer' from 127.0.0.1:60024
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [contr=
ol] Dump for 'answer' from 127.0.0.1:60024: { "supports": [ "load limit" ], "=
sdp": "v=3D0
Mar 9 20:21:02 debian rtpengine[11823]: o=3D- 2654832326 4 IN IP4 10.13.1.152
Mar 9 20:21:02 debian rtpengine[11823]: s=3DAsterisk
Mar 9 20:21:02 debian rtpengine[11823]: c=3DIN IP4 10.13.1.152
Mar 9 20:21:02 debian rtpengine[11823]: t=3D0 0
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dmsid-semantic:WMS *
Mar 9 20:21:02 debian rtpengine[11823]: m=3Daudio 14450 UDP/TLS/RTP/SAVPF 111=
 126
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dconnection:new
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dsetup:active
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dfingerprint:SHA-256 62:AD:7E:86:4=
D:FF:87:6B:44:5A:F0:62:A2:37:D6:56:5C:D4:F4:A8:03:88:A6:E1:DD:2A:15:69:75:1B:=
04:3C
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dice-ufrag:7706bb5e0317151b5749cc8=
550354244
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dice-pwd:4af879c44cb99216424536fa5=
defd9d5
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dcandidate:Ha0d0198 1 UDP 21307064=
31 10.13.1.152 14450 typ host
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dcandidate:H6719a439 1 UDP 2130706=
431 103.25.164.57 14450 typ host
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtpmap:111 opus/48000/2
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtpmap:126 telephone-event/8000
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dfmtp:126 0-16
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dptime:20
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dmaxptime:20
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dsendrecv
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtcp-mux
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dmsid:d5be09fd-dce5-4d96-879e-f34f=
22f54ef1 a3f22c04-6988-4464-a458-5abc099e7bc0
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtcp-fb:* transport-cc
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dmid:0
Mar 9 20:21:02 debian rtpengine[11823]: ", "call-id": "ui7jc53b9lfbt9lf4nu7",=
 "received-from": [ "IP4", "10.13.1.152" ], "from-tag": "7n38ig1acl", "to-tag=
": "a5935482-3f00-4dd0-b98c-0b4726da777d", "command": "answer" }
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [core]=
 Using default bitrate of 32000 bps for 2-channel Opus
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [core]=
 Unconfirming peer address for local 10.13.1.127:30000
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [core]=
 Unconfirming peer address for local 10.13.1.127:30020
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [core]=
 Unconfirming peer address for local 10.13.1.127:30001
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [core]=
 Unconfirming peer address for local 10.13.1.127:30021
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [core]=
 Unsubscribing '7n38ig1acl' from 'a5935482-3f00-4dd0-b98c-0b4726da777d'
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [core]=
 Unsubscribing 'a5935482-3f00-4dd0-b98c-0b4726da777d' from '7n38ig1acl'
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [core]=
 Subscribing 'a5935482-3f00-4dd0-b98c-0b4726da777d' to '7n38ig1acl'
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [core]=
 Subscribing '7n38ig1acl' to 'a5935482-3f00-4dd0-b98c-0b4726da777d'
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Updating codecs for answerer a5935482-3f00-4dd0-b98c-0b4726da777d #1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Adding codec opus/48000/2 (111)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Adding codec telephone-event/8000 (126)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Setting up codec handlers for a5935482-3f00-4dd0-b98c-0b4726da777d #1 -> 7n=
38ig1acl #1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Default sink codec is opus/48000/2
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Checking receiver codec opus/48000/2 (111)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink codec for opus/48000/2 is opus/48000/2 (111)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink supports codec opus/48000/2 for passthrough
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Using passthrough handler for opus/48000/2 with DTMF -1, CN -1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Checking receiver codec telephone-event/8000/1 (126)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink codec for telephone-event/8000 is telephone-event/8000/1 (126)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink supports codec telephone-event/8000 for passthrough
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Using passthrough handler for telephone-event/8000 with DTMF 126, CN -1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Codec answer for a5935482-3f00-4dd0-b98c-0b4726da777d #1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Reverse codec for opus/48000/2 (111) is opus/48000/2 (111)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Reverse codec for telephone-event/8000 (126) is telephone-event/8000 (126)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] telephone-event/8000/1 payload type 126 already present, skip
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Setting up codec handlers for 7n38ig1acl #1 -> a5935482-3f00-4dd0-b98c-0b47=
26da777d #1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Default sink codec is opus/48000/2
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Checking receiver codec opus/48000/2 (111)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Creating codec handler for opus/48000/2 (111)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink codec for opus/48000/2 is opus/48000/2 (111)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink supports codec opus/48000/2 for passthrough
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Using passthrough handler for opus/48000/2 with DTMF -1, CN -1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Checking receiver codec telephone-event/8000/1 (126)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Creating codec handler for telephone-event/8000 (126)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink codec for telephone-event/8000 is telephone-event/8000/1 (126)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink supports codec telephone-event/8000 for passthrough
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Using passthrough handler for telephone-event/8000 with DTMF 126, CN -1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Updating supplemental codecs for 7n38ig1acl #1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Updating supplemental codecs for a5935482-3f00-4dd0-b98c-0b4726da777d #1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Setting up codec handlers for 7n38ig1acl #1 -> a5935482-3f00-4dd0-b98c-0b47=
26da777d #1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Default sink codec is opus/48000/2
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Checking receiver codec opus/48000/2 (111)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink codec for opus/48000/2 is opus/48000/2 (111)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink supports codec opus/48000/2 for passthrough
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Using passthrough handler for opus/48000/2 with DTMF -1, CN -1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Checking receiver codec telephone-event/8000/1 (126)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink codec for telephone-event/8000 is telephone-event/8000/1 (126)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink supports codec telephone-event/8000 for passthrough
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Using passthrough handler for telephone-event/8000 with DTMF 126, CN -1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Setting up codec handlers for a5935482-3f00-4dd0-b98c-0b4726da777d #1 -> 7n=
38ig1acl #1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Default sink codec is opus/48000/2
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Checking receiver codec opus/48000/2 (111)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink codec for opus/48000/2 is opus/48000/2 (111)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink supports codec opus/48000/2 for passthrough
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Using passthrough handler for opus/48000/2 with DTMF -1, CN -1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Checking receiver codec telephone-event/8000/1 (126)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink codec for telephone-event/8000 is telephone-event/8000/1 (126)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink supports codec telephone-event/8000 for passthrough
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Using passthrough handler for telephone-event/8000 with DTMF 126, CN -1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [core]=
 set FILLED flag for stream, local 10.13.1.127:30000 remote 10.13.1.152:14450
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [core]=
 set FILLED flag for stream, local 10.13.1.127:30001 remote 10.13.1.152:14451
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [crypt=
o] [10.13.1.127:30001] Initialized incoming SRTP with SDES crypto params:
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [crypt=
o] [2] Initialized outgoing SRTP with SDES crypto params: suite AEAD_AES_256_=
GCM, tag 1, key czR43Q05Tlky5pj/m6BomEKXh+b5okz/iSUDQqgvHDI=3D salt Vov9BA7SK=
ter2Ajj
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [ice] =
Replacing previously learned prflx ICE candidate with Ha0d0198:1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [ice] =
Learning new ICE candidate H6719a439:1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [ice] =
Created candidate pair GtpEjl9r4IzNpiXr:H6719a439:1 between 10.13.1.127 and 1=
03.25.164.57:14450, type host
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [ice] =
Recalculating all ICE pair priorities
Mar 9 20:21:02 debian rtpengine[11823]: WARNING: [ui7jc53b9lfbt9lf4nu7]: [ice=
] Priority collision between candidate pairs GtpEjl9r4IzNpiXr:H6719a439:1 and=
 GtpEjl9r4IzNpiXr:Ha0d0198:1 - ICE will likely fail
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [ice] =
Sending ICE/STUN request for candidate pair GtpEjl9r4IzNpiXr:Ha0d0198:1 from =
10.13.1.127 to 10.13.1.152:14450
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [ice] =
Shutting down ICE agent (nothing to do)
Mar 9 20:21:02 debian rtpengine[11823]: INFO: [ui7jc53b9lfbt9lf4nu7]: [contro=
l] Replying to 'answer' from 127.0.0.1:60024 (elapsed time 0.003226 sec)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [contr=
ol] Response dump for 'answer' to 127.0.0.1:60024: { "sdp": "v=3D0
Mar 9 20:21:02 debian rtpengine[11823]: o=3D- 2654832326 4 IN IP4 10.13.1.152
Mar 9 20:21:02 debian rtpengine[11823]: s=3DAsterisk
Mar 9 20:21:02 debian rtpengine[11823]: c=3DIN IP4 10.13.1.127
Mar 9 20:21:02 debian rtpengine[11823]: t=3D0 0
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dmsid-semantic:WMS *
Mar 9 20:21:02 debian rtpengine[11823]: m=3Daudio 30020 UDP/TLS/RTP/SAVPF 111=
 126
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dconnection:new
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dmaxptime:20
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dmsid:d5be09fd-dce5-4d96-879e-f34f=
22f54ef1 a3f22c04-6988-4464-a458-5abc099e7bc0
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtcp-fb:* transport-cc
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dmid:0
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtpmap:111 opus/48000/2
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtpmap:126 telephone-event/8000
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dfmtp:126 0-16
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dsendrecv
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtcp:30020
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtcp-mux
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dsetup:active
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dfingerprint:sha-256 0C:67:09:6B:A=
E:6B:30:09:81:C5:9C:65:C6:EC:9E:CE:C2:6E:E2:EA:67:B4:B5:B3:40:C4:F1:0C:3E:05:=
96:79
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dtls-id:ac2907348568344c9743f21fa1=
383e08
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dptime:20
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dice-ufrag:4xVkmu6h
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dice-pwd:kc54UEYL25S4UjgSjVKJdcEiAR
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dice-options:trickle
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dcandidate:GtpEjl9r4IzNpiXr 1 UDP =
2130706431 10.13.1.127 30020 typ host
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dend-of-candidates
Mar 9 20:21:02 debian rtpengine[11823]: ", "result": "ok" }
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7/a5935482=
-3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [srtp] Processing incoming DTLS p=
acket
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7/a5935482=
-3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [srtp] Sending DTLS packet
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7/a5935482=
-3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [ice] Received ICE/STUN response =
code 0 for candidate pair GtpEjl9r4IzNpiXr:Ha0d0198:1 from 10.13.1.152:14450 =
to 10.13.1.127
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7/a5935482=
-3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [ice] Setting ICE candidate pair =
GtpEjl9r4IzNpiXr:Ha0d0198:1 as succeeded
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7/a5935482=
-3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [ice] Best succeeded ICE pair wit=
h all components is GtpEjl9r4IzNpiXr:Ha0d0198:1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7/a5935482=
-3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [ice] ICE not completed yet, but =
can use pair GtpEjl9r4IzNpiXr:Ha0d0198:1
Mar 9 20:21:02 debian rtpengine[11823]: INFO: [ui7jc53b9lfbt9lf4nu7/a5935482-=
3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [ice] ICE negotiated: peer for com=
ponent 1 is 10.13.1.152:14450
Mar 9 20:21:02 debian rtpengine[11823]: INFO: [ui7jc53b9lfbt9lf4nu7/a5935482-=
3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [ice] ICE negotiated: local interf=
ace 10.13.1.127
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7/a5935482=
-3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [srtp] Processing incoming DTLS p=
acket
Mar 9 20:21:02 debian rtpengine[11823]: INFO: [ui7jc53b9lfbt9lf4nu7/a5935482-=
3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [crypto] DTLS: Peer certificate ac=
cepted
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7/a5935482=
-3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [crypto] DTLS handshake successful
Mar 9 20:21:02 debian rtpengine[11823]: INFO: [ui7jc53b9lfbt9lf4nu7/a5935482-=
3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [crypto] DTLS-SRTP successfully ne=
gotiated using AES_CM_128_HMAC_SHA1_80
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7/a5935482=
-3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [srtp] SRTP keys, incoming:
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7/a5935482=
-3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [srtp] --- AES_CM_128_HMAC_SHA1_8=
0 key AtAWESyBg5e6Ub3EPRQ5ag=3D=3D salt rgwpYXp6KpHCmfjMxVA=3D
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7/a5935482=
-3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [srtp] SRTP keys, outgoing:
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7/a5935482=
-3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [srtp] --- AES_CM_128_HMAC_SHA1_8=
0 key 8+zHcQ5a1Bv5L0dv2AfKyg=3D=3D salt 7YaPNc68d5ALtKKIOCQ=3D
Mar 9 20:21:02 debian rtpengine[11823]: INFO: [ui7jc53b9lfbt9lf4nu7/a5935482-=
3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [crypto] DTLS-SRTP successfully ne=
gotiated using AES_CM_128_HMAC_SHA1_80
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7/a5935482=
-3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [srtp] SRTP keys, incoming:
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7/a5935482=
-3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [srtp] --- AES_CM_128_HMAC_SHA1_8=
0 key AtAWESyBg5e6Ub3EPRQ5ag=3D=3D salt rgwpYXp6KpHCmfjMxVA=3D
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7/a5935482=
-3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [srtp] SRTP keys, outgoing:
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7/a5935482=
-3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [srtp] --- AES_CM_128_HMAC_SHA1_8=
0 key 8+zHcQ5a1Bv5L0dv2AfKyg=3D=3D salt 7YaPNc68d5ALtKKIOCQ=3D
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7/a5935482=
-3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [srtp] Sending DTLS packet
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7/a5935482=
-3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [core] Successful STUN binding re=
quest from 10.13.1.152:14450
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7/a5935482=
-3f00-4dd0-b98c-0b4726da777d/1]: [ice] Start nominating ICE pairs
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7/a5935482=
-3f00-4dd0-b98c-0b4726da777d/1]: [ice] Nominating ICE pair GtpEjl9r4IzNpiXr:H=
a0d0198:1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7/a5935482=
-3f00-4dd0-b98c-0b4726da777d/1]: [ice] Sending nominating ICE/STUN request fo=
r candidate pair GtpEjl9r4IzNpiXr:Ha0d0198:1 from 10.13.1.127 to 10.13.1.152:=
14450
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7/a5935482=
-3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [ice] Received ICE/STUN response =
code 0 for candidate pair GtpEjl9r4IzNpiXr:Ha0d0198:1 from 10.13.1.152:14450 =
to 10.13.1.127
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7/a5935482=
-3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [ice] Setting nominated ICE candi=
date pair GtpEjl9r4IzNpiXr:Ha0d0198:1 as valid
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7/a5935482=
-3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [ice] ICE completed, using pair G=
tpEjl9r4IzNpiXr:Ha0d0198:1
Mar 9 20:21:02 debian rtpengine[11823]: INFO: [ui7jc53b9lfbt9lf4nu7/a5935482-=
3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [ice] ICE negotiated: peer for com=
ponent 1 is 10.13.1.152:14450
Mar 9 20:21:02 debian rtpengine[11823]: INFO: [ui7jc53b9lfbt9lf4nu7/a5935482-=
3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [ice] ICE negotiated: local interf=
ace 10.13.1.127
Mar 9 20:21:02 debian rtpengine[11823]: INFO: [ui7jc53b9lfbt9lf4nu7]: [contro=
l] Received command 'answer' from 127.0.0.1:60024
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [contr=
ol] Dump for 'answer' from 127.0.0.1:60024: { "supports": [ "load limit" ], "=
sdp": "v=3D0
Mar 9 20:21:02 debian rtpengine[11823]: o=3D- 2654832326 4 IN IP4 10.13.1.152
Mar 9 20:21:02 debian rtpengine[11823]: s=3DAsterisk
Mar 9 20:21:02 debian rtpengine[11823]: c=3DIN IP4 10.13.1.152
Mar 9 20:21:02 debian rtpengine[11823]: t=3D0 0
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dmsid-semantic:WMS *
Mar 9 20:21:02 debian rtpengine[11823]: m=3Daudio 14450 UDP/TLS/RTP/SAVPF 111=
 126
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dconnection:new
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dsetup:active
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dfingerprint:SHA-256 62:AD:7E:86:4=
D:FF:87:6B:44:5A:F0:62:A2:37:D6:56:5C:D4:F4:A8:03:88:A6:E1:DD:2A:15:69:75:1B:=
04:3C
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dice-ufrag:7706bb5e0317151b5749cc8=
550354244
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dice-pwd:4af879c44cb99216424536fa5=
defd9d5
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dcandidate:Ha0d0198 1 UDP 21307064=
31 10.13.1.152 14450 typ host
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dcandidate:H6719a439 1 UDP 2130706=
431 103.25.164.57 14450 typ host
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtpmap:111 opus/48000/2
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtpmap:126 telephone-event/8000
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dfmtp:126 0-16
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dptime:20
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dmaxptime:20
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dsendrecv
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtcp-mux
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dmsid:d5be09fd-dce5-4d96-879e-f34f=
22f54ef1 a3f22c04-6988-4464-a458-5abc099e7bc0
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtcp-fb:* transport-cc
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dmid:0
Mar 9 20:21:02 debian rtpengine[11823]: ", "call-id": "ui7jc53b9lfbt9lf4nu7",=
 "received-from": [ "IP4", "10.13.1.152" ], "from-tag": "7n38ig1acl", "to-tag=
": "a5935482-3f00-4dd0-b98c-0b4726da777d", "command": "answer" }
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [core]=
 Using default bitrate of 32000 bps for 2-channel Opus
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Updating codecs for answerer a5935482-3f00-4dd0-b98c-0b4726da777d #1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Adding codec opus/48000/2 (111)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Adding codec telephone-event/8000 (126)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Setting up codec handlers for a5935482-3f00-4dd0-b98c-0b4726da777d #1 -> 7n=
38ig1acl #1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Default sink codec is opus/48000/2
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Checking receiver codec opus/48000/2 (111)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink codec for opus/48000/2 is opus/48000/2 (111)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink supports codec opus/48000/2 for passthrough
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Using passthrough handler for opus/48000/2 with DTMF -1, CN -1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Checking receiver codec telephone-event/8000/1 (126)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink codec for telephone-event/8000 is telephone-event/8000/1 (126)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink supports codec telephone-event/8000 for passthrough
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Using passthrough handler for telephone-event/8000 with DTMF 126, CN -1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Codec answer for a5935482-3f00-4dd0-b98c-0b4726da777d #1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Reverse codec for opus/48000/2 (111) is opus/48000/2 (111)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Reverse codec for telephone-event/8000 (126) is telephone-event/8000 (126)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] telephone-event/8000/1 payload type 126 already present, skip
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Setting up codec handlers for 7n38ig1acl #1 -> a5935482-3f00-4dd0-b98c-0b47=
26da777d #1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Default sink codec is opus/48000/2
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Checking receiver codec opus/48000/2 (111)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink codec for opus/48000/2 is opus/48000/2 (111)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink supports codec opus/48000/2 for passthrough
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Using passthrough handler for opus/48000/2 with DTMF -1, CN -1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Checking receiver codec telephone-event/8000/1 (126)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink codec for telephone-event/8000 is telephone-event/8000/1 (126)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink supports codec telephone-event/8000 for passthrough
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Using passthrough handler for telephone-event/8000 with DTMF 126, CN -1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Updating supplemental codecs for 7n38ig1acl #1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Updating supplemental codecs for a5935482-3f00-4dd0-b98c-0b4726da777d #1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Setting up codec handlers for 7n38ig1acl #1 -> a5935482-3f00-4dd0-b98c-0b47=
26da777d #1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Default sink codec is opus/48000/2
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Checking receiver codec opus/48000/2 (111)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink codec for opus/48000/2 is opus/48000/2 (111)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink supports codec opus/48000/2 for passthrough
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Using passthrough handler for opus/48000/2 with DTMF -1, CN -1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Checking receiver codec telephone-event/8000/1 (126)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink codec for telephone-event/8000 is telephone-event/8000/1 (126)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink supports codec telephone-event/8000 for passthrough
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Using passthrough handler for telephone-event/8000 with DTMF 126, CN -1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Setting up codec handlers for a5935482-3f00-4dd0-b98c-0b4726da777d #1 -> 7n=
38ig1acl #1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Default sink codec is opus/48000/2
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Checking receiver codec opus/48000/2 (111)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink codec for opus/48000/2 is opus/48000/2 (111)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink supports codec opus/48000/2 for passthrough
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Using passthrough handler for opus/48000/2 with DTMF -1, CN -1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Checking receiver codec telephone-event/8000/1 (126)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink codec for telephone-event/8000 is telephone-event/8000/1 (126)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Sink supports codec telephone-event/8000 for passthrough
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [codec=
] Using passthrough handler for telephone-event/8000 with DTMF 126, CN -1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [ice] =
Dropping new ICE candidate Ha0d0198 in favour of Ha0d0198:1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [ice] =
Dropping new ICE candidate H6719a439 in favour of H6719a439:1
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [ice] =
Shutting down ICE agent (nothing to do)
Mar 9 20:21:02 debian rtpengine[11823]: INFO: [ui7jc53b9lfbt9lf4nu7]: [contro=
l] Replying to 'answer' from 127.0.0.1:60024 (elapsed time 0.002244 sec)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7]: [contr=
ol] Response dump for 'answer' to 127.0.0.1:60024: { "sdp": "v=3D0
Mar 9 20:21:02 debian rtpengine[11823]: o=3D- 2654832326 4 IN IP4 10.13.1.152
Mar 9 20:21:02 debian rtpengine[11823]: s=3DAsterisk
Mar 9 20:21:02 debian rtpengine[11823]: c=3DIN IP4 10.13.1.127
Mar 9 20:21:02 debian rtpengine[11823]: t=3D0 0
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dmsid-semantic:WMS *
Mar 9 20:21:02 debian rtpengine[11823]: m=3Daudio 30020 UDP/TLS/RTP/SAVPF 111=
 126
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dconnection:new
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dmaxptime:20
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dmsid:d5be09fd-dce5-4d96-879e-f34f=
22f54ef1 a3f22c04-6988-4464-a458-5abc099e7bc0
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtcp-fb:* transport-cc
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dmid:0
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtpmap:111 opus/48000/2
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtpmap:126 telephone-event/8000
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dfmtp:126 0-16
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dsendrecv
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtcp:30020
Mar 9 20:21:02 debian rtpengine[11823]: a=3Drtcp-mux
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dsetup:active
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dfingerprint:sha-256 0C:67:09:6B:A=
E:6B:30:09:81:C5:9C:65:C6:EC:9E:CE:C2:6E:E2:EA:67:B4:B5:B3:40:C4:F1:0C:3E:05:=
96:79
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dtls-id:ac2907348568344c9743f21fa1=
383e08
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dptime:20
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dice-ufrag:4xVkmu6h
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dice-pwd:kc54UEYL25S4UjgSjVKJdcEiAR
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dice-options:trickle
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dcandidate:GtpEjl9r4IzNpiXr 1 UDP =
2130706431 10.13.1.127 30020 typ host
Mar 9 20:21:02 debian rtpengine[11823]: a=3Dend-of-candidates
Mar 9 20:21:02 debian rtpengine[11823]: ", "result": "ok" }
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7/a5935482=
-3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [core] New ingress SSRC for: 10.1=
3.1.152:14450 SSRC: 46ca8abf
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7/a5935482=
-3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [core] Handling packet: remote 10=
.13.1.152:14450 (expected: 10.13.1.152:14450) -> local 10.13.1.127:30000 (RTP=
 seq 31783 TS 528 SSRC 46ca8abf)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7/a5935482=
-3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [srtp] Generated session key: mas=
ter key f3ecc771..., master salt ed868f35..., label 00, length 16, result 680=
6f5cc...
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7/a5935482=
-3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [srtp] Generated session key: mas=
ter key f3ecc771..., master salt ed868f35..., label 01, length 20, result 044=
b0cce...
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7/a5935482=
-3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [srtp] Generated session key: mas=
ter key f3ecc771..., master salt ed868f35..., label 02, length 14, result 442=
6c95d...
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7/a5935482=
-3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [core] New egress (direct) SSRC f=
or: 0.0.0.0:9 SSRC: 46ca8abf
Mar 9 20:21:02 debian rtpengine[11823]: ERR: [ui7jc53b9lfbt9lf4nu7/a5935482-3=
f00-4dd0-b98c-0b4726da777d/1 port 30000]: [core] SRTP output wanted, but no c=
rypto suite was negotiated
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7/a5935482=
-3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [core] Error when sending message=
. Error: Inappropriate ioctl for device
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7/a5935482=
-3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [core] Handling packet: remote 10=
.13.1.152:14450 (expected: 10.13.1.152:14450) -> local 10.13.1.127:30000 (RTP=
 seq 31784 TS 1488 SSRC 46ca8abf)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7/a5935482=
-3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [core] Handling packet: remote 10=
.13.1.152:14450 (expected: 10.13.1.152:14450) -> local 10.13.1.127:30000 (RTP=
 seq 31785 TS 2448 SSRC 46ca8abf)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7/a5935482=
-3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [core] Handling packet: remote 10=
.13.1.152:14450 (expected: 10.13.1.152:14450) -> local 10.13.1.127:30000 (RTP=
 seq 31786 TS 3408 SSRC 46ca8abf)
Mar 9 20:21:02 debian rtpengine[11823]: DEBUG: [ui7jc53b9lfbt9lf4nu7/a5935482=
-3f00-4dd0-b98c-0b4726da777d/1 port 30000]: [core] Handling packet: remote 10=
.13.1.152:14450 (expected:

--===============0533717070==--