Use of single code and code-accept prevents kernel forwarding?
16 views
Skip to first unread message
Dave Horton
Nov 12, 2025, 10:58:21 AMNov 12
to rtpe...@googlegroups.com
I am sending an offer with these flags:
5:flagsl12:single codec11:inject DTMFe
and later an answer with these
17:codec-accept-PCMU28:codec-accept-telephone-event
Now I have an incoming call offering PCMU and the call gets set up with PCMU on both sides. I would expect the media stream to be handled by the kernel module, which I have loaded, and yet when I check the stats I see that non of the media streams are being handled by the kernel module
rtpengine-ctl list totals
Statistics over currently running sessions:
Owned sessions :226
Foreign sessions :0
Total sessions :226
Transcoded media :229
Packets per second (userspace) :0
Bytes per second (userspace) :0
Errors per second (userspace) :0
Packets per second (kernel) :0
Bytes per second (kernel) :0
Errors per second (kernel) :0
Packets per second (total) :0
Bytes per second (total) :0
Errors per second (total) :0
Userspace-only media streams :356
Kernel-only media streams :0
Mixed kernel/userspace media streams :0
Does the use of some of the flags I am using cause all streams to be treated as if they are being transcoded, even when PCMU is being used on both sides?
I am using rtpengine version mr11.5.1.45
Dave
5:flagsl12:single codec11:inject DTMFe
and later an answer with these
17:codec-accept-PCMU28:codec-accept-telephone-event
Now I have an incoming call offering PCMU and the call gets set up with PCMU on both sides. I would expect the media stream to be handled by the kernel module, which I have loaded, and yet when I check the stats I see that non of the media streams are being handled by the kernel module
rtpengine-ctl list totals
Statistics over currently running sessions:
Owned sessions :226
Foreign sessions :0
Total sessions :226
Transcoded media :229
Packets per second (userspace) :0
Bytes per second (userspace) :0
Errors per second (userspace) :0
Packets per second (kernel) :0
Bytes per second (kernel) :0
Errors per second (kernel) :0
Packets per second (total) :0
Bytes per second (total) :0
Errors per second (total) :0
Userspace-only media streams :356
Kernel-only media streams :0
Mixed kernel/userspace media streams :0
Does the use of some of the flags I am using cause all streams to be treated as if they are being transcoded, even when PCMU is being used on both sides?
I am using rtpengine version mr11.5.1.45
Dave
Dave Horton
Nov 12, 2025, 11:02:03 AMNov 12
to rtpe...@googlegroups.com
One additional thing. I see these warnings in the log
NOTICE: [82ca18f2-3a83-123f-53be-0eaa8e387a41/as22777369/1 port 56193]: [core] Setting 'non-forwarding' flag for kernel stream due to lack of sinks
Always referencing the rtcp port. There is not some issue where if the rtcp messages cant be forwarded by the kernel then the rtp stream is not either, is there?
NOTICE: [82ca18f2-3a83-123f-53be-0eaa8e387a41/as22777369/1 port 56193]: [core] Setting 'non-forwarding' flag for kernel stream due to lack of sinks
Always referencing the rtcp port. There is not some issue where if the rtcp messages cant be forwarded by the kernel then the rtp stream is not either, is there?
David Horton
Nov 12, 2025, 11:09:35 AMNov 12
to Sipwise rtpengine
Oh, sorry in my initial message I switched the offer and answer..
The offer flags were: 17:codec-accept-PCMU28:codec-accept-telephone-event
and the answer flags were: 5:flagsl12:single codec11:inject DTMFe
So, do those flags somehow force all streams to be handled in userspace?
So, do those flags somehow force all streams to be handled in userspace?
Alex Balashov
Nov 12, 2025, 11:12:04 AMNov 12
to rtpe...@googlegroups.com
> On Nov 12, 2025, at 11:09 AM, David Horton <da...@drachtio.org> wrote:
>
> So, do those flags somehow force all streams to be handled in userspace?
-- Alex
--
Alex Balashov
Principal Consultant
Evariste Systems LLC
Web: https://evaristesys.com, https://www.csrpswitch.com
Tel: +1-706-510-6800
Richard Fuchs
Nov 12, 2025, 12:08:21 PMNov 12
to rtpe...@googlegroups.com
On 12/11/2025 12.01, Dave Horton wrote:
I am sending an offer with these flags: 5:flagsl12:single codec11:inject DTMFe
The "inject DTMF" flag is what is preventing it from being handled by the kernel. Reason being that when DTMF injection is requested, this obviously must be handled by the user space, and the current state of the RTP stream (codec, sequencing, time stamps, etc) must be known precisely at that exact moment.
There have been some improvements in this regard in later versions (e.g. shared memory between kernel and user space so that both have the exact same knowledge about the RTP streams at all times) and for certain scenarios this made it possible to still have streams handled by the kernel and then pull them back to user space only when needed, but off the top of my head I can't say if DTMF injection is one of these scenarios.
Cheers
David Horton
Nov 13, 2025, 11:24:59 AMNov 13
to Sipwise rtpengine
Hmm I have removed the "inject DMTF" flag and retested, and the results were interesting. I now see in the logs that rtpengine is "Kernelizing media stream" however, the logging and subsequent statistics command indicate that the media is being passed in userspace. Any idea what could account for this? Here is a portion of the debug log
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: INFO: [2bff51285f484a2f...@0.0.0.0]: [control] Received command 'offer' from 127.0.0.1:7001
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [control] Dump for 'offer' from 127.0.0.1:7001: { "DTLS": "off", "ICE": "remove", "SDES": "off", "call-id": "2bff51285f484a2f...@0.0.0.0", "command": "offer", "direction": [ "public", "private" ], "flags": [ "port latching", "media handover", "media handover" ], "from-tag": "49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847", "record call": "no", "replace": [ "origin", "session-connection" ], "rtcp-mux": [ "accept" ], "sdp": "v=0
o=root 435486840 435486840 IN IP4 172.18.160.54 ...
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: ...
s=Twilio Media Gateway
c=IN IP4 168.86.138.252
t=0 0
m=audio 17616 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=maxptime:20
a=sendrecv
", "transport protocol": "RTP/AVP" }
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: NOTICE: [2bff51285f484a2f...@0.0.0.0]: [core] Creating new call
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] Subscribing '49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847' to ''
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] Subscribing '' to '49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847'
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Updating codecs for offerer 49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847 #1
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Adding codec PCMU/8000 (0)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Adding codec PCMA/8000 (8)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Adding codec telephone-event/8000 (101)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Updating codecs for answerer #1
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Adding codec PCMU/8000 (0)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Adding codec PCMA/8000 (8)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Adding codec telephone-event/8000 (101)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Updating supplemental codecs for #1
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Setting up codec handlers for #1 -> 49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847 #1
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Default sink codec is PCMU/8000 (0)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Checking receiver codec PCMU/8000/1 (0)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Creating codec handler for PCMU/8000 (0)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink codec for PCMU/8000 is PCMU/8000/1 (0)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink supports codec PCMU/8000 (0) for passthrough (to 0)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Using passthrough handler for PCMU/8000 (0) with DTMF 101, CN -1
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Checking receiver codec PCMA/8000/1 (8)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Creating codec handler for PCMA/8000 (8)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink codec for PCMA/8000 is PCMA/8000/1 (8)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink supports codec PCMA/8000 (8) for passthrough (to 8)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Using passthrough handler for PCMA/8000 (8) with DTMF 101, CN -1
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Checking receiver codec telephone-event/8000/1 (101)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Creating codec handler for telephone-event/8000 (101)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink codec for telephone-event/8000 is telephone-event/8000/1 (101)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink supports codec telephone-event/8000 (101) for passthrough (to 101)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Using passthrough handler for telephone-event/8000 (101) with DTMF 101, CN -1
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Updating supplemental codecs for #1
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Setting up codec handlers for #1 -> 49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847 #1
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Default sink codec is PCMU/8000 (0)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Checking receiver codec PCMU/8000/1 (0)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink codec for PCMU/8000 is PCMU/8000/1 (0)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink supports codec PCMU/8000 (0) for passthrough (to 0)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Using passthrough handler for PCMU/8000 (0) with DTMF 101, CN -1
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Checking receiver codec PCMA/8000/1 (8)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink codec for PCMA/8000 is PCMA/8000/1 (8)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink supports codec PCMA/8000 (8) for passthrough (to 8)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Using passthrough handler for PCMA/8000 (8) with DTMF 101, CN -1
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Checking receiver codec telephone-event/8000/1 (101)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink codec for telephone-event/8000 is telephone-event/8000/1 (101)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink supports codec telephone-event/8000 (101) for passthrough (to 101)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Using passthrough handler for telephone-event/8000 (101) with DTMF 101, CN -1
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] Trying to bind the socket for RTP/RTCP ports (allocation attempt = '1')
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] Trying to bind the socket for port = '41086'
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] Trying to bind the socket for port = '41087'
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] Opened a socket on port '41086' (on interface '172.20.11.174') for a media relay
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] Trying to bind the socket for RTP/RTCP ports (allocation attempt = '1')
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] Trying to bind the socket for port = '46616'
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] Trying to bind the socket for port = '46617'
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] Opened a socket on port '46616' (on interface '172.20.11.174') for a media relay
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] set FILLED flag for stream, local 172.20.11.174:46616 remote 168.86.138.252:17616
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] set FILLED flag for stream, local 172.20.11.174:46617 remote 168.86.138.252:17617
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: INFO: [2bff51285f484a2f...@0.0.0.0]: [control] Replying to 'offer' from 127.0.0.1:7001 (elapsed time 0.000398 sec)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [control] Response dump for 'offer' to 127.0.0.1:7001: { "sdp": "v=0
o=root 435486840 435486840 IN IP4 172.20.11.174
s=Twilio Media Gateway
c=IN IP4 172.20.11.174
t=0 0
m=audio 41086 RTP/AVP 0 8 101
a=maxptime:20
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=sendrecv
a=rtcp:41087
a=ptime:20
", "result": "ok" }
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: INFO: [2bff51285f484a2f...@0.0.0.0]: [control] Received command 'answer' from 127.0.0.1:7001
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [control] Dump for 'answer' from 127.0.0.1:7001: { "DTLS": "off", "ICE": "remove", "SDES": "off", "call-id": "2bff51285f484a2f...@0.0.0.0", "command": "answer", "flags": [ "port latching", "media handover", "media handover" ], "from-tag": "49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847", "record call": "no", "replace": [ "origin", "session-connection" ], "rtcp-mux": [ "accept" ], "sdp": "v=0
o=Mediaserver 1763018871 1763018872 IN IP4 172.20.11.254
s=Mediase ...
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: ... rver
c=IN IP4 172.20.11.254
t=0 0
m=audio 30902 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:20
a=sendrecv
a=rtcp:30903 IN IP4 172.20.11.254
", "to-tag": "SDvKmZ2e0mvmc", "transport protocol": "RTP/AVP" }
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] Unconfirming peer address for local 172.20.11.174:41086 (dialogue signalling event)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] Unconfirming peer address for local 172.20.11.174:46616 (dialogue signalling event)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] Unconfirming peer address for local 172.20.11.174:41087 (dialogue signalling event)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] Unconfirming peer address for local 172.20.11.174:46617 (dialogue signalling event)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] Unsubscribing '49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847' from 'SDvKmZ2e0mvmc'
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] Unsubscribing 'SDvKmZ2e0mvmc' from '49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847'
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] Subscribing 'SDvKmZ2e0mvmc' to '49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847'
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] Subscribing '49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847' to 'SDvKmZ2e0mvmc'
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Updating codecs for answerer SDvKmZ2e0mvmc #1
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Adding codec PCMU/8000 (0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Adding codec telephone-event/8000 (101)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Setting up codec handlers for SDvKmZ2e0mvmc #1 -> 49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847 #1
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Default sink codec is PCMU/8000 (0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Checking receiver codec PCMU/8000/1 (0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink codec for PCMU/8000 is PCMU/8000/1 (0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink supports codec PCMU/8000 (0) for passthrough (to 0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Using passthrough handler for PCMU/8000 (0) with DTMF 101, CN -1
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Checking receiver codec telephone-event/8000/1 (101)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink codec for telephone-event/8000 is telephone-event/8000/1 (101)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink supports codec telephone-event/8000 (101) for passthrough (to 101)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Using passthrough handler for telephone-event/8000 (101) with DTMF 101, CN -1
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Codec answer for SDvKmZ2e0mvmc #1
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Reverse codec for PCMU/8000 (0) is PCMU/8000 (0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Reverse codec for telephone-event/8000 (101) is telephone-event/8000 (101)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] telephone-event/8000/1 payload type 101 already present, skip
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] telephone-event/8000/1 payload type 101 already present, skip
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Setting up codec handlers for 49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847 #1 -> SDvKmZ2e0mvmc #1
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Default sink codec is PCMU/8000 (0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Checking receiver codec PCMU/8000/1 (0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Creating codec handler for PCMU/8000 (0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink codec for PCMU/8000 is PCMU/8000/1 (0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink supports codec PCMU/8000 (0) for passthrough (to 0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Using passthrough handler for PCMU/8000 (0) with DTMF 101, CN -1
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Checking receiver codec telephone-event/8000/1 (101)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Creating codec handler for telephone-event/8000 (101)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink codec for telephone-event/8000 is telephone-event/8000/1 (101)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink supports codec telephone-event/8000 (101) for passthrough (to 101)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Using passthrough handler for telephone-event/8000 (101) with DTMF 101, CN -1
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Updating supplemental codecs for 49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847 #1
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Updating supplemental codecs for SDvKmZ2e0mvmc #1
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Setting up codec handlers for 49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847 #1 -> SDvKmZ2e0mvmc #1
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Default sink codec is PCMU/8000 (0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Checking receiver codec PCMU/8000/1 (0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink codec for PCMU/8000 is PCMU/8000/1 (0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink supports codec PCMU/8000 (0) for passthrough (to 0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Using passthrough handler for PCMU/8000 (0) with DTMF 101, CN -1
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Checking receiver codec telephone-event/8000/1 (101)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink codec for telephone-event/8000 is telephone-event/8000/1 (101)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink supports codec telephone-event/8000 (101) for passthrough (to 101)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Using passthrough handler for telephone-event/8000 (101) with DTMF 101, CN -1
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Setting up codec handlers for SDvKmZ2e0mvmc #1 -> 49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847 #1
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Default sink codec is PCMU/8000 (0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Checking receiver codec PCMU/8000/1 (0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink codec for PCMU/8000 is PCMU/8000/1 (0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink supports codec PCMU/8000 (0) for passthrough (to 0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Using passthrough handler for PCMU/8000 (0) with DTMF 101, CN -1
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Checking receiver codec telephone-event/8000/1 (101)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink codec for telephone-event/8000 is telephone-event/8000/1 (101)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink supports codec telephone-event/8000 (101) for passthrough (to 101)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Using passthrough handler for telephone-event/8000 (101) with DTMF 101, CN -1
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] set FILLED flag for stream, local 172.20.11.174:41086 remote 172.20.11.254:30902
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] set FILLED flag for stream, local 172.20.11.174:41087 remote 172.20.11.254:30903
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: INFO: [2bff51285f484a2f...@0.0.0.0]: [control] Replying to 'answer' from 127.0.0.1:7001 (elapsed time 0.000334 sec)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [control] Response dump for 'answer' to 127.0.0.1:7001: { "sdp": "v=0
o=Mediaserver 1763018871 1763018872 IN IP4 3.148.70.168
s=Mediaserver
c=IN IP4 3.148.70.168
t=0 0
m=audio 46616 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv
a=rtcp:46617
a=ptime:20
", "result": "ok" }
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/SDvKmZ2e0mvmc/1 port 41086]: [core] New ingress SSRC for: 172.20.11.254:30902 SSRC: b52a7145
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/SDvKmZ2e0mvmc/1 port 41086]: [core] Handling packet: remote 172.20.11.254:30902 (expected: 172.20.11.254:30902) -> local 172.20.11.174:41086 (RTP seq 12649 TS 160 SSRC b52a7145)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/SDvKmZ2e0mvmc/1 port 41086]: [core] New egress (direct) SSRC for: 168.86.138.252:17616 SSRC: b52a7145
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847/1 port 46616]: [core] Forward to sink endpoint: local 172.20.11.174:46616 -> remote 168.86.138.252:17616 (RTP seq 12649 TS 160 SSRC b52a7145)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/SDvKmZ2e0mvmc/1 port 41086]: [core] Handling packet: remote 172.20.11.254:30902 (expected: 172.20.11.254:30902) -> local 172.20.11.174:41086 (RTP seq 12650 TS 320 SSRC b52a7145)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847/1 port 46616]: [core] Forward to sink endpoint: local 172.20.11.174:46616 -> remote 168.86.138.252:17616 (RTP seq 12650 TS 320 SSRC b52a7145)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847/1 port 46616]: [core] New ingress SSRC for: 168.86.138.252:17616 SSRC: 5f263cbd
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847/1 port 46616]: [core] Handling packet: remote 168.86.138.252:17616 (expected: 168.86.138.252:17616) -> local 172.20.11.174:46616 (RTP seq 5313 TS 0 SSRC 5f263cbd)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847/1 port 46616]: [core] New egress (direct) SSRC for: 172.20.11.254:30902 SSRC: 5f263cbd
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/SDvKmZ2e0mvmc/1 port 41086]: [core] Forward to sink endpoint: local 172.20.11.174:41086 -> remote 172.20.11.254:30902 (RTP seq 5313 TS 0 SSRC 5f263cbd)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/SDvKmZ2e0mvmc/1 port 41086]: [core] Handling packet: remote 172.20.11.254:30902 (expected: 172.20.11.254:30902) -> local 172.20.11.174:41086 (RTP seq 12651 TS 480 SSRC b52a7145)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847/1 port 46616]: [core] Forward to sink endpoint: local 172.20.11.174:46616 -> remote 168.86.138.252:17616 (RTP seq 12651 TS 480 SSRC b52a7145)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847/1 port 46616]: [core] Handling packet: remote 168.86.138.252:17616 (expected: 168.86.138.252:17616) -> local 172.20.11.174:46616 (RTP seq 5314 TS 160 SSRC 5f263cbd)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/SDvKmZ2e0mvmc/1 port 41086]: [core] Forward to sink endpoint: local 172.20.11.174:41086 -> remote 172.20.11.254:30902 (RTP seq 5314 TS 160 SSRC 5f263cbd)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/SDvKmZ2e0mvmc/1 port 41086]: [core] Handling packet: remote 172.20.11.254:30902 (expected: 172.20.11.254:30902) -> local 172.20.11.174:41086 (RTP seq 12652 TS 640 SSRC b52a7145)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847/1 port 46616]: [core] Forward to sink endpoint: local 172.20.11.174:46616 -> remote 168.86.138.252:17616 (RTP seq 12652 TS 640 SSRC b52a7145)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847/1 port 46616]: [core] Handling packet: remote 168.86.138.252:17616 (expected: 168.86.138.252:17616) -> local 172.20.11.174:46616 (RTP seq 5315 TS 320 SSRC 5f263cbd)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/SDvKmZ2e0mvmc/1 port 41086]: [core] Forward to sink endpoint: local 172.20.11.174:41086 -> remote 172.20.11.254:30902 (RTP seq 5315 TS 320 SSRC 5f263cbd)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/SDvKmZ2e0mvmc/1 port 41086]: [core] Handling packet: remote 172.20.11.254:30902 (expected: 172.20.11.254:30902) -> local 172.20.11.174:41086 (RTP seq 12653 TS 800 SSRC b52a7145)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847/1 port 46616]: [core] Forward to sink endpoint: local 172.20.11.174:46616 -> remote 168.86.138.252:17616 (RTP seq 12653 TS 800 SSRC b52a7145)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847/1 port 46616]: [core] Handling packet: remote 168.86.138.252:17616 (expected: 168.86.138.252:17616) -> local 172.20.11.174:46616 (RTP seq 5316 TS 480 SSRC 5f263cbd)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/SDvKmZ2e0mvmc/1 port 41086]: [core] Forward to sink endpoint: local 172.20.11.174:41086 -> remote 172.20.11.254:30902 (RTP seq 5316 TS 480 SSRC 5f263cbd)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/SDvKmZ2e0mvmc/1 port 41086]: [core] Handling packet: remote 172.20.11.254:30902 (expected: 172.20.11.254:30902) -> local 172.20.11.174:41086 (RTP seq 12654 TS 960 SSRC b52a7145)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847/1 port 46616]: [core] Forward to sink endpoint: local 172.20.11.174:46616 -> remote 168.86.138.252:17616 (RTP seq 12654 TS 960 SSRC b52a7145)
Nov 13 16:02:57 ip-172-20-11-174 rtpengine[2388428]: INFO: [2bff51285f484a2f...@0.0.0.0/49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847/1 port 46616]: [core] Kernelizing media stream: 168.86.138.252:17616 -> 172.20.11.174:46616 | 172.20.11.174:41086 -> 172.20.11.254:30902
Nov 13 16:02:57 ip-172-20-11-174 rtpengine[2388428]: INFO: [2bff51285f484a2f...@0.0.0.0/SDvKmZ2e0mvmc/1 port 41086]: [core] Confirmed peer address as 172.20.11.254:30902
Nov 13 16:02:57 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/SDvKmZ2e0mvmc/1 port 41086]: [core] Handling packet: remote 172.20.11.254:30902 (expected: 172.20.11.254:30902) -> local 172.20.11.174:41086 (RTP seq 12813 TS 26400 SSRC b52a7145)
Nov 13 16:02:57 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847/1 port 46616]: [core] Forward to sink endpoint: local 172.20.11.174:46616 -> remote 168.86.138.252:17616 (RTP seq 12813 TS 26400 SSRC b52a7145)
Nov 13 16:02:57 ip-172-20-11-174 rtpengine[2388428]: INFO: [2bff51285f484a2f...@0.0.0.0/SDvKmZ2e0mvmc/1 port 41086]: [core] Kernelizing media stream: 172.20.11.254:30902 -> 172.20.11.174:41086 | 172.20.11.174:46616 -> 168.86.138.252:17616
** we continue to see these logs - does this mean it is still being handled in userspace?
Nov 13 16:02:57 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847/1 port 46616]: [core] Handling packet: remote 168.86.138.252:17616 (expected: 168.86.138.252:17616) -> local 172.20.11.174:46616 (RTP seq 5500 TS 29920 SSRC 5f263cbd)
Nov 13 16:02:57 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/SDvKmZ2e0mvmc/1 port 41086]: [core] Forward to sink endpoint: local 172.20.11.174:41086 -> remote 172.20.11.254:30902 (RTP seq 5500 TS 29920 SSRC 5f263cbd)
Nov 13 16:02:57 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/SDvKmZ2e0mvmc/1 port 41086]: [core] Handling packet: remote 172.20.11.254:30902 (expected: 172.20.11.254:30902) -> local 172.20.11.174:41086 (RTP seq 12839 TS 30560 SSRC b52a7145)
Nov 13 16:02:57 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847/1 port 46616]: [core] Forward to sink endpoint: local 172.20.11.174:46616 -> remote 168.86.138.252:17616 (RTP seq 12839 TS 30560 SSRC b52a7145)
*** later, statistics command shows nothing is going through kernel module
Nov 13 16:03:03 ip-172-20-11-174 rtpengine[2388428]: INFO: [control] Replying to 'statistics' from 127.0.0.1:36714 (elapsed time 0.000314 sec)
Nov 13 16:03:03 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [control] Response dump for 'statistics' to 127.0.0.1:36714: { "statistics": { "currentstatistics": { "sessionsown": 1, "sessionsforeign": 0, "sessionstotal": 1, "transcodedmedia": 0, "packetrate_user": 0, "byterate_user": 0, "errorrate_user": 0, "packetrate_kernel": 0, "byterate_kernel": 0, "errorrate_kernel": 0, "packetrate": 0, "byterate": 0, "errorrate": 0, "media_userspace": 2, "media_kernel": 0, "media_mixed": 0 }, "totalstatistics": { "uptime": "4244", "managedsessions": 10, "rejectedsess ...
Nov 13 16:03:03 ip-172-20-11-174 rtpengine[2388428]: DEBUG: ... ions": 0, "timeoutsessions": 0, "silenttimeoutsessions": 0, "finaltimeoutsessions": 0, "offertimeoutsessions": 0, "regularterminatedsessions": 10, "forcedterminatedsessions": 0, "relayedpackets_user": 9942, "relayedpacketerrors_user": 10, "relayedbytes_user": 1699164, "relayedpackets_kernel": 0, "relayedpacketerrors_kernel": 0, "relayedbytes_kernel": 0, "relayedpackets": 9942, "relayedpacketerrors": 10, "relayedbytes": 1699164, "zerowaystreams": 0, "onewaystreams": 0, "avgcallduration": "10.6707 ...
Nov 13 16:03:03 ip-172-20-11-174 rtpengine[2388428]: DEBUG: ... 88", "totalcallsduration": "106.707887", "totalcallsduration2": "1264.834655", "totalcallsduration_stddev": "3.552147" }, "mos": { "mos_total": "55.900000", "mos2_total": "240.370000", "mos_samples_total": 13, "mos_average": "4.300000", "mos_stddev": "0.000000" }, "voip_metrics": { "jitter_total": "1.000000", "jitter2_total": "1.000000", "jitter_samples_total": 23, "jitter_average": "0.000000", "jitter_stddev": "0.000000", "rtt_e2e_total": "268257.000000", "rtt_e2e2_total": "5562974773.000000", ...
Nov 13 16:03:03 ip-172-20-11-174 rtpengine[2388428]: DEBUG: ... "rtt_e2e_samples_total": 23, "rtt_e2e_average": "11663.000000", "rtt_e2e_stddev": "10287.000000", "rtt_dsct_total": "251044.000000", "rtt_dsct2_total": "3034477534.000000", "rtt_dsct_samples_total": 23, "rtt_dsct_average": "10914.000000", "rtt_dsct_stddev": "3577.000000", "packetloss_total": "0.000000", "packetloss2_total": "0.000000", "packetloss_samples_total": 23, "packetloss_average": "0.000000", "packetloss_stddev": "0.000000", "jitter_measured_total": "0.000000", "jitter_measured2_total": ...
Nov 13 16:03:03 ip-172-20-11-174 rtpengine[2388428]: DEBUG: ... "0.000000", "jitter_measured_samples_total": 0, "jitter_measured_average": "0.000000", "jitter_measured_stddev": "0.000000", "packets_lost": 0, "rtp_duplicates": 0, "rtp_skips": 0, "rtp_seq_resets": 0, "rtp_reordered": 0 }, "controlstatistics": { "proxies": [ { "proxy": "127.0.0.1", "pingcount": 565, "pingduration": "0.000470", "offercount": 11, "offerduration": "0.007761", "answercount": 11, "answerduration": "0.004070", "deletecount": 10, "deleteduration": "0.001398", "querycount": 0, "querydu ...
Nov 13 16:03:03 ip-172-20-11-174 rtpengine[2388428]: DEBUG: ... ration": "0.000000", "listcount": 0, "listduration": "0.000000", "startreccount": 0, "startrecduration": "0.000000", "stopreccount": 0, "stoprecduration": "0.000000", "pausereccount": 0, "pauserecduration": "0.000000", "startfwdcount": 0, "startfwdduration": "0.000000", "stopfwdcount": 0, "stopfwdduration": "0.000000", "blkdtmfcount": 0, "blkdtmfduration": "0.000000", "unblkdtmfcount": 0, "unblkdtmfduration": "0.000000", "blkmediacount": 0, "blkmediaduration": "0.000000", "unblkmediacount": 0, " ...
Nov 13 16:03:03 ip-172-20-11-174 rtpengine[2388428]: DEBUG: ... unblkmediaduration": "0.000000", "playmediacount": 0, "playmediaduration": "0.000000", "stopmediacount": 0, "stopmediaduration": "0.000000", "playdtmfcount": 0, "playdtmfduration": "0.000000", "statscount": 140, "statsduration": "0.047318", "slnmediacount": 0, "slnmediaduration": "0.000000", "unslnmediacount": 0, "unslnmediaduration": "0.000000", "pubcount": 0, "pubduration": "0.000000", "subreqcount": 0, "subreqduration": "0.000000", "subanscount": 0, "subansduration": "0.000000", "unsubcount": ...
Nov 13 16:03:03 ip-172-20-11-174 rtpengine[2388428]: DEBUG: ... 0, "unsubduration": "0.000000", "errorcount": 0 } ], "totalpingcount": 565, "totaloffercount": 11, "totalanswercount": 11, "totaldeletecount": 10, "totalquerycount": 0, "totallistcount": 0, "totalstartreccount": 0, "totalstopreccount": 0, "totalpausereccount": 0, "totalstartfwdcount": 0, "totalstopfwdcount": 0, "totalblkdtmfcount": 0, "totalunblkdtmfcount": 0, "totalblkmediacount": 0, "totalunblkmediacount": 0, "totalplaymediacount": 0, "totalstopmediacount": 0, "totalplaydtmfcount": 0, "totals ...
Nov 13 16:03:03 ip-172-20-11-174 rtpengine[2388428]: DEBUG: ... tatscount": 140, "totalslnmediacount": 0, "totalunslnmediacount": 0, "totalpubcount": 0, "totalsubreqcount": 0, "totalsubanscount": 0, "totalunsubcount": 0 }, "interfaces": [ { "name": "private", "address": "172.20.11.174", "ports": { "min": 40000, "max": 60000, "used": 4, "used_pct": "0.02", "free": 19997, "totals": 20001 }, "packets_lost": 0, "duplicates": 0, "voip_metrics": { "mos_total": "43.000000", "mos2_total": "184.900000", "mos_samples_total": 10, "mos_average": "4.300000", "mos_stddev" ...
Nov 13 16:03:03 ip-172-20-11-174 rtpengine[2388428]: DEBUG: ... : "0.000000", "jitter_total": "1.000000", "jitter2_total": "1.000000", "jitter_samples_total": 11, "jitter_average": "0.000000", "jitter_stddev": "0.000000", "rtt_e2e_total": "205670.000000", "rtt_e2e2_total": "4254002264.000000", "rtt_e2e_samples_total": 11, "rtt_e2e_average": "18697.000000", "rtt_e2e_stddev": "6094.000000", "rtt_dsct_total": "100961.000000", "rtt_dsct2_total": "1139902951.000000", "rtt_dsct_samples_total": 11, "rtt_dsct_average": "9178.000000", "rtt_dsct_stddev": "4403.000000" ...
Nov 13 16:03:03 ip-172-20-11-174 rtpengine[2388428]: DEBUG: ... , "packetloss_total": "0.000000", "packetloss2_total": "0.000000", "packetloss_samples_total": 11, "packetloss_average": "0.000000", "packetloss_stddev": "0.000000", "jitter_measured_total": "0.000000", "jitter_measured2_total": "0.000000", "jitter_measured_samples_total": 0, "jitter_measured_average": "0.000000", "jitter_measured_stddev": "0.000000" }, "ingress": { "packets": 4982, "bytes": 855704, "errors": 0 }, "egress": { "packets": 4960, "bytes": 843460, "errors": 0 } }, { "name": "public", ...
Nov 13 16:03:03 ip-172-20-11-174 rtpengine[2388428]: DEBUG: ... "address": "172.20.11.174", "ports": { "min": 40000, "max": 60000, "used": 4, "used_pct": "0.02", "free": 19997, "totals": 20001 }, "packets_lost": 0, "duplicates": 0, "voip_metrics": { "mos_total": "12.900000", "mos2_total": "55.470000", "mos_samples_total": 3, "mos_average": "4.300000", "mos_stddev": "0.000000", "jitter_total": "0.000000", "jitter2_total": "0.000000", "jitter_samples_total": 12, "jitter_average": "0.000000", "jitter_stddev": "0.000000", "rtt_e2e_total": "62587.000000", "rtt_e ...
Nov 13 16:03:03 ip-172-20-11-174 rtpengine[2388428]: DEBUG: ... 2e2_total": "1308972509.000000", "rtt_e2e_samples_total": 12, "rtt_e2e_average": "5215.000000", "rtt_e2e_stddev": "9048.000000", "rtt_dsct_total": "150083.000000", "rtt_dsct2_total": "1894574583.000000", "rtt_dsct_samples_total": 12, "rtt_dsct_average": "12506.000000", "rtt_dsct_stddev": "1207.000000", "packetloss_total": "0.000000", "packetloss2_total": "0.000000", "packetloss_samples_total": 12, "packetloss_average": "0.000000", "packetloss_stddev": "0.000000", "jitter_measured_total": "0.0000 ...
Nov 13 16:03:03 ip-172-20-11-174 rtpengine[2388428]: DEBUG: ... 00", "jitter_measured2_total": "0.000000", "jitter_measured_samples_total": 0, "jitter_measured_average": "0.000000", "jitter_measured_stddev": "0.000000" }, "ingress": { "packets": 5014, "bytes": 843676, "errors": 0 }, "egress": { "packets": 4972, "bytes": 857804, "errors": 10 } } ], "transcoders": [ ] }, "result": "ok" }
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [control] Dump for 'offer' from 127.0.0.1:7001: { "DTLS": "off", "ICE": "remove", "SDES": "off", "call-id": "2bff51285f484a2f...@0.0.0.0", "command": "offer", "direction": [ "public", "private" ], "flags": [ "port latching", "media handover", "media handover" ], "from-tag": "49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847", "record call": "no", "replace": [ "origin", "session-connection" ], "rtcp-mux": [ "accept" ], "sdp": "v=0
o=root 435486840 435486840 IN IP4 172.18.160.54 ...
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: ...
s=Twilio Media Gateway
c=IN IP4 168.86.138.252
t=0 0
m=audio 17616 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=maxptime:20
a=sendrecv
", "transport protocol": "RTP/AVP" }
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: NOTICE: [2bff51285f484a2f...@0.0.0.0]: [core] Creating new call
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] Subscribing '49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847' to ''
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] Subscribing '' to '49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847'
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Updating codecs for offerer 49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847 #1
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Adding codec PCMU/8000 (0)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Adding codec PCMA/8000 (8)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Adding codec telephone-event/8000 (101)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Updating codecs for answerer #1
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Adding codec PCMU/8000 (0)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Adding codec PCMA/8000 (8)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Adding codec telephone-event/8000 (101)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Updating supplemental codecs for #1
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Setting up codec handlers for #1 -> 49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847 #1
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Default sink codec is PCMU/8000 (0)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Checking receiver codec PCMU/8000/1 (0)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Creating codec handler for PCMU/8000 (0)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink codec for PCMU/8000 is PCMU/8000/1 (0)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink supports codec PCMU/8000 (0) for passthrough (to 0)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Using passthrough handler for PCMU/8000 (0) with DTMF 101, CN -1
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Checking receiver codec PCMA/8000/1 (8)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Creating codec handler for PCMA/8000 (8)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink codec for PCMA/8000 is PCMA/8000/1 (8)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink supports codec PCMA/8000 (8) for passthrough (to 8)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Using passthrough handler for PCMA/8000 (8) with DTMF 101, CN -1
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Checking receiver codec telephone-event/8000/1 (101)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Creating codec handler for telephone-event/8000 (101)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink codec for telephone-event/8000 is telephone-event/8000/1 (101)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink supports codec telephone-event/8000 (101) for passthrough (to 101)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Using passthrough handler for telephone-event/8000 (101) with DTMF 101, CN -1
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Updating supplemental codecs for #1
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Setting up codec handlers for #1 -> 49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847 #1
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Default sink codec is PCMU/8000 (0)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Checking receiver codec PCMU/8000/1 (0)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink codec for PCMU/8000 is PCMU/8000/1 (0)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink supports codec PCMU/8000 (0) for passthrough (to 0)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Using passthrough handler for PCMU/8000 (0) with DTMF 101, CN -1
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Checking receiver codec PCMA/8000/1 (8)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink codec for PCMA/8000 is PCMA/8000/1 (8)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink supports codec PCMA/8000 (8) for passthrough (to 8)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Using passthrough handler for PCMA/8000 (8) with DTMF 101, CN -1
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Checking receiver codec telephone-event/8000/1 (101)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink codec for telephone-event/8000 is telephone-event/8000/1 (101)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink supports codec telephone-event/8000 (101) for passthrough (to 101)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Using passthrough handler for telephone-event/8000 (101) with DTMF 101, CN -1
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] Trying to bind the socket for RTP/RTCP ports (allocation attempt = '1')
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] Trying to bind the socket for port = '41086'
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] Trying to bind the socket for port = '41087'
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] Opened a socket on port '41086' (on interface '172.20.11.174') for a media relay
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] Trying to bind the socket for RTP/RTCP ports (allocation attempt = '1')
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] Trying to bind the socket for port = '46616'
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] Trying to bind the socket for port = '46617'
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] Opened a socket on port '46616' (on interface '172.20.11.174') for a media relay
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] set FILLED flag for stream, local 172.20.11.174:46616 remote 168.86.138.252:17616
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] set FILLED flag for stream, local 172.20.11.174:46617 remote 168.86.138.252:17617
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: INFO: [2bff51285f484a2f...@0.0.0.0]: [control] Replying to 'offer' from 127.0.0.1:7001 (elapsed time 0.000398 sec)
Nov 13 16:02:52 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [control] Response dump for 'offer' to 127.0.0.1:7001: { "sdp": "v=0
o=root 435486840 435486840 IN IP4 172.20.11.174
s=Twilio Media Gateway
c=IN IP4 172.20.11.174
t=0 0
m=audio 41086 RTP/AVP 0 8 101
a=maxptime:20
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=sendrecv
a=rtcp:41087
a=ptime:20
", "result": "ok" }
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: INFO: [2bff51285f484a2f...@0.0.0.0]: [control] Received command 'answer' from 127.0.0.1:7001
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [control] Dump for 'answer' from 127.0.0.1:7001: { "DTLS": "off", "ICE": "remove", "SDES": "off", "call-id": "2bff51285f484a2f...@0.0.0.0", "command": "answer", "flags": [ "port latching", "media handover", "media handover" ], "from-tag": "49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847", "record call": "no", "replace": [ "origin", "session-connection" ], "rtcp-mux": [ "accept" ], "sdp": "v=0
o=Mediaserver 1763018871 1763018872 IN IP4 172.20.11.254
s=Mediase ...
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: ... rver
c=IN IP4 172.20.11.254
t=0 0
m=audio 30902 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:20
a=sendrecv
a=rtcp:30903 IN IP4 172.20.11.254
", "to-tag": "SDvKmZ2e0mvmc", "transport protocol": "RTP/AVP" }
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] Unconfirming peer address for local 172.20.11.174:41086 (dialogue signalling event)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] Unconfirming peer address for local 172.20.11.174:46616 (dialogue signalling event)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] Unconfirming peer address for local 172.20.11.174:41087 (dialogue signalling event)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] Unconfirming peer address for local 172.20.11.174:46617 (dialogue signalling event)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] Unsubscribing '49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847' from 'SDvKmZ2e0mvmc'
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] Unsubscribing 'SDvKmZ2e0mvmc' from '49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847'
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] Subscribing 'SDvKmZ2e0mvmc' to '49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847'
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] Subscribing '49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847' to 'SDvKmZ2e0mvmc'
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Updating codecs for answerer SDvKmZ2e0mvmc #1
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Adding codec PCMU/8000 (0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Adding codec telephone-event/8000 (101)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Setting up codec handlers for SDvKmZ2e0mvmc #1 -> 49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847 #1
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Default sink codec is PCMU/8000 (0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Checking receiver codec PCMU/8000/1 (0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink codec for PCMU/8000 is PCMU/8000/1 (0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink supports codec PCMU/8000 (0) for passthrough (to 0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Using passthrough handler for PCMU/8000 (0) with DTMF 101, CN -1
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Checking receiver codec telephone-event/8000/1 (101)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink codec for telephone-event/8000 is telephone-event/8000/1 (101)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink supports codec telephone-event/8000 (101) for passthrough (to 101)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Using passthrough handler for telephone-event/8000 (101) with DTMF 101, CN -1
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Codec answer for SDvKmZ2e0mvmc #1
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Reverse codec for PCMU/8000 (0) is PCMU/8000 (0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Reverse codec for telephone-event/8000 (101) is telephone-event/8000 (101)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] telephone-event/8000/1 payload type 101 already present, skip
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] telephone-event/8000/1 payload type 101 already present, skip
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Setting up codec handlers for 49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847 #1 -> SDvKmZ2e0mvmc #1
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Default sink codec is PCMU/8000 (0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Checking receiver codec PCMU/8000/1 (0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Creating codec handler for PCMU/8000 (0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink codec for PCMU/8000 is PCMU/8000/1 (0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink supports codec PCMU/8000 (0) for passthrough (to 0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Using passthrough handler for PCMU/8000 (0) with DTMF 101, CN -1
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Checking receiver codec telephone-event/8000/1 (101)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Creating codec handler for telephone-event/8000 (101)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink codec for telephone-event/8000 is telephone-event/8000/1 (101)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink supports codec telephone-event/8000 (101) for passthrough (to 101)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Using passthrough handler for telephone-event/8000 (101) with DTMF 101, CN -1
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Updating supplemental codecs for 49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847 #1
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Updating supplemental codecs for SDvKmZ2e0mvmc #1
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Setting up codec handlers for 49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847 #1 -> SDvKmZ2e0mvmc #1
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Default sink codec is PCMU/8000 (0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Checking receiver codec PCMU/8000/1 (0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink codec for PCMU/8000 is PCMU/8000/1 (0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink supports codec PCMU/8000 (0) for passthrough (to 0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Using passthrough handler for PCMU/8000 (0) with DTMF 101, CN -1
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Checking receiver codec telephone-event/8000/1 (101)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink codec for telephone-event/8000 is telephone-event/8000/1 (101)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink supports codec telephone-event/8000 (101) for passthrough (to 101)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Using passthrough handler for telephone-event/8000 (101) with DTMF 101, CN -1
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Setting up codec handlers for SDvKmZ2e0mvmc #1 -> 49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847 #1
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Default sink codec is PCMU/8000 (0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Checking receiver codec PCMU/8000/1 (0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink codec for PCMU/8000 is PCMU/8000/1 (0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink supports codec PCMU/8000 (0) for passthrough (to 0)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Using passthrough handler for PCMU/8000 (0) with DTMF 101, CN -1
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Checking receiver codec telephone-event/8000/1 (101)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink codec for telephone-event/8000 is telephone-event/8000/1 (101)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Sink supports codec telephone-event/8000 (101) for passthrough (to 101)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [codec] Using passthrough handler for telephone-event/8000 (101) with DTMF 101, CN -1
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] set FILLED flag for stream, local 172.20.11.174:41086 remote 172.20.11.254:30902
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [core] set FILLED flag for stream, local 172.20.11.174:41087 remote 172.20.11.254:30903
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: INFO: [2bff51285f484a2f...@0.0.0.0]: [control] Replying to 'answer' from 127.0.0.1:7001 (elapsed time 0.000334 sec)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0]: [control] Response dump for 'answer' to 127.0.0.1:7001: { "sdp": "v=0
o=Mediaserver 1763018871 1763018872 IN IP4 3.148.70.168
s=Mediaserver
c=IN IP4 3.148.70.168
t=0 0
m=audio 46616 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv
a=rtcp:46617
a=ptime:20
", "result": "ok" }
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/SDvKmZ2e0mvmc/1 port 41086]: [core] New ingress SSRC for: 172.20.11.254:30902 SSRC: b52a7145
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/SDvKmZ2e0mvmc/1 port 41086]: [core] Handling packet: remote 172.20.11.254:30902 (expected: 172.20.11.254:30902) -> local 172.20.11.174:41086 (RTP seq 12649 TS 160 SSRC b52a7145)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/SDvKmZ2e0mvmc/1 port 41086]: [core] New egress (direct) SSRC for: 168.86.138.252:17616 SSRC: b52a7145
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847/1 port 46616]: [core] Forward to sink endpoint: local 172.20.11.174:46616 -> remote 168.86.138.252:17616 (RTP seq 12649 TS 160 SSRC b52a7145)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/SDvKmZ2e0mvmc/1 port 41086]: [core] Handling packet: remote 172.20.11.254:30902 (expected: 172.20.11.254:30902) -> local 172.20.11.174:41086 (RTP seq 12650 TS 320 SSRC b52a7145)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847/1 port 46616]: [core] Forward to sink endpoint: local 172.20.11.174:46616 -> remote 168.86.138.252:17616 (RTP seq 12650 TS 320 SSRC b52a7145)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847/1 port 46616]: [core] New ingress SSRC for: 168.86.138.252:17616 SSRC: 5f263cbd
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847/1 port 46616]: [core] Handling packet: remote 168.86.138.252:17616 (expected: 168.86.138.252:17616) -> local 172.20.11.174:46616 (RTP seq 5313 TS 0 SSRC 5f263cbd)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847/1 port 46616]: [core] New egress (direct) SSRC for: 172.20.11.254:30902 SSRC: 5f263cbd
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/SDvKmZ2e0mvmc/1 port 41086]: [core] Forward to sink endpoint: local 172.20.11.174:41086 -> remote 172.20.11.254:30902 (RTP seq 5313 TS 0 SSRC 5f263cbd)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/SDvKmZ2e0mvmc/1 port 41086]: [core] Handling packet: remote 172.20.11.254:30902 (expected: 172.20.11.254:30902) -> local 172.20.11.174:41086 (RTP seq 12651 TS 480 SSRC b52a7145)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847/1 port 46616]: [core] Forward to sink endpoint: local 172.20.11.174:46616 -> remote 168.86.138.252:17616 (RTP seq 12651 TS 480 SSRC b52a7145)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847/1 port 46616]: [core] Handling packet: remote 168.86.138.252:17616 (expected: 168.86.138.252:17616) -> local 172.20.11.174:46616 (RTP seq 5314 TS 160 SSRC 5f263cbd)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/SDvKmZ2e0mvmc/1 port 41086]: [core] Forward to sink endpoint: local 172.20.11.174:41086 -> remote 172.20.11.254:30902 (RTP seq 5314 TS 160 SSRC 5f263cbd)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/SDvKmZ2e0mvmc/1 port 41086]: [core] Handling packet: remote 172.20.11.254:30902 (expected: 172.20.11.254:30902) -> local 172.20.11.174:41086 (RTP seq 12652 TS 640 SSRC b52a7145)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847/1 port 46616]: [core] Forward to sink endpoint: local 172.20.11.174:46616 -> remote 168.86.138.252:17616 (RTP seq 12652 TS 640 SSRC b52a7145)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847/1 port 46616]: [core] Handling packet: remote 168.86.138.252:17616 (expected: 168.86.138.252:17616) -> local 172.20.11.174:46616 (RTP seq 5315 TS 320 SSRC 5f263cbd)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/SDvKmZ2e0mvmc/1 port 41086]: [core] Forward to sink endpoint: local 172.20.11.174:41086 -> remote 172.20.11.254:30902 (RTP seq 5315 TS 320 SSRC 5f263cbd)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/SDvKmZ2e0mvmc/1 port 41086]: [core] Handling packet: remote 172.20.11.254:30902 (expected: 172.20.11.254:30902) -> local 172.20.11.174:41086 (RTP seq 12653 TS 800 SSRC b52a7145)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847/1 port 46616]: [core] Forward to sink endpoint: local 172.20.11.174:46616 -> remote 168.86.138.252:17616 (RTP seq 12653 TS 800 SSRC b52a7145)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847/1 port 46616]: [core] Handling packet: remote 168.86.138.252:17616 (expected: 168.86.138.252:17616) -> local 172.20.11.174:46616 (RTP seq 5316 TS 480 SSRC 5f263cbd)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/SDvKmZ2e0mvmc/1 port 41086]: [core] Forward to sink endpoint: local 172.20.11.174:41086 -> remote 172.20.11.254:30902 (RTP seq 5316 TS 480 SSRC 5f263cbd)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/SDvKmZ2e0mvmc/1 port 41086]: [core] Handling packet: remote 172.20.11.254:30902 (expected: 172.20.11.254:30902) -> local 172.20.11.174:41086 (RTP seq 12654 TS 960 SSRC b52a7145)
Nov 13 16:02:53 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847/1 port 46616]: [core] Forward to sink endpoint: local 172.20.11.174:46616 -> remote 168.86.138.252:17616 (RTP seq 12654 TS 960 SSRC b52a7145)
Nov 13 16:02:57 ip-172-20-11-174 rtpengine[2388428]: INFO: [2bff51285f484a2f...@0.0.0.0/49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847/1 port 46616]: [core] Kernelizing media stream: 168.86.138.252:17616 -> 172.20.11.174:46616 | 172.20.11.174:41086 -> 172.20.11.254:30902
Nov 13 16:02:57 ip-172-20-11-174 rtpengine[2388428]: INFO: [2bff51285f484a2f...@0.0.0.0/SDvKmZ2e0mvmc/1 port 41086]: [core] Confirmed peer address as 172.20.11.254:30902
Nov 13 16:02:57 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/SDvKmZ2e0mvmc/1 port 41086]: [core] Handling packet: remote 172.20.11.254:30902 (expected: 172.20.11.254:30902) -> local 172.20.11.174:41086 (RTP seq 12813 TS 26400 SSRC b52a7145)
Nov 13 16:02:57 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847/1 port 46616]: [core] Forward to sink endpoint: local 172.20.11.174:46616 -> remote 168.86.138.252:17616 (RTP seq 12813 TS 26400 SSRC b52a7145)
Nov 13 16:02:57 ip-172-20-11-174 rtpengine[2388428]: INFO: [2bff51285f484a2f...@0.0.0.0/SDvKmZ2e0mvmc/1 port 41086]: [core] Kernelizing media stream: 172.20.11.254:30902 -> 172.20.11.174:41086 | 172.20.11.174:46616 -> 168.86.138.252:17616
** we continue to see these logs - does this mean it is still being handled in userspace?
Nov 13 16:02:57 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847/1 port 46616]: [core] Handling packet: remote 168.86.138.252:17616 (expected: 168.86.138.252:17616) -> local 172.20.11.174:46616 (RTP seq 5500 TS 29920 SSRC 5f263cbd)
Nov 13 16:02:57 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/SDvKmZ2e0mvmc/1 port 41086]: [core] Forward to sink endpoint: local 172.20.11.174:41086 -> remote 172.20.11.254:30902 (RTP seq 5500 TS 29920 SSRC 5f263cbd)
Nov 13 16:02:57 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/SDvKmZ2e0mvmc/1 port 41086]: [core] Handling packet: remote 172.20.11.254:30902 (expected: 172.20.11.254:30902) -> local 172.20.11.174:41086 (RTP seq 12839 TS 30560 SSRC b52a7145)
Nov 13 16:02:57 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [2bff51285f484a2f...@0.0.0.0/49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847/1 port 46616]: [core] Forward to sink endpoint: local 172.20.11.174:46616 -> remote 168.86.138.252:17616 (RTP seq 12839 TS 30560 SSRC b52a7145)
*** later, statistics command shows nothing is going through kernel module
Nov 13 16:03:03 ip-172-20-11-174 rtpengine[2388428]: INFO: [control] Replying to 'statistics' from 127.0.0.1:36714 (elapsed time 0.000314 sec)
Nov 13 16:03:03 ip-172-20-11-174 rtpengine[2388428]: DEBUG: [control] Response dump for 'statistics' to 127.0.0.1:36714: { "statistics": { "currentstatistics": { "sessionsown": 1, "sessionsforeign": 0, "sessionstotal": 1, "transcodedmedia": 0, "packetrate_user": 0, "byterate_user": 0, "errorrate_user": 0, "packetrate_kernel": 0, "byterate_kernel": 0, "errorrate_kernel": 0, "packetrate": 0, "byterate": 0, "errorrate": 0, "media_userspace": 2, "media_kernel": 0, "media_mixed": 0 }, "totalstatistics": { "uptime": "4244", "managedsessions": 10, "rejectedsess ...
Nov 13 16:03:03 ip-172-20-11-174 rtpengine[2388428]: DEBUG: ... ions": 0, "timeoutsessions": 0, "silenttimeoutsessions": 0, "finaltimeoutsessions": 0, "offertimeoutsessions": 0, "regularterminatedsessions": 10, "forcedterminatedsessions": 0, "relayedpackets_user": 9942, "relayedpacketerrors_user": 10, "relayedbytes_user": 1699164, "relayedpackets_kernel": 0, "relayedpacketerrors_kernel": 0, "relayedbytes_kernel": 0, "relayedpackets": 9942, "relayedpacketerrors": 10, "relayedbytes": 1699164, "zerowaystreams": 0, "onewaystreams": 0, "avgcallduration": "10.6707 ...
Nov 13 16:03:03 ip-172-20-11-174 rtpengine[2388428]: DEBUG: ... 88", "totalcallsduration": "106.707887", "totalcallsduration2": "1264.834655", "totalcallsduration_stddev": "3.552147" }, "mos": { "mos_total": "55.900000", "mos2_total": "240.370000", "mos_samples_total": 13, "mos_average": "4.300000", "mos_stddev": "0.000000" }, "voip_metrics": { "jitter_total": "1.000000", "jitter2_total": "1.000000", "jitter_samples_total": 23, "jitter_average": "0.000000", "jitter_stddev": "0.000000", "rtt_e2e_total": "268257.000000", "rtt_e2e2_total": "5562974773.000000", ...
Nov 13 16:03:03 ip-172-20-11-174 rtpengine[2388428]: DEBUG: ... "rtt_e2e_samples_total": 23, "rtt_e2e_average": "11663.000000", "rtt_e2e_stddev": "10287.000000", "rtt_dsct_total": "251044.000000", "rtt_dsct2_total": "3034477534.000000", "rtt_dsct_samples_total": 23, "rtt_dsct_average": "10914.000000", "rtt_dsct_stddev": "3577.000000", "packetloss_total": "0.000000", "packetloss2_total": "0.000000", "packetloss_samples_total": 23, "packetloss_average": "0.000000", "packetloss_stddev": "0.000000", "jitter_measured_total": "0.000000", "jitter_measured2_total": ...
Nov 13 16:03:03 ip-172-20-11-174 rtpengine[2388428]: DEBUG: ... "0.000000", "jitter_measured_samples_total": 0, "jitter_measured_average": "0.000000", "jitter_measured_stddev": "0.000000", "packets_lost": 0, "rtp_duplicates": 0, "rtp_skips": 0, "rtp_seq_resets": 0, "rtp_reordered": 0 }, "controlstatistics": { "proxies": [ { "proxy": "127.0.0.1", "pingcount": 565, "pingduration": "0.000470", "offercount": 11, "offerduration": "0.007761", "answercount": 11, "answerduration": "0.004070", "deletecount": 10, "deleteduration": "0.001398", "querycount": 0, "querydu ...
Nov 13 16:03:03 ip-172-20-11-174 rtpengine[2388428]: DEBUG: ... ration": "0.000000", "listcount": 0, "listduration": "0.000000", "startreccount": 0, "startrecduration": "0.000000", "stopreccount": 0, "stoprecduration": "0.000000", "pausereccount": 0, "pauserecduration": "0.000000", "startfwdcount": 0, "startfwdduration": "0.000000", "stopfwdcount": 0, "stopfwdduration": "0.000000", "blkdtmfcount": 0, "blkdtmfduration": "0.000000", "unblkdtmfcount": 0, "unblkdtmfduration": "0.000000", "blkmediacount": 0, "blkmediaduration": "0.000000", "unblkmediacount": 0, " ...
Nov 13 16:03:03 ip-172-20-11-174 rtpengine[2388428]: DEBUG: ... unblkmediaduration": "0.000000", "playmediacount": 0, "playmediaduration": "0.000000", "stopmediacount": 0, "stopmediaduration": "0.000000", "playdtmfcount": 0, "playdtmfduration": "0.000000", "statscount": 140, "statsduration": "0.047318", "slnmediacount": 0, "slnmediaduration": "0.000000", "unslnmediacount": 0, "unslnmediaduration": "0.000000", "pubcount": 0, "pubduration": "0.000000", "subreqcount": 0, "subreqduration": "0.000000", "subanscount": 0, "subansduration": "0.000000", "unsubcount": ...
Nov 13 16:03:03 ip-172-20-11-174 rtpengine[2388428]: DEBUG: ... 0, "unsubduration": "0.000000", "errorcount": 0 } ], "totalpingcount": 565, "totaloffercount": 11, "totalanswercount": 11, "totaldeletecount": 10, "totalquerycount": 0, "totallistcount": 0, "totalstartreccount": 0, "totalstopreccount": 0, "totalpausereccount": 0, "totalstartfwdcount": 0, "totalstopfwdcount": 0, "totalblkdtmfcount": 0, "totalunblkdtmfcount": 0, "totalblkmediacount": 0, "totalunblkmediacount": 0, "totalplaymediacount": 0, "totalstopmediacount": 0, "totalplaydtmfcount": 0, "totals ...
Nov 13 16:03:03 ip-172-20-11-174 rtpengine[2388428]: DEBUG: ... tatscount": 140, "totalslnmediacount": 0, "totalunslnmediacount": 0, "totalpubcount": 0, "totalsubreqcount": 0, "totalsubanscount": 0, "totalunsubcount": 0 }, "interfaces": [ { "name": "private", "address": "172.20.11.174", "ports": { "min": 40000, "max": 60000, "used": 4, "used_pct": "0.02", "free": 19997, "totals": 20001 }, "packets_lost": 0, "duplicates": 0, "voip_metrics": { "mos_total": "43.000000", "mos2_total": "184.900000", "mos_samples_total": 10, "mos_average": "4.300000", "mos_stddev" ...
Nov 13 16:03:03 ip-172-20-11-174 rtpengine[2388428]: DEBUG: ... : "0.000000", "jitter_total": "1.000000", "jitter2_total": "1.000000", "jitter_samples_total": 11, "jitter_average": "0.000000", "jitter_stddev": "0.000000", "rtt_e2e_total": "205670.000000", "rtt_e2e2_total": "4254002264.000000", "rtt_e2e_samples_total": 11, "rtt_e2e_average": "18697.000000", "rtt_e2e_stddev": "6094.000000", "rtt_dsct_total": "100961.000000", "rtt_dsct2_total": "1139902951.000000", "rtt_dsct_samples_total": 11, "rtt_dsct_average": "9178.000000", "rtt_dsct_stddev": "4403.000000" ...
Nov 13 16:03:03 ip-172-20-11-174 rtpengine[2388428]: DEBUG: ... , "packetloss_total": "0.000000", "packetloss2_total": "0.000000", "packetloss_samples_total": 11, "packetloss_average": "0.000000", "packetloss_stddev": "0.000000", "jitter_measured_total": "0.000000", "jitter_measured2_total": "0.000000", "jitter_measured_samples_total": 0, "jitter_measured_average": "0.000000", "jitter_measured_stddev": "0.000000" }, "ingress": { "packets": 4982, "bytes": 855704, "errors": 0 }, "egress": { "packets": 4960, "bytes": 843460, "errors": 0 } }, { "name": "public", ...
Nov 13 16:03:03 ip-172-20-11-174 rtpengine[2388428]: DEBUG: ... "address": "172.20.11.174", "ports": { "min": 40000, "max": 60000, "used": 4, "used_pct": "0.02", "free": 19997, "totals": 20001 }, "packets_lost": 0, "duplicates": 0, "voip_metrics": { "mos_total": "12.900000", "mos2_total": "55.470000", "mos_samples_total": 3, "mos_average": "4.300000", "mos_stddev": "0.000000", "jitter_total": "0.000000", "jitter2_total": "0.000000", "jitter_samples_total": 12, "jitter_average": "0.000000", "jitter_stddev": "0.000000", "rtt_e2e_total": "62587.000000", "rtt_e ...
Nov 13 16:03:03 ip-172-20-11-174 rtpengine[2388428]: DEBUG: ... 2e2_total": "1308972509.000000", "rtt_e2e_samples_total": 12, "rtt_e2e_average": "5215.000000", "rtt_e2e_stddev": "9048.000000", "rtt_dsct_total": "150083.000000", "rtt_dsct2_total": "1894574583.000000", "rtt_dsct_samples_total": 12, "rtt_dsct_average": "12506.000000", "rtt_dsct_stddev": "1207.000000", "packetloss_total": "0.000000", "packetloss2_total": "0.000000", "packetloss_samples_total": 12, "packetloss_average": "0.000000", "packetloss_stddev": "0.000000", "jitter_measured_total": "0.0000 ...
Nov 13 16:03:03 ip-172-20-11-174 rtpengine[2388428]: DEBUG: ... 00", "jitter_measured2_total": "0.000000", "jitter_measured_samples_total": 0, "jitter_measured_average": "0.000000", "jitter_measured_stddev": "0.000000" }, "ingress": { "packets": 5014, "bytes": 843676, "errors": 0 }, "egress": { "packets": 4972, "bytes": 857804, "errors": 10 } } ], "transcoders": [ ] }, "result": "ok" }
Richard Fuchs
Nov 13, 2025, 11:56:33 AMNov 13
to rtpe...@googlegroups.com
On 13/11/2025 12.24, David Horton wrote:
> Hmm I have removed the "inject DMTF" flag and retested, and the
> results were interesting. I now see in the logs that rtpengine is
> "Kernelizing media stream" however, the logging and subsequent
> statistics command indicate that the media is being passed in
> userspace. Any idea what could account for this? Here is a portion
> of the debug log
>
> Hmm I have removed the "inject DMTF" flag and retested, and the
> results were interesting. I now see in the logs that rtpengine is
> "Kernelizing media stream" however, the logging and subsequent
> statistics command indicate that the media is being passed in
> userspace. Any idea what could account for this? Here is a portion
> of the debug log
>
> Nov 13 16:02:57 ip-172-20-11-174 rtpengine[2388428]: INFO:
> [2bff51285f484a2f...@0.0.0.0/49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847/1
> port 46616]: [core] Kernelizing media stream: 168.86.138.252:17616 ->
> 172.20.11.174:46616 | 172.20.11.174:41086 -> 172.20.11.254:30902
>
> [2bff51285f484a2f...@0.0.0.0/49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847/1
> port 46616]: [core] Kernelizing media stream: 168.86.138.252:17616 ->
> 172.20.11.174:46616 | 172.20.11.174:41086 -> 172.20.11.254:30902
>
> ** we continue to see these logs - does this mean it is still being
> handled in userspace?
>
> Nov 13 16:02:57 ip-172-20-11-174 rtpengine[2388428]: DEBUG:
> [2bff51285f484a2f...@0.0.0.0/49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847/1
> port 46616]: [core] Handling packet: remote 168.86.138.252:17616
> (expected: 168.86.138.252:17616) -> local 172.20.11.174:46616 (RTP seq
> 5500 TS 29920 SSRC 5f263cbd)
That's the same stream, so yes it does. Check the contents of
> handled in userspace?
>
> Nov 13 16:02:57 ip-172-20-11-174 rtpengine[2388428]: DEBUG:
> [2bff51285f484a2f...@0.0.0.0/49012676_c3356d0b_7b3312cb-06ae-4fe6-8c9b-67898bd58847/1
> port 46616]: [core] Handling packet: remote 168.86.138.252:17616
> (expected: 168.86.138.252:17616) -> local 172.20.11.174:46616 (RTP seq
> 5500 TS 29920 SSRC 5f263cbd)
/proc/rtpengine/0/list. If the stream is listed but the counters aren't
increasing, then probably the iptables/nftables rule is missing or
doesn't take.
Cheers
Reply all
Reply to author
Forward
0 new messages