Hello, I am using kamailio to register the webrtc client and routes the calls to asterisk using pjsip. I am having no voice on both ends. Logs are attached witht this email.
Mar 24 13:06:58 debian rtpengine[7345]: INFO: [8asmubtpv46ac7nrfk57]: [control] Received command 'offer' from 10.13.1.127:59841 Mar 24 13:06:58 debian rtpengine[7345]: NOTICE: [8asmubtpv46ac7nrfk57]: [core] Creating new call Mar 24 13:06:58 debian rtpengine[7345]: INFO: [8asmubtpv46ac7nrfk57]: [control] Replying to 'offer' from 10.13.1.127:59841 (elapsed time 0.016067 sec) Mar 24 13:06:58 debian rtpengine[7345]: INFO: [8asmubtpv46ac7nrfk57]: [control] Received command 'answer' from 10.13.1.127:52045 Mar 24 13:06:58 debian rtpengine[7345]: INFO: [8asmubtpv46ac7nrfk57]: [control] Replying to 'answer' from 10.13.1.127:52045 (elapsed time 0.000997 sec) Mar 24 13:06:58 debian rtpengine[7345]: INFO: [8asmubtpv46ac7nrfk57/223df8fa-8106-48af-844f-33f97530a0d8/1 port 10940]: [ice] ICE negotiated: peer for component 1 is 10.13.1.170:15634 Mar 24 13:06:58 debian rtpengine[7345]: INFO: [8asmubtpv46ac7nrfk57/223df8fa-8106-48af-844f-33f97530a0d8/1 port 10940]: [ice] ICE negotiated: local interface 10.13.1.127 Mar 24 13:06:58 debian rtpengine[7345]: ERR: [8asmubtpv46ac7nrfk57/223df8fa-8106-48af-844f-33f97530a0d8/1 port 10940]: [core] SRTP output wanted, but no crypto suite was negotiated Mar 24 13:06:58 debian rtpengine[7345]: INFO: [8asmubtpv46ac7nrfk57]: [control] Received command 'answer' from 10.13.1.127:52045 Mar 24 13:06:58 debian rtpengine[7345]: INFO: [8asmubtpv46ac7nrfk57]: [control] Replying to 'answer' from 10.13.1.127:52045 (elapsed time 0.000786 sec) Mar 24 13:06:58 debian rtpengine[7345]: INFO: [8asmubtpv46ac7nrfk57/223df8fa-8106-48af-844f-33f97530a0d8/1 port 10940]: [crypto] DTLS: Peer certificate accepted Mar 24 13:06:58 debian rtpengine[7345]: INFO: [8asmubtpv46ac7nrfk57/223df8fa-8106-48af-844f-33f97530a0d8/1 port 10940]: [crypto] DTLS-SRTP successfully negotiated using AES_CM_128_HMAC_SHA1_80 Mar 24 13:06:58 debian rtpengine[7345]: INFO: [8asmubtpv46ac7nrfk57/223df8fa-8106-48af-844f-33f97530a0d8/1 port 10940]: [crypto] DTLS-SRTP successfully negotiated using AES_CM_128_HMAC_SHA1_80 Mar 24 13:06:58 debian rtpengine[7345]: INFO: [8asmubtpv46ac7nrfk57/223df8fa-8106-48af-844f-33f97530a0d8/1 port 10940]: [ice] ICE negotiated: peer for component 1 is 10.13.1.170:15634 Mar 24 13:06:58 debian rtpengine[7345]: INFO: [8asmubtpv46ac7nrfk57/223df8fa-8106-48af-844f-33f97530a0d8/1 port 10940]: [ice] ICE negotiated: local interface 10.13.1.127 Mar 24 13:07:02 debian rtpengine[7345]: INFO: [8asmubtpv46ac7nrfk57/223df8fa-8106-48af-844f-33f97530a0d8/1 port 10940]: [core] Confirmed peer address as 10.13.1.170:15634 Mar 24 13:07:02 debian rtpengine[7345]: INFO: [8asmubtpv46ac7nrfk57/223df8fa-8106-48af-844f-33f97530a0d8/1 port 10940]: [core] Kernelizing media stream: 10.13.1.170:15634 -> 10.13.1.127:10940 | 10.13.1.127:10960 -> 192.168.30.200:53489 Mar 24 13:07:02 debian rtpengine[7345]: WARNING: [8asmubtpv46ac7nrfk57/223df8fa-8106-48af-844f-33f97530a0d8/1 port 10940]: [core] No support for kernel packet forwarding available (encryption cipher or HMAC not supported by kernel module) Mar 24 13:07:02 debian rtpengine[7345]: NOTICE: [8asmubtpv46ac7nrfk57/223df8fa-8106-48af-844f-33f97530a0d8/1 port 10940]: [core] Setting 'non-forwarding' flag for kernel stream due to lack of sinks Mar 24 13:07:03 debian rtpengine[7345]: ERR: [8asmubtpv46ac7nrfk57/223df8fa-8106-48af-844f-33f97530a0d8/1 port 10940]: [rtcp] SRTCP output wanted, but no crypto suite was negotiated Mar 24 13:07:03 debian rtpengine[7345]: INFO: [8asmubtpv46ac7nrfk57/223df8fa-8106-48af-844f-33f97530a0d8/1 port 10940]: [core] Removing media stream from kernel: local 10.13.1.127:10940 Mar 24 13:07:03 debian rtpengine[7345]: INFO: [8asmubtpv46ac7nrfk57/223df8fa-8106-48af-844f-33f97530a0d8/1 port 10940]: [core] Kernelizing media stream: 10.13.1.170:15634 -> 10.13.1.127:10940 | 10.13.1.127:10960 -> 192.168.30.200:53489 Mar 24 13:07:03 debian rtpengine[7345]: WARNING: [8asmubtpv46ac7nrfk57/223df8fa-8106-48af-844f-33f97530a0d8/1 port 10940]: [core] No support for kernel packet forwarding available (encryption cipher or HMAC not supported by kernel module) Mar 24 13:07:04 debian rtpengine[7345]: INFO: [8asmubtpv46ac7nrfk57]: [control] Received command 'delete' from 10.13.1.127:52045 Mar 24 13:07:04 debian rtpengine[7345]: INFO: [8asmubtpv46ac7nrfk57]: [core] Scheduling deletion of call branch '9693uq66f0' (via-branch '') in 30 seconds Mar 24 13:07:04 debian rtpengine[7345]: INFO: [8asmubtpv46ac7nrfk57]: [core] Scheduling deletion of call branch '223df8fa-8106-48af-844f-33f97530a0d8' (via-branch '') in 30 seconds Mar 24 13:07:04 debian rtpengine[7345]: INFO: [8asmubtpv46ac7nrfk57]: [core] Scheduling deletion of entire call in 30 seconds Mar 24 13:07:04 debian rtpengine[7345]: INFO: [8asmubtpv46ac7nrfk57]: [control] Replying to 'delete' from 10.13.1.127:52045 (elapsed time 0.001463 sec) Mar 24 13:07:17 debian /usr/local/sbin/kamailio[13362]: INFO: <script>: 10.13.1.170 authentication bypassed for sip:developer@10.13.1.127 Mar 24 13:07:34 debian rtpengine[7345]: INFO: [8asmubtpv46ac7nrfk57]: [core] Final packet stats: Mar 24 13:07:34 debian rtpengine[7345]: INFO: [8asmubtpv46ac7nrfk57]: [core] --- Tag '9693uq66f0', created 0:36 ago for branch '' Mar 24 13:07:34 debian rtpengine[7345]: INFO: [8asmubtpv46ac7nrfk57]: [core] --- subscribed to '223df8fa-8106-48af-844f-33f97530a0d8' Mar 24 13:07:34 debian rtpengine[7345]: INFO: [8asmubtpv46ac7nrfk57]: [core] --- subscription for '223df8fa-8106-48af-844f-33f97530a0d8' Mar 24 13:07:34 debian rtpengine[7345]: INFO: [8asmubtpv46ac7nrfk57]: [core] ------ Media #1 (audio over UDP/TLS/RTP/SAVPF) using unknown codec Mar 24 13:07:34 debian rtpengine[7345]: INFO: [8asmubtpv46ac7nrfk57]: [core] --------- Port 10.13.1.127:10960 <> 192.168.30.200:53489, SSRC 0, in 0 p, 0 b, 292 e, 36 ts, out 0 p, 0 b, 0 e Mar 24 13:07:34 debian rtpengine[7345]: INFO: [8asmubtpv46ac7nrfk57]: [core] --- Tag '223df8fa-8106-48af-844f-33f97530a0d8', created 0:36 ago for branch '' Mar 24 13:07:34 debian rtpengine[7345]: INFO: [8asmubtpv46ac7nrfk57]: [core] --- subscribed to '9693uq66f0' Mar 24 13:07:34 debian rtpengine[7345]: INFO: [8asmubtpv46ac7nrfk57]: [core] --- subscription for '9693uq66f0' Mar 24 13:07:34 debian rtpengine[7345]: INFO: [8asmubtpv46ac7nrfk57]: [core] ------ Media #1 (audio over UDP/TLS/RTP/SAVPF) using opus/48000/2 Mar 24 13:07:34 debian rtpengine[7345]: INFO: [8asmubtpv46ac7nrfk57]: [core] --------- Port 10.13.1.127:10940 <> 10.13.1.170:15634, SSRC 1ada0b2b, in 292 p, 40137 b, 1 e, 30 ts, out 2 p, 1449 b, 0 e
It seems to me the answer might be in the logs you posted:
On Mar 24, 2023, at 3:41 AM, Arun K R mail4arunkr@gmail.com wrote:
Mar 24 13:07:02 debian rtpengine[7345]: WARNING: [8asmubtpv46ac7nrfk57/223df8fa-8106-48af-844f-33f97530a0d8/1 port 10940]: [core] No support for kernel packet forwarding available (encryption cipher or HMAC not supported by kernel module) Mar 24 13:07:02 debian rtpengine[7345]: NOTICE: [8asmubtpv46ac7nrfk57/223df8fa-8106-48af-844f-33f97530a0d8/1 port 10940]: [core] Setting 'non-forwarding' flag for kernel stream due to lack of sinks Mar 24 13:07:03 debian rtpengine[7345]: ERR: [8asmubtpv46ac7nrfk57/223df8fa-8106-48af-844f-33f97530a0d8/1 port 10940]: [rtcp] SRTCP output wanted, but no crypto suite was negotiated Mar 24 13:07:03 debian rtpengine[7345]: INFO: [8asmubtpv46ac7nrfk57/223df8fa-8106-48af-844f-33f97530a0d8/1 port 10940]: [core] Removing media stream from kernel: local 10.13.1.127:10940 Mar 24 13:07:03 debian rtpengine[7345]: INFO: [8asmubtpv46ac7nrfk57/223df8fa-8106-48af-844f-33f97530a0d8/1 port 10940]: [core] Kernelizing media stream: 10.13.1.170:15634 -> 10.13.1.127:10940 | 10.13.1.127:10960 -> 192.168.30.200:53489 Mar 24 13:07:03 debian rtpengine[7345]: WARNING: [8asmubtpv46ac7nrfk57/223df8fa-8106-48af-844f-33f97530a0d8/1 port 10940]: [core] No support for kernel packet forwarding available (encryption cipher or HMAC not supported by kernel module)
You mean
No support for kernel packet forwarding available (encryption cipher
or HMAC not supported by kernel module
can you suggest how can i add kernel support for cipher or HMAC encryption if that is the issue.
Thank you
On Fri, Mar 24, 2023 at 5:58 PM Alex Balashov abalashov@evaristesys.com wrote:
It seems to me the answer might be in the logs you posted:
On Mar 24, 2023, at 3:41 AM, Arun K R mail4arunkr@gmail.com wrote:
Mar 24 13:07:02 debian rtpengine[7345]: WARNING:
[8asmubtpv46ac7nrfk57/223df8fa-8106-48af-844f-33f97530a0d8/1 port 10940]: [core] No support for kernel packet forwarding available (encryption cipher or HMAC not supported by kernel module)
Mar 24 13:07:02 debian rtpengine[7345]: NOTICE:
[8asmubtpv46ac7nrfk57/223df8fa-8106-48af-844f-33f97530a0d8/1 port 10940]: [core] Setting 'non-forwarding' flag for kernel stream due to lack of sinks
Mar 24 13:07:03 debian rtpengine[7345]: ERR:
[8asmubtpv46ac7nrfk57/223df8fa-8106-48af-844f-33f97530a0d8/1 port 10940]: [rtcp] SRTCP output wanted, but no crypto suite was negotiated
Mar 24 13:07:03 debian rtpengine[7345]: INFO:
[8asmubtpv46ac7nrfk57/223df8fa-8106-48af-844f-33f97530a0d8/1 port 10940]: [core] Removing media stream from kernel: local 10.13.1.127:10940
Mar 24 13:07:03 debian rtpengine[7345]: INFO:
[8asmubtpv46ac7nrfk57/223df8fa-8106-48af-844f-33f97530a0d8/1 port 10940]: [core] Kernelizing media stream: 10.13.1.170:15634 -> 10.13.1.127:10940 | 10.13.1.127:10960 -> 192.168.30.200:53489
Mar 24 13:07:03 debian rtpengine[7345]: WARNING:
[8asmubtpv46ac7nrfk57/223df8fa-8106-48af-844f-33f97530a0d8/1 port 10940]: [core] No support for kernel packet forwarding available (encryption cipher or HMAC not supported by kernel module)
-- Alex Balashov Principal Consultant Evariste Systems LLC Web: https://evaristesys.com Tel: +1-706-510-6800
Kamailio - Users Mailing List - Non Commercial Discussions To unsubscribe send an email to sr-users-leave@lists.kamailio.org Important: keep the mailing list in the recipients, do not reply only to the sender! Edit mailing list options or unsubscribe:
After loading crypto module into the kernel now I am getting SRTP authentication failed, kindy see the logs below
Mar 25 10:45:34 debian rtpengine[17868]: o=- 7850469901141480639 2 IN IP4 127.0.0.1 Mar 25 10:45:34 debian rtpengine[17868]: s=- Mar 25 10:45:34 debian rtpengine[17868]: t=0 0 Mar 25 10:45:34 debian rtpengine[17868]: a=group:BUNDLE 0 Mar 25 10:45:34 debian rtpengine[17868]: a=extmap-allow-mixed Mar 25 10:45:34 debian rtpengine[17868]: a=msid-semantic: WMS ukQZUUNqJBfb86Rzru3RA390AAIGX4mzOsH4 Mar 25 10:45:34 debian rtpengine[17868]: m=audio 9 UDP/TLS/RTP/SAVPF 111 63 9 0 8 13 110 126 Mar 25 10:45:34 debian rtpengine[17868]: c=IN IP4 0.0.0.0 Mar 25 10:45:34 debian rtpengine[17868]: a=rtcp:9 IN IP4 0.0.0.0 Mar 25 10:45:34 debian rtpengine[17868]: a=ice-ufrag:ZW7m Mar 25 10:45:34 debian rtpengine[17868]: a=ice-pwd:R11oi+7clD5K3WHviTxun+qG Mar 25 10:45:34 debian rtpengine[17868]: a=ice-options:trickle Mar 25 10:45:34 debian rtpengine[17868]: a=fingerprint:sha-256 83:27:2D:0A:0D:AF:EE:7A:B9:F6:D0:B3:5E:E1:B0:31:70:38:00:AB:E2:90:E4:AA:93:94:BE:0E:22:0A:53:26 Mar 25 10:45:34 debian rtpengine[17868]: a=setup:actpass Mar 25 10:45:34 debian rtpengine[17868]: a=mid:0 Mar 25 10:45:34 debian rtpengine[17868]: a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level Mar 25 10:45:34 debian rtpengine[17868]: a=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time Mar 25 10:45:34 debian rtpengine[17868]: a=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01 Mar 25 10:45:34 debian rtpengine[17868]: a=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid Mar 25 10:45:34 debian rtpengine[17868]: a=sendrecv Mar 25 10:45:34 debian rtpengine[17868]: a=msid:ukQZUUNqJBfb86Rzru3RA390AAIGX4mzOsH4 61406c6f-0991-409d-921a-67c1747ef4b1 Mar 25 10:45:34 debian rtpengine[17868]: a=rtcp-mux Mar 25 10:45:34 debian rtpengine[17868]: a=rtpmap:111 opus/48000/2 Mar 25 10:45:34 debian rtpengine[17868]: a=rtcp-fb:111 transport-cc Mar 25 10:45:34 debian rtpengine[17868]: a=fmtp:111 minptime=10;useinbandfec=1 Mar 25 10:45:34 debian rtpengine[17868]: a=rtpmap:63 red/48000/2 Mar 25 10:45:34 debian rtpengine[17868]: a=fmtp:63 111/111 Mar 25 10:45:34 debian rtpengine[17868]: a=rtpmap:9 G722/8000 Mar 25 10:45:34 debian rtpengine[17868]: a=rtpmap:0 PCMU/8000 Mar 25 10:45:34 debian rtpengine[17868]: a=rtpmap:8 PCMA/8000 Mar 25 10:45:34 debian rtpengine[17868]: a=rtpmap:13 CN/8000 Mar 25 10:45:34 debian rtpengine[17868]: a=rtpmap:110 telephone-event/48000 Mar 25 10:45:34 debian rtpengine[17868]: a=rtpmap:126 telephone-event/8000 Mar 25 10:45:34 debian rtpengine[17868]: a=ssrc:199333846 cname:OBdOn05PKdHnvXw9 Mar 25 10:45:34 debian rtpengine[17868]: a=ssrc:199333846 msid:ukQZUUNqJBfb86Rzru3RA390AAIGX4mzOsH4 61406c6f-0991-409d-921a-67c1747ef4b1 Mar 25 10:45:34 debian rtpengine[17868]: ", "replace": [ "origin", "session-connection" ], "call-id": "oaece23ntismpjeug83i", "received-from": [ "IP4", "122.161.108.16" ], "from-tag": "pc2bfpeipd", "command": "offer" } Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [core] Using default bitrate of 32000 bps for 2-channel Opus Mar 25 10:45:34 debian rtpengine[17868]: NOTICE: [oaece23ntismpjeug83i]: [core] Creating new call Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [core] Subscribing 'pc2bfpeipd' to '' Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [core] Subscribing '' to 'pc2bfpeipd' Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Updating codecs for offerer pc2bfpeipd #1 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Adding codec opus/48000/2 (111) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Adding codec red/48000/2 (63) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Adding codec G722/8000 (9) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Adding codec PCMU/8000 (0) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Adding codec PCMA/8000 (8) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Adding codec CN/8000 (13) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Adding codec telephone-event/48000 (110) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Adding codec telephone-event/8000 (126) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Updating codecs for answerer #1 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Adding codec opus/48000/2 (111) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Adding codec red/48000/2 (63) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Adding codec G722/8000 (9) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Adding codec PCMU/8000 (0) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Adding codec PCMA/8000 (8) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Adding codec CN/8000 (13) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Adding codec telephone-event/48000 (110) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Adding codec telephone-event/8000 (126) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Updating supplemental codecs for #1 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Setting up codec handlers for #1 -> pc2bfpeipd #1 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Default sink codec is opus/48000/2 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Checking receiver codec opus/48000/2 (111) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Creating codec handler for opus/48000/2 (111) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink codec for opus/48000/2 is opus/48000/2 (111) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink supports codec opus/48000/2 for passthrough Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Using passthrough handler for opus/48000/2 with DTMF 110, CN -1 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Checking receiver codec red/48000/2 (63) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Creating codec handler for red/48000/2 (63) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] No codec support for red/48000/2 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Using passthrough handler for red/48000/2 with DTMF -1, CN -1 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Checking receiver codec G722/8000/1 (9) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Creating codec handler for G722/8000 (9) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink codec for G722/8000 is G722/8000/1 (9) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink supports codec G722/8000 for passthrough Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Using passthrough handler for G722/8000 with DTMF 126, CN 13 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Checking receiver codec PCMU/8000/1 (0) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Creating codec handler for PCMU/8000 (0) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink codec for PCMU/8000 is PCMU/8000/1 (0) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink supports codec PCMU/8000 for passthrough Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Using passthrough handler for PCMU/8000 with DTMF 126, CN 13 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Checking receiver codec PCMA/8000/1 (8) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Creating codec handler for PCMA/8000 (8) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink codec for PCMA/8000 is PCMA/8000/1 (8) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink supports codec PCMA/8000 for passthrough Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Using passthrough handler for PCMA/8000 with DTMF 126, CN 13 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Checking receiver codec CN/8000/1 (13) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Creating codec handler for CN/8000 (13) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink codec for CN/8000 is CN/8000/1 (13) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink supports codec CN/8000 for passthrough Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Using passthrough handler for CN/8000 with DTMF 126, CN 13 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Checking receiver codec telephone-event/48000/1 (110) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Creating codec handler for telephone-event/48000 (110) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink codec for telephone-event/48000 is telephone-event/48000/1 (110) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink supports codec telephone-event/48000 for passthrough Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Using passthrough handler for telephone-event/48000 with DTMF 110, CN -1 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Checking receiver codec telephone-event/8000/1 (126) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Creating codec handler for telephone-event/8000 (126) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink codec for telephone-event/8000 is telephone-event/8000/1 (126) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink supports codec telephone-event/8000 for passthrough Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Using passthrough handler for telephone-event/8000 with DTMF 126, CN 13 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Updating supplemental codecs for #1 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Setting up codec handlers for #1 -> pc2bfpeipd #1 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Default sink codec is opus/48000/2 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Checking receiver codec opus/48000/2 (111) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink codec for opus/48000/2 is opus/48000/2 (111) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink supports codec opus/48000/2 for passthrough Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Using passthrough handler for opus/48000/2 with DTMF 110, CN -1 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Checking receiver codec red/48000/2 (63) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] No codec support for red/48000/2 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Using passthrough handler for red/48000/2 with DTMF -1, CN -1 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Checking receiver codec G722/8000/1 (9) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink codec for G722/8000 is G722/8000/1 (9) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink supports codec G722/8000 for passthrough Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Using passthrough handler for G722/8000 with DTMF 126, CN 13 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Checking receiver codec PCMU/8000/1 (0) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink codec for PCMU/8000 is PCMU/8000/1 (0) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink supports codec PCMU/8000 for passthrough Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Using passthrough handler for PCMU/8000 with DTMF 126, CN 13 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Checking receiver codec PCMA/8000/1 (8) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink codec for PCMA/8000 is PCMA/8000/1 (8) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink supports codec PCMA/8000 for passthrough Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Using passthrough handler for PCMA/8000 with DTMF 126, CN 13 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Checking receiver codec CN/8000/1 (13) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink codec for CN/8000 is CN/8000/1 (13) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink supports codec CN/8000 for passthrough Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Using passthrough handler for CN/8000 with DTMF 126, CN 13 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Checking receiver codec telephone-event/48000/1 (110) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink codec for telephone-event/48000 is telephone-event/48000/1 (110) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink supports codec telephone-event/48000 for passthrough Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Using passthrough handler for telephone-event/48000 with DTMF 110, CN -1 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Checking receiver codec telephone-event/8000/1 (126) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink codec for telephone-event/8000 is telephone-event/8000/1 (126) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink supports codec telephone-event/8000 for passthrough Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Using passthrough handler for telephone-event/8000 with DTMF 126, CN 13 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [core] set FILLED flag for stream, local 10.13.1.127:10074 remote 0.0.0.0:9 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [crypto] Creating active DTLS connection context Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [crypto] Creating active DTLS connection context Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [core] set FILLED flag for stream, local 10.13.1.127:10075 remote 0.0.0.0:9 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [crypto] [10.13.1.127:10064] Initialized incoming SRTP with SDES crypto params: <none> Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [crypto] [1] Initialized outgoing SRTP with SDES crypto params: suite AEAD_AES_256_GCM, tag 1, key znZHZ2zXk2mxg0ZRU8lO5cupyIZUY66TvfWcGTqNtEo= salt iYXDb/ZUzyobMGSf Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [crypto] Creating passive DTLS connection context Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [crypto] Creating passive DTLS connection context Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [crypto] [10.13.1.127:10065] Initialized incoming SRTP with SDES crypto params: <none> Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [crypto] [2] Initialized outgoing SRTP with SDES crypto params: suite AEAD_AES_256_GCM, tag 1, key znZHZ2zXk2mxg0ZRU8lO5cupyIZUY66TvfWcGTqNtEo= salt iYXDb/ZUzyobMGSf Mar 25 10:45:34 debian rtpengine[17868]: INFO: [oaece23ntismpjeug83i]: [control] Replying to 'offer' from 127.0.0.1:50012 (elapsed time 0.013914 sec) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [control] Response dump for 'offer' to 127.0.0.1:50012: { "sdp": "v=0 Mar 25 10:45:34 debian rtpengine[17868]: o=- 7850469901141480639 2 IN IP4 10.13.1.127 Mar 25 10:45:34 debian rtpengine[17868]: s=- Mar 25 10:45:34 debian rtpengine[17868]: t=0 0 Mar 25 10:45:34 debian rtpengine[17868]: a=extmap-allow-mixed Mar 25 10:45:34 debian rtpengine[17868]: a=msid-semantic: WMS ukQZUUNqJBfb86Rzru3RA390AAIGX4mzOsH4 Mar 25 10:45:34 debian rtpengine[17868]: m=audio 10064 UDP/TLS/RTP/SAVPF 111 63 9 0 8 13 110 126 Mar 25 10:45:34 debian rtpengine[17868]: c=IN IP4 10.13.1.127 Mar 25 10:45:34 debian rtpengine[17868]: a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level Mar 25 10:45:34 debian rtpengine[17868]: a=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time Mar 25 10:45:34 debian rtpengine[17868]: a=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01 Mar 25 10:45:34 debian rtpengine[17868]: a=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid Mar 25 10:45:34 debian rtpengine[17868]: a=msid:ukQZUUNqJBfb86Rzru3RA390AAIGX4mzOsH4 61406c6f-0991-409d-921a-67c1747ef4b1 Mar 25 10:45:34 debian rtpengine[17868]: a=ssrc:199333846 cname:OBdOn05PKdHnvXw9 Mar 25 10:45:34 debian rtpengine[17868]: a=ssrc:199333846 msid:ukQZUUNqJBfb86Rzru3RA390AAIGX4mzOsH4 61406c6f-0991-409d-921a-67c1747ef4b1 Mar 25 10:45:34 debian rtpengine[17868]: a=mid:0 Mar 25 10:45:34 debian rtpengine[17868]: a=rtpmap:111 opus/48000/2 Mar 25 10:45:34 debian rtpengine[17868]: a=fmtp:111 minptime=10;useinbandfec=1 Mar 25 10:45:34 debian rtpengine[17868]: a=rtcp-fb:111 transport-cc Mar 25 10:45:34 debian rtpengine[17868]: a=rtpmap:63 red/48000/2 Mar 25 10:45:34 debian rtpengine[17868]: a=fmtp:63 111/111 Mar 25 10:45:34 debian rtpengine[17868]: a=rtpmap:9 G722/8000 Mar 25 10:45:34 debian rtpengine[17868]: a=rtpmap:0 PCMU/8000 Mar 25 10:45:34 debian rtpengine[17868]: a=rtpmap:8 PCMA/8000 Mar 25 10:45:34 debian rtpengine[17868]: a=rtpmap:13 CN/8000 Mar 25 10:45:34 debian rtpengine[17868]: a=rtpmap:110 telephone-event/48000 Mar 25 10:45:34 debian rtpengine[17868]: a=rtpmap:126 telephone-event/8000 Mar 25 10:45:34 debian rtpengine[17868]: a=sendrecv Mar 25 10:45:34 debian rtpengine[17868]: a=rtcp:10065 Mar 25 10:45:34 debian rtpengine[17868]: a=rtcp-mux Mar 25 10:45:34 debian rtpengine[17868]: a=crypto:1 AEAD_AES_256_GCM inline:znZHZ2zXk2mxg0ZRU8lO5cupyIZUY66TvfWcGTqNtEqJhcNv9lTPKhswZJ8 Mar 25 10:45:34 debian rtpengine[17868]: a=crypto:2 AEAD_AES_128_GCM inline:wOzKxBYTjuvGWf8qkRrWZcsYhY8Jqa5yWzDxQA Mar 25 10:45:34 debian rtpengine[17868]: a=crypto:3 AES_256_CM_HMAC_SHA1_80 inline:GxxRmmYrR5Ib3AReGd0mx7xEvWw4fmvYE968ClSz9EbYIBq326AS75TrweJ1rg Mar 25 10:45:34 debian rtpengine[17868]: a=crypto:4 AES_256_CM_HMAC_SHA1_32 inline:ymlIVibeJM7oR6/irVC0Gjf8PtPdg/5KVPQsQQAMSQNZkmOgTxwqSHzHW1fFJg Mar 25 10:45:34 debian rtpengine[17868]: a=crypto:5 AES_192_CM_HMAC_SHA1_80 inline:xJOxJgeWxXy0K5yPCKd30G13xn8xzXXe2yUDuZA90V9CtcbHLkM Mar 25 10:45:34 debian rtpengine[17868]: a=crypto:6 AES_192_CM_HMAC_SHA1_32 inline:aacO1TUI7RBdGKXMBy/AZOlsKiezyU9ES8f2erivDWolInPRGM8 Mar 25 10:45:34 debian rtpengine[17868]: a=crypto:7 AES_CM_128_HMAC_SHA1_80 inline:SvC9VYxr4AXm0669CJKdEaUoNh/rUIa0l49X2MiQ Mar 25 10:45:34 debian rtpengine[17868]: a=crypto:8 AES_CM_128_HMAC_SHA1_32 inline:7beRnEI0KKy3A9+y8OtkyVLW9rYWjhj5eNRo8T1H Mar 25 10:45:34 debian rtpengine[17868]: a=crypto:9 F8_128_HMAC_SHA1_80 inline:rtqYJBJNEvkhUDBpwlFHZBawhOKQs9ppdRtCPqf/ Mar 25 10:45:34 debian rtpengine[17868]: a=crypto:10 F8_128_HMAC_SHA1_32 inline:9SxDbJNtxQbtgAc5klf/NX1FYWPhaqbgBAecvvyr Mar 25 10:45:34 debian rtpengine[17868]: a=crypto:11 NULL_HMAC_SHA1_80 inline:v3RKaEYt0RRP2zZ+haYZPK6+oap9ioj86nMZkCeW Mar 25 10:45:34 debian rtpengine[17868]: a=crypto:12 NULL_HMAC_SHA1_32 inline:qTnnXQBHd4v0XmAeW31WCjhrKpAGGViJCEqhO4jR Mar 25 10:45:34 debian rtpengine[17868]: a=setup:actpass Mar 25 10:45:34 debian rtpengine[17868]: a=fingerprint:sha-256 C7:84:AC:FD:5D:EF:33:11:3A:02:1A:F3:5C:B4:88:BF:D7:B6:1C:A7:FA:C2:98:09:F6:99:22:DF:42:DE:AB:30 Mar 25 10:45:34 debian rtpengine[17868]: a=tls-id:a21aad374a0967fe34854b91777a77d0 Mar 25 10:45:34 debian rtpengine[17868]: a=ice-ufrag:kU66sE9l Mar 25 10:45:34 debian rtpengine[17868]: a=ice-pwd:1gUFAEiQSOEbkmVyCCywQWsmkC Mar 25 10:45:34 debian rtpengine[17868]: a=candidate:JJ5Ebqjkkvu8vYdW 1 UDP 2130706431 10.13.1.127 10064 typ host Mar 25 10:45:34 debian rtpengine[17868]: a=candidate:JJ5Ebqjkkvu8vYdW 2 UDP 2130706430 10.13.1.127 10065 typ host Mar 25 10:45:34 debian rtpengine[17868]: ", "result": "ok" } Mar 25 10:45:34 debian rtpengine[17868]: INFO: [oaece23ntismpjeug83i]: [control] Received command 'answer' from 127.0.0.1:54458 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [control] Dump for 'answer' from 127.0.0.1:54458: { "supports": [ "load limit" ], "sdp": "v=0 Mar 25 10:45:34 debian rtpengine[17868]: o=- 292492479 4 IN IP4 10.13.1.170 Mar 25 10:45:34 debian rtpengine[17868]: s=Asterisk Mar 25 10:45:34 debian rtpengine[17868]: c=IN IP4 10.13.1.170 Mar 25 10:45:34 debian rtpengine[17868]: t=0 0 Mar 25 10:45:34 debian rtpengine[17868]: a=msid-semantic:WMS * Mar 25 10:45:34 debian rtpengine[17868]: m=audio 19132 UDP/TLS/RTP/SAVPF 111 0 126 Mar 25 10:45:34 debian rtpengine[17868]: a=connection:new Mar 25 10:45:34 debian rtpengine[17868]: a=setup:active Mar 25 10:45:34 debian rtpengine[17868]: a=fingerprint:SHA-256 8C:FD:21:30:C3:79:70:D3:7E:D5:BD:12:EA:6B:6A:47:48:FF:FB:7B:FE:33:02:8A:6D:3B:3A:23:04:DE:A2:34 Mar 25 10:45:34 debian rtpengine[17868]: a=ice-ufrag:065408617fbb934f6030468278fe5b14 Mar 25 10:45:34 debian rtpengine[17868]: a=ice-pwd:15df5b73074e13ee443959a06225134e Mar 25 10:45:34 debian rtpengine[17868]: a=candidate:Ha0d01aa 1 UDP 2130706431 10.13.1.170 19132 typ host Mar 25 10:45:34 debian rtpengine[17868]: a=rtpmap:111 opus/48000/2 Mar 25 10:45:34 debian rtpengine[17868]: a=fmtp:111 useinbandfec=1 Mar 25 10:45:34 debian rtpengine[17868]: a=rtpmap:0 PCMU/8000 Mar 25 10:45:34 debian rtpengine[17868]: a=rtpmap:126 telephone-event/8000 Mar 25 10:45:34 debian rtpengine[17868]: a=fmtp:126 0-16 Mar 25 10:45:34 debian rtpengine[17868]: a=ptime:20 Mar 25 10:45:34 debian rtpengine[17868]: a=maxptime:20 Mar 25 10:45:34 debian rtpengine[17868]: a=sendrecv Mar 25 10:45:34 debian rtpengine[17868]: a=rtcp-mux Mar 25 10:45:34 debian rtpengine[17868]: a=msid:c144f85b-fa09-4b04-a62a-fcbb4694b992 9407213a-4d88-49a6-b6c0-a21765b065f5 Mar 25 10:45:34 debian rtpengine[17868]: a=rtcp-fb:* transport-cc Mar 25 10:45:34 debian rtpengine[17868]: a=mid:0 Mar 25 10:45:34 debian rtpengine[17868]: ", "flags": [ "SIP-source-address" ], "replace": [ "origin", "session-connection" ], "call-id": "oaece23ntismpjeug83i", "received-from": [ "IP4", "10.13.1.170" ], "from-tag": "pc2bfpeipd", "to-tag": "0cce98ab-33cc-4ac9-8a2b-1d52f012f940", "command": "answer" } Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [core] Using default bitrate of 32000 bps for 2-channel Opus Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i//1 port 10064]: [ice] Created candidate pair JJ5Ebqjkkvu8vYdW:2014c59638a1507b0:1 between 10.13.1.127 and 10.13.1.170:19132, type prflx Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i//1 port 10064]: [ice] Triggering check for JJ5Ebqjkkvu8vYdW:2014c59638a1507b0:1 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i//1 port 10064]: [core] Successful STUN binding request from 10.13.1.170:19132 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [core] Unconfirming peer address for local 10.13.1.127:10064 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [core] Unconfirming peer address for local 10.13.1.127:10074 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [core] Unconfirming peer address for local 10.13.1.127:10065 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [core] Unconfirming peer address for local 10.13.1.127:10075 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [core] Unsubscribing 'pc2bfpeipd' from '0cce98ab-33cc-4ac9-8a2b-1d52f012f940' Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [core] Unsubscribing '0cce98ab-33cc-4ac9-8a2b-1d52f012f940' from 'pc2bfpeipd' Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [core] Subscribing '0cce98ab-33cc-4ac9-8a2b-1d52f012f940' to 'pc2bfpeipd' Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [core] Subscribing 'pc2bfpeipd' to '0cce98ab-33cc-4ac9-8a2b-1d52f012f940' Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Updating codecs for answerer 0cce98ab-33cc-4ac9-8a2b-1d52f012f940 #1 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Adding codec opus/48000/2 (111) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Adding codec PCMU/8000 (0) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Adding codec telephone-event/8000 (126) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Setting up codec handlers for 0cce98ab-33cc-4ac9-8a2b-1d52f012f940 #1 -> pc2bfpeipd #1 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Default sink codec is opus/48000/2 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Checking receiver codec opus/48000/2 (111) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink codec for opus/48000/2 is opus/48000/2 (111) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink supports codec opus/48000/2 for passthrough Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Using passthrough handler for opus/48000/2 with DTMF -1, CN -1 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Checking receiver codec PCMU/8000/1 (0) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink codec for PCMU/8000 is PCMU/8000/1 (0) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink supports codec PCMU/8000 for passthrough Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Using passthrough handler for PCMU/8000 with DTMF 126, CN -1 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Checking receiver codec telephone-event/8000/1 (126) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink codec for telephone-event/8000 is telephone-event/8000/1 (126) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink supports codec telephone-event/8000 for passthrough Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Using passthrough handler for telephone-event/8000 with DTMF 126, CN -1 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Codec answer for 0cce98ab-33cc-4ac9-8a2b-1d52f012f940 #1 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Reverse codec for opus/48000/2 (111) is opus/48000/2 (111) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Reverse codec for PCMU/8000 (0) is PCMU/8000 (0) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Reverse codec for telephone-event/8000 (126) is telephone-event/8000 (126) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] telephone-event/8000/1 payload type 126 already present, skip Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] telephone-event/8000/1 payload type 126 already present, skip Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Setting up codec handlers for pc2bfpeipd #1 -> 0cce98ab-33cc-4ac9-8a2b-1d52f012f940 #1 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Default sink codec is opus/48000/2 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Checking receiver codec opus/48000/2 (111) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Creating codec handler for opus/48000/2 (111) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink codec for opus/48000/2 is opus/48000/2 (111) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink supports codec opus/48000/2 for passthrough Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Using passthrough handler for opus/48000/2 with DTMF -1, CN -1 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Checking receiver codec PCMU/8000/1 (0) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Creating codec handler for PCMU/8000 (0) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink codec for PCMU/8000 is PCMU/8000/1 (0) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink supports codec PCMU/8000 for passthrough Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Using passthrough handler for PCMU/8000 with DTMF 126, CN -1 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Checking receiver codec telephone-event/8000/1 (126) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Creating codec handler for telephone-event/8000 (126) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink codec for telephone-event/8000 is telephone-event/8000/1 (126) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink supports codec telephone-event/8000 for passthrough Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Using passthrough handler for telephone-event/8000 with DTMF 126, CN -1 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Updating supplemental codecs for pc2bfpeipd #1 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Updating supplemental codecs for 0cce98ab-33cc-4ac9-8a2b-1d52f012f940 #1 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Setting up codec handlers for pc2bfpeipd #1 -> 0cce98ab-33cc-4ac9-8a2b-1d52f012f940 #1 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Default sink codec is opus/48000/2 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Checking receiver codec opus/48000/2 (111) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink codec for opus/48000/2 is opus/48000/2 (111) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink supports codec opus/48000/2 for passthrough Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Using passthrough handler for opus/48000/2 with DTMF -1, CN -1 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Checking receiver codec PCMU/8000/1 (0) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink codec for PCMU/8000 is PCMU/8000/1 (0) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink supports codec PCMU/8000 for passthrough Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Using passthrough handler for PCMU/8000 with DTMF 126, CN -1 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Checking receiver codec telephone-event/8000/1 (126) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink codec for telephone-event/8000 is telephone-event/8000/1 (126) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink supports codec telephone-event/8000 for passthrough Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Using passthrough handler for telephone-event/8000 with DTMF 126, CN -1 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Setting up codec handlers for 0cce98ab-33cc-4ac9-8a2b-1d52f012f940 #1 -> pc2bfpeipd #1 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Default sink codec is opus/48000/2 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Checking receiver codec opus/48000/2 (111) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink codec for opus/48000/2 is opus/48000/2 (111) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink supports codec opus/48000/2 for passthrough Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Using passthrough handler for opus/48000/2 with DTMF -1, CN -1 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Checking receiver codec PCMU/8000/1 (0) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink codec for PCMU/8000 is PCMU/8000/1 (0) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink supports codec PCMU/8000 for passthrough Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Using passthrough handler for PCMU/8000 with DTMF 126, CN -1 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Checking receiver codec telephone-event/8000/1 (126) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink codec for telephone-event/8000 is telephone-event/8000/1 (126) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Sink supports codec telephone-event/8000 for passthrough Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [codec] Using passthrough handler for telephone-event/8000 with DTMF 126, CN -1 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [core] set FILLED flag for stream, local 10.13.1.127:10064 remote 10.13.1.170:19132 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [core] set FILLED flag for stream, local 10.13.1.127:10065 remote 10.13.1.170:19133 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [crypto] [10.13.1.127:10065] Initialized incoming SRTP with SDES crypto params: <none> Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [crypto] [2] Initialized outgoing SRTP with SDES crypto params: suite AEAD_AES_256_GCM, tag 1, key znZHZ2zXk2mxg0ZRU8lO5cupyIZUY66TvfWcGTqNtEo= salt iYXDb/ZUzyobMGSf Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [ice] Replacing previously learned prflx ICE candidate with Ha0d01aa:1 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [ice] Recalculating all ICE pair priorities Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [ice] Sending ICE/STUN request for candidate pair JJ5Ebqjkkvu8vYdW:Ha0d01aa:1 from 10.13.1.127 to 10.13.1.170:19132 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [ice] Shutting down ICE agent (nothing to do) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [ice] Received ICE/STUN response code 0 for candidate pair JJ5Ebqjkkvu8vYdW:Ha0d01aa:1 from 10.13.1.170:19132 to 10.13.1.127 Mar 25 10:45:34 debian rtpengine[17868]: INFO: [oaece23ntismpjeug83i]: [control] Replying to 'answer' from 127.0.0.1:54458 (elapsed time 0.008632 sec) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [ice] Setting ICE candidate pair JJ5Ebqjkkvu8vYdW:Ha0d01aa:1 as succeeded Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i]: [control] Response dump for 'answer' to 127.0.0.1:54458: { "sdp": "v=0 Mar 25 10:45:34 debian rtpengine[17868]: o=- 292492479 4 IN IP4 10.13.1.127 Mar 25 10:45:34 debian rtpengine[17868]: s=Asterisk Mar 25 10:45:34 debian rtpengine[17868]: c=IN IP4 10.13.1.127 Mar 25 10:45:34 debian rtpengine[17868]: t=0 0 Mar 25 10:45:34 debian rtpengine[17868]: a=msid-semantic:WMS * Mar 25 10:45:34 debian rtpengine[17868]: m=audio 10074 UDP/TLS/RTP/SAVPF 111 0 126 Mar 25 10:45:34 debian rtpengine[17868]: a=connection:new Mar 25 10:45:34 debian rtpengine[17868]: a=maxptime:20 Mar 25 10:45:34 debian rtpengine[17868]: a=msid:c144f85b-fa09-4b04-a62a-fcbb4694b992 9407213a-4d88-49a6-b6c0-a21765b065f5 Mar 25 10:45:34 debian rtpengine[17868]: a=rtcp-fb:* transport-cc Mar 25 10:45:34 debian rtpengine[17868]: a=mid:0 Mar 25 10:45:34 debian rtpengine[17868]: a=rtpmap:111 opus/48000/2 Mar 25 10:45:34 debian rtpengine[17868]: a=fmtp:111 useinbandfec=1 Mar 25 10:45:34 debian rtpengine[17868]: a=rtpmap:0 PCMU/8000 Mar 25 10:45:34 debian rtpengine[17868]: a=rtpmap:126 telephone-event/8000 Mar 25 10:45:34 debian rtpengine[17868]: a=fmtp:126 0-16 Mar 25 10:45:34 debian rtpengine[17868]: a=sendrecv Mar 25 10:45:34 debian rtpengine[17868]: a=rtcp:10074 Mar 25 10:45:34 debian rtpengine[17868]: a=rtcp-mux Mar 25 10:45:34 debian rtpengine[17868]: a=setup:active Mar 25 10:45:34 debian rtpengine[17868]: a=fingerprint:sha-256 C7:84:AC:FD:5D:EF:33:11:3A:02:1A:F3:5C:B4:88:BF:D7:B6:1C:A7:FA:C2:98:09:F6:99:22:DF:42:DE:AB:30 Mar 25 10:45:34 debian rtpengine[17868]: a=tls-id:b58e9c0060fa4b5b87d8e1dd16685afb Mar 25 10:45:34 debian rtpengine[17868]: a=ptime:20 Mar 25 10:45:34 debian rtpengine[17868]: a=ice-ufrag:X3H5KYnc Mar 25 10:45:34 debian rtpengine[17868]: a=ice-pwd:vsJJoElWhUGVYxBLAmiiiCapdF Mar 25 10:45:34 debian rtpengine[17868]: a=ice-options:trickle Mar 25 10:45:34 debian rtpengine[17868]: a=candidate:JJ5Ebqjkkvu8vYdW 1 UDP 2130706431 10.13.1.127 10074 typ host Mar 25 10:45:34 debian rtpengine[17868]: a=end-of-candidates Mar 25 10:45:34 debian rtpengine[17868]: ", "result": "ok" } Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [ice] Best succeeded ICE pair with all components is JJ5Ebqjkkvu8vYdW:Ha0d01aa:1 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [ice] ICE not completed yet, but can use pair JJ5Ebqjkkvu8vYdW:Ha0d01aa:1 Mar 25 10:45:34 debian rtpengine[17868]: INFO: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [ice] ICE negotiated: peer for component 1 is 10.13.1.170:19132 Mar 25 10:45:34 debian rtpengine[17868]: INFO: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [ice] ICE negotiated: local interface 10.13.1.127 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [srtp] Processing incoming DTLS packet Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [srtp] Sending DTLS packet Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [srtp] Processing incoming DTLS packet Mar 25 10:45:34 debian rtpengine[17868]: INFO: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [crypto] DTLS: Peer certificate accepted Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [crypto] DTLS handshake successful Mar 25 10:45:34 debian rtpengine[17868]: INFO: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [crypto] DTLS-SRTP successfully negotiated using AES_CM_128_HMAC_SHA1_80 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [srtp] SRTP keys, incoming: Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [srtp] --- AES_CM_128_HMAC_SHA1_80 key ZFwDypZk6A6XUWDU8LpLBw== salt hsdVV4bC/Sqje6O9U6o= Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [srtp] SRTP keys, outgoing: Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [srtp] --- AES_CM_128_HMAC_SHA1_80 key aqVG1NE/PIidO5eHCoNDdA== salt D7yWny/KSJ1s9H/VXuQ= Mar 25 10:45:34 debian rtpengine[17868]: INFO: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [crypto] DTLS-SRTP successfully negotiated using AES_CM_128_HMAC_SHA1_80 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [srtp] SRTP keys, incoming: Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [srtp] --- AES_CM_128_HMAC_SHA1_80 key ZFwDypZk6A6XUWDU8LpLBw== salt hsdVV4bC/Sqje6O9U6o= Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [srtp] SRTP keys, outgoing: Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [srtp] --- AES_CM_128_HMAC_SHA1_80 key aqVG1NE/PIidO5eHCoNDdA== salt D7yWny/KSJ1s9H/VXuQ= Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [srtp] Sending DTLS packet Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [core] New ingress SSRC for: 10.13.1.170:19132 SSRC: 6556cba3 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [core] Handling packet: remote 10.13.1.170:19132 (expected: 10.13.1.170:19132) -> local 10.13.1.127:10064 (RTP seq 15470 TS 816 SSRC 6556cba3) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [srtp] Generated session key: master key 6aa546d4..., master salt 0fbc969f..., label 00, length 16, result a69177c7... Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [srtp] Generated session key: master key 6aa546d4..., master salt 0fbc969f..., label 01, length 20, result 03e236f1... Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [srtp] Generated session key: master key 6aa546d4..., master salt 0fbc969f..., label 02, length 14, result ad94bd3c... Mar 25 10:45:34 debian rtpengine[17868]: WARNING: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [core] Discarded invalid SRTP packet: authentication failed Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [core] Handling packet: remote 10.13.1.170:19132 (expected: 10.13.1.170:19132) -> local 10.13.1.127:10064 (RTP seq 15471 TS 1776 SSRC 6556cba3) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [core] New egress (direct) SSRC for: 0.0.0.0:9 SSRC: 6556cba3 Mar 25 10:45:34 debian rtpengine[17868]: ERR: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [core] SRTP output wanted, but no crypto suite was negotiated Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [core] Error when sending message. Error: Inappropriate ioctl for device Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [core] Handling packet: remote 10.13.1.170:19132 (expected: 10.13.1.170:19132) -> local 10.13.1.127:10064 (RTP seq 15472 TS 2736 SSRC 6556cba3) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [core] Handling packet: remote 10.13.1.170:19132 (expected: 10.13.1.170:19132) -> local 10.13.1.127:10064 (RTP seq 15473 TS 3696 SSRC 6556cba3) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [core] Handling packet: remote 10.13.1.170:19132 (expected: 10.13.1.170:19132) -> local 10.13.1.127:10064 (RTP seq 15474 TS 4656 SSRC 6556cba3) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1]: [ice] Start nominating ICE pairs Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1]: [ice] Nominating ICE pair JJ5Ebqjkkvu8vYdW:Ha0d01aa:1 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1]: [ice] Sending nominating ICE/STUN request for candidate pair JJ5Ebqjkkvu8vYdW:Ha0d01aa:1 from 10.13.1.127 to 10.13.1.170:19132 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [ice] Received ICE/STUN response code 0 for candidate pair JJ5Ebqjkkvu8vYdW:Ha0d01aa:1 from 10.13.1.170:19132 to 10.13.1.127 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [ice] Setting nominated ICE candidate pair JJ5Ebqjkkvu8vYdW:Ha0d01aa:1 as valid Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [ice] ICE completed, using pair JJ5Ebqjkkvu8vYdW:Ha0d01aa:1 Mar 25 10:45:34 debian rtpengine[17868]: INFO: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [ice] ICE negotiated: peer for component 1 is 10.13.1.170:19132 Mar 25 10:45:34 debian rtpengine[17868]: INFO: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [ice] ICE negotiated: local interface 10.13.1.127 Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [core] Handling packet: remote 10.13.1.170:19132 (expected: 10.13.1.170:19132) -> local 10.13.1.127:10064 (RTP seq 15475 TS 5616 SSRC 6556cba3) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [core] Handling packet: remote 10.13.1.170:19132 (expected: 10.13.1.170:19132) -> local 10.13.1.127:10064 (RTP seq 15476 TS 6576 SSRC 6556cba3) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [core] Handling packet: remote 10.13.1.170:19132 (expected: 10.13.1.170:19132) -> local 10.13.1.127:10064 (RTP seq 15477 TS 7536 SSRC 6556cba3) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [core] Handling packet: remote 10.13.1.170:19132 (expected: 10.13.1.170:19132) -> local 10.13.1.127:10064 (RTP seq 15478 TS 8496 SSRC 6556cba3) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [core] Handling packet: remote 10.13.1.170:19132 (expected: 10.13.1.170:19132) -> local 10.13.1.127:10064 (RTP seq 15479 TS 9456 SSRC 6556cba3) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [core] Handling packet: remote 10.13.1.170:19132 (expected: 10.13.1.170:19132) -> local 10.13.1.127:10064 (RTP seq 15480 TS 10416 SSRC 6556cba3) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [core] Handling packet: remote 10.13.1.170:19132 (expected: 10.13.1.170:19132) -> local 10.13.1.127:10064 (RTP seq 15481 TS 11376 SSRC 6556cba3) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [core] Handling packet: remote 10.13.1.170:19132 (expected: 10.13.1.170:19132) -> local 10.13.1.127:10064 (RTP seq 15482 TS 12336 SSRC 6556cba3) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [core] Handling packet: remote 10.13.1.170:19132 (expected: 10.13.1.170:19132) -> local 10.13.1.127:10064 (RTP seq 15483 TS 13296 SSRC 6556cba3) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [core] Handling packet: remote 10.13.1.170:19132 (expected: 10.13.1.170:19132) -> local 10.13.1.127:10064 (RTP seq 15484 TS 14256 SSRC 6556cba3) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [core] Handling packet: remote 10.13.1.170:19132 (expected: 10.13.1.170:19132) -> local 10.13.1.127:10064 (RTP seq 15485 TS 15216 SSRC 6556cba3) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [core] Handling packet: remote 10.13.1.170:19132 (expected: 10.13.1.170:19132) -> local 10.13.1.127:10064 (RTP seq 15486 TS 16176 SSRC 6556cba3) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [core] Handling packet: remote 10.13.1.170:19132 (expected: 10.13.1.170:19132) -> local 10.13.1.127:10064 (RTP seq 15487 TS 17136 SSRC 6556cba3) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [core] Handling packet: remote 10.13.1.170:19132 (expected: 10.13.1.170:19132) -> local 10.13.1.127:10064 (RTP seq 15488 TS 18096 SSRC 6556cba3) Mar 25 10:45:34 debian rtpengine[17868]: DEBUG: [oaece23ntismpjeug83i/0cce98ab-33cc-4ac9-8a2b-1d52f012f940/1 port 10064]: [core] Handling packet: remote 10.13.1.170:19132 (expected: 10.13.1.170:19132) -> local 10.13.1.127:10064 (RTP seq 15489 TS 19056 SSRC 6556cba3)
On Sat, Mar 25, 2023 at 10:10 AM Arun K R mail4arunkr@gmail.com wrote:
You mean
No support for kernel packet forwarding available (encryption cipher
or HMAC not supported by kernel module
can you suggest how can i add kernel support for cipher or HMAC encryption if that is the issue.
Thank you
On Fri, Mar 24, 2023 at 5:58 PM Alex Balashov abalashov@evaristesys.com wrote:
It seems to me the answer might be in the logs you posted:
On Mar 24, 2023, at 3:41 AM, Arun K R mail4arunkr@gmail.com wrote:
Mar 24 13:07:02 debian rtpengine[7345]: WARNING:
[8asmubtpv46ac7nrfk57/223df8fa-8106-48af-844f-33f97530a0d8/1 port 10940]: [core] No support for kernel packet forwarding available (encryption cipher or HMAC not supported by kernel module)
Mar 24 13:07:02 debian rtpengine[7345]: NOTICE:
[8asmubtpv46ac7nrfk57/223df8fa-8106-48af-844f-33f97530a0d8/1 port 10940]: [core] Setting 'non-forwarding' flag for kernel stream due to lack of sinks
Mar 24 13:07:03 debian rtpengine[7345]: ERR:
[8asmubtpv46ac7nrfk57/223df8fa-8106-48af-844f-33f97530a0d8/1 port 10940]: [rtcp] SRTCP output wanted, but no crypto suite was negotiated
Mar 24 13:07:03 debian rtpengine[7345]: INFO:
[8asmubtpv46ac7nrfk57/223df8fa-8106-48af-844f-33f97530a0d8/1 port 10940]: [core] Removing media stream from kernel: local 10.13.1.127:10940
Mar 24 13:07:03 debian rtpengine[7345]: INFO:
[8asmubtpv46ac7nrfk57/223df8fa-8106-48af-844f-33f97530a0d8/1 port 10940]: [core] Kernelizing media stream: 10.13.1.170:15634 -> 10.13.1.127:10940 | 10.13.1.127:10960 -> 192.168.30.200:53489
Mar 24 13:07:03 debian rtpengine[7345]: WARNING:
[8asmubtpv46ac7nrfk57/223df8fa-8106-48af-844f-33f97530a0d8/1 port 10940]: [core] No support for kernel packet forwarding available (encryption cipher or HMAC not supported by kernel module)
-- Alex Balashov Principal Consultant Evariste Systems LLC Web: https://evaristesys.com Tel: +1-706-510-6800
Kamailio - Users Mailing List - Non Commercial Discussions To unsubscribe send an email to sr-users-leave@lists.kamailio.org Important: keep the mailing list in the recipients, do not reply only to the sender! Edit mailing list options or unsubscribe:
-
Alex Balashov -
Arun K R