RTPEngine auto restarting and no audio in communication

357 views
Skip to first unread message

Virendra Bhati

unread,
Feb 16, 2022, 2:33:56 AM2/16/22
to rtpengine
Dear Team,
In my Centos 7 system I am facing strange issue, may be due to a lot of install / reinstall I did for OpenSSL, RTPEngine and other dependency to make it working.

Now whenever audio is not passing then below error is coming...

Feb 16 12:46:33 ectl-pbx rtpengine[43685]: ERR: [324ff305-099b-123b-a78b-b2533b44fe95]: [ffmpeg] av_log: Specified sample format -1 is invalid or not supported
Feb 16 12:46:33 ectl-pbx rtpengine[43685]: ERR: [324ff305-099b-123b-a78b-b2533b44fe95]: [core] Error returned from libav: Invalid argument
Feb 16 12:46:41 ectl-pbx rtpengine[44153]: INFO: [crypto] Generating new DTLS certificate
Feb 16 12:46:41 ectl-pbx rtpengine[44153]: DEBUG: [srtp] Dump of DTLS certificate:
Feb 16 12:46:41 ectl-pbx rtpengine[44153]: DEBUG: [srtp] --- -----BEGIN CERTIFICATE-----
Feb 16 12:46:41 ectl-pbx rtpengine[44153]: DEBUG: [srtp] --- MIICpDCCAYwCCQDhEdGLm0vlIDANBgkqhkiG9w0BAQsFADAUMRIwEAYDVQQDDAly
Feb 16 12:46:41 ectl-pbx rtpengine[44153]: DEBUG: [srtp] --- dHBlbmdpbmUwHhcNMjIwMjE1MDcxNjQxWhcNMjIwMzE4MDcxNjQxWjAUMRIwEAYD
Feb 16

I have installed ffmpeg but what is the issue of this module ?
Why every time on restart DTLS certificate is generate, Will it impact on RTPEgnine Handshaking on running call ?

I am ready to take commercial help if in case my question is out of context.

Richard Fuchs

unread,
Feb 16, 2022, 7:37:02 AM2/16/22
to rtpe...@googlegroups.com
On 16/02/2022 02.33, [EXT] 'Virendra Bhati' via rtpengine wrote:
Dear Team,
In my Centos 7 system I am facing strange issue, may be due to a lot of install / reinstall I did for OpenSSL, RTPEngine and other dependency to make it working.

Now whenever audio is not passing then below error is coming...

Feb 16 12:46:33 ectl-pbx rtpengine[43685]: ERR: [324ff305-099b-123b-a78b-b2533b44fe95]: [ffmpeg] av_log: Specified sample format -1 is invalid or not supported
Feb 16 12:46:33 ectl-pbx rtpengine[43685]: ERR: [324ff305-099b-123b-a78b-b2533b44fe95]: [core] Error returned from libav: Invalid argument
Feb 16 12:46:41 ectl-pbx rtpengine[44153]: INFO: [crypto] Generating new DTLS certificate
Feb 16 12:46:41 ectl-pbx rtpengine[44153]: DEBUG: [srtp] Dump of DTLS certificate:
Feb 16 12:46:41 ectl-pbx rtpengine[44153]: DEBUG: [srtp] --- -----BEGIN CERTIFICATE-----
Feb 16 12:46:41 ectl-pbx rtpengine[44153]: DEBUG: [srtp] --- MIICpDCCAYwCCQDhEdGLm0vlIDANBgkqhkiG9w0BAQsFADAUMRIwEAYDVQQDDAly
Feb 16 12:46:41 ectl-pbx rtpengine[44153]: DEBUG: [srtp] --- dHBlbmdpbmUwHhcNMjIwMjE1MDcxNjQxWhcNMjIwMzE4MDcxNjQxWjAUMRIwEAYD
Feb 16

I have installed ffmpeg but what is the issue of this module ?

What happened just previously to this message? I'm guessing you're doing some transcoding. What codecs are involved? Turn on debug logging and post the full log.

Cheers

Virendra Bhati

unread,
Feb 16, 2022, 1:00:10 PM2/16/22
to Richard Fuchs, rtpe...@googlegroups.com
Dear Richard,
Transcoding we are doing at Media Server(Freeswitch). RTPEngine is just for port and webRTC handling with the SDP modification we want to use.

Below is a code glimpse of OpenSIPS.

branch_route[per_branch_ops] {
        if (has_body_part("application/sdp")) {
                        $var(rtpengine_flags) = "replace-session-connection replace-origin ";
                        # if the call comes from WSS, accept RTCP mux
                        if (isflagset("SRC_WS"))
                                        $var(rtpengine_flags) = $var(rtpengine_flags) + "rtcp-mux-accept ";
                        # if the call goes to WSS, add DTLS
                        if (isbflagset("DST_WS"))
                                        $var(rtpengine_flags) = $var(rtpengine_flags) + "UDP/TLS/RTP/SAVPF ICE=force rtcp-mux-require SDES-off";
                        else
                                        $var(rtpengine_flags) = $var(rtpengine_flags) + "RTP/AVP ICE=remove";               
                        rtpengine_offer($var(rtpengine_flags));
        }
}
onreply_route[handle_nat] {
        xlog("[$ci] incoming reply\n");
    if (nat_uac_test(1))
        fix_nated_contact();
        if ($socket_in(proto) == "wss")
                fix_nated_contact();

    if (t_check_status("(183)|(200)|(180)") && has_body("application/sdp")) {
                $var(rtpengine_flags) = "replace-session-connection replace-origin ";
                # if the call goes to WSS, add DTLS
                if (isflagset("SRC_WS"))
                        $var(rtpengine_flags) = $var(rtpengine_flags) + "UDP/TLS/RTP/SAVPF ICE=force rtcp-mux-require SDES-off";
                else if (isbflagset("DST_WS"))
                                        $var(rtpengine_flags) = $var(rtpengine_flags) + "UDP/TLS/RTP/SAVPF ICE=force rtcp-mux-require SDES-off";
                                else
                    $var(rtpengine_flags) = $var(rtpengine_flags) + "RTP/AVP ICE=remove";
                rtpengine_answer($var(rtpengine_flags));
    }
}

Sysylogs
Feb 16 23:20:26 ectl-pbx systemd: Failed to start Kernel based rtp proxy.
Feb 16 23:20:26 ectl-pbx systemd: Unit rtpengine.service entered failed state.
Feb 16 23:20:26 ectl-pbx systemd: rtpengine.service failed.
Feb 16 23:20:26 ectl-pbx systemd: rtpengine.service holdoff time over, scheduling restart.
Feb 16 23:20:26 ectl-pbx systemd: Stopped Kernel based rtp proxy.
Feb 16 23:20:26 ectl-pbx systemd: Starting Kernel based rtp proxy...
Feb 16 23:20:26 ectl-pbx systemd: rtpengine.service: control process exited, code=exited status=255
Feb 16 23:20:26 ectl-pbx systemd: Failed to start Kernel based rtp proxy.
Feb 16 23:20:26 ectl-pbx systemd: Unit rtpengine.service entered failed state.
Feb 16 23:20:26 ectl-pbx systemd: rtpengine.service failed.
Feb 16 23:20:26 ectl-pbx systemd: rtpengine.service holdoff time over, scheduling restart.
Feb 16 23:20:26 ectl-pbx systemd: Stopped Kernel based rtp proxy.
Feb 16 23:20:26 ectl-pbx systemd: Starting Kernel based rtp proxy...
Feb 16 23:20:26 ectl-pbx systemd: rtpengine.service: control process exited, code=exited status=255

RTPEngine Logs
Feb 16 14:30:41 ectl-pbx rtpengine[46265]: INFO: [control] Received command 'ping' from 127.0.0.1:53282
Feb 16 14:30:41 ectl-pbx rtpengine[46265]: DEBUG: [control] Dump for 'ping' from 127.0.0.1:53282: { "command": "ping" }
Feb 16 14:30:41 ectl-pbx rtpengine[46265]: INFO: [control] Replying to 'ping' from 127.0.0.1:53282 (elapsed time 0.000003 sec)
Feb 16 14:30:41 ectl-pbx rtpengine[46265]: DEBUG: [control] Response dump for 'ping' to 127.0.0.1:53282: { "result": "pong" }
Feb 16 14:30:42 ectl-pbx rtpengine[46265]: DEBUG: [core] timer run time = 0.000100 sec
Feb 16 14:30:43 ectl-pbx rtpengine[46265]: DEBUG: [core] timer run time = 0.000114 sec
Feb 16 14:30:44 ectl-pbx rtpengine[46265]: DEBUG: [core] timer run time = 0.000114 sec
Feb 16 14:30:45 ectl-pbx rtpengine[46265]: DEBUG: [core] timer run time = 0.000114 sec
Feb 16 14:30:46 ectl-pbx rtpengine[46265]: DEBUG: [core] timer run time = 0.000106 sec
Feb 16 14:30:47 ectl-pbx rtpengine[46265]: DEBUG: [core] timer run time = 0.000099 sec
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [core] timer run time = 0.000101 sec
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: INFO: [CwPAkBQLQ2I1NegR38T2UA..]: [control] Received command 'offer' from 127.0.0.1:52996
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [control] Dump for 'offer' from 127.0.0.1:52996: { "sdp": "v=0#015#012o=Z 1620167466 1 IN IP4 192.168.2.235#015#012s=Z#015#012c=IN IP4 192.168.2.235#015#012t=0 0#015#012m=audio 8000 RTP/AVP 106 111 97 110 112 98 100 101 99 102 0 8 9 3#015#012a=rtpmap:106 opus/48000/2#015#012a=fmtp:106 minptime=20; useinbandfec=1#015#012a=rtpmap:111 speex/16000#015#012a=rtpmap:97 iLBC/8000#015#012a=fmtp:97 mode=20#015#012a=rtpmap:110 speex/8000#015#012a=rtpmap:112 speex/32000#015#012a=rtpmap:98 telephone-event/48000#015#012a=fmtp:98 0-16#015#012a=rtpmap:100 telephone-event/16000#015#012a=fmtp:100 0-16#015#012a=rt ...
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: ... pmap:101 telephone-event/8000#015#012a=fmtp:101 0-16#015#012a=rtpmap:99 telephone-event/32000#015#012a=fmtp:99 0-16#015#012a=rtpmap:102 G726-32/8000#015#012a=sendrecv#015#012", "ICE": "remove", "replace": [ "session-connection", "origin" ], "transport-protocol": "RTP/AVP", "call-id": "CwPAkBQLQ2I1NegR38T2UA..", "received-from": [ "IP4", "103.61.114.110" ], "from-tag": "3a3ef342", "command": "offer" }
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: NOTICE: [CwPAkBQLQ2I1NegR38T2UA..]: [core] Creating new call
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [core] Subscribing '3a3ef342' to ''
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [core] Subscribing '' to '3a3ef342'
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [codec] Updating codecs for offerer 3a3ef342 #1
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [codec] Adding codec opus/48000/2 (106)
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [codec] Using passthrough handler for PCMA/8000 with DTMF 101, CN -1
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [codec] Checking receiver codec G722/8000/1 (9)
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [codec] Sink codec is G722/8000/1 (9)
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [codec] Sink supports codec G722/8000 for passthrough
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [codec] Using passthrough handler for G722/8000 with DTMF 101, CN -1
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [codec] Checking receiver codec GSM/8000/1 (3)
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [codec] Sink codec is GSM/8000/1 (3)
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [codec] Sink supports codec GSM/8000 for passthrough
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [codec] Using passthrough handler for GSM/8000 with DTMF 101, CN -1
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [core] set FILLED flag for stream, local 10.10.144.212:10018 remote 192.168.2.235:8000
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [core] set FILLED flag for stream, local 10.10.144.212:10019 remote 192.168.2.235:8001
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: INFO: [CwPAkBQLQ2I1NegR38T2UA..]: [control] Replying to 'offer' from 127.0.0.1:52996 (elapsed time 0.003100 sec)
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [control] Response dump for 'offer' to 127.0.0.1:52996: { "sdp": "v=0#015#012o=Z 1620167466 1 IN IP4 103.163.40.13#015#012s=Z#015#012c=IN IP4 103.163.40.13#015#012t=0 0#015#012m=audio 10000 RTP/AVP 106 111 97 110 112 98 100 101 99 102 0 8 9 3#015#012a=rtpmap:106 opus/48000/2#015#012a=fmtp:106 minptime=20; useinbandfec=1#015#012a=rtpmap:111 speex/16000#015#012a=rtpmap:97 iLBC/8000#015#012a=fmtp:97 mode=20#015#012a=rtpmap:110 speex/8000#015#012a=rtpmap:112 speex/32000#015#012a=rtpmap:98 telephone-event/48000#015#012a=fmtp:98 0-16#015#012a=rtpmap:100 telephone-event/16000#015#012a=fmtp:100 0- ...
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: ... 16#015#012a=rtpmap:101 telephone-event/8000#015#012a=fmtp:101 0-16#015#012a=rtpmap:99 telephone-event/32000#015#012a=fmtp:99 0-16#015#012a=rtpmap:102 G726-32/8000#015#012a=rtpmap:0 PCMU/8000#015#012a=rtpmap:8 PCMA/8000#015#012a=rtpmap:9 G722/8000#015#012a=rtpmap:3 GSM/8000#015#012a=sendrecv#015#012a=rtcp:10001#015#012", "result": "ok" }
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: INFO: [CwPAkBQLQ2I1NegR38T2UA..]: [control] Received command 'answer' from 127.0.0.1:37700
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [control] Dump for 'answer' from 127.0.0.1:37700: { "sdp": "v=0#015#012o=FreeSWITCH 1644970918 1644970919 IN IP4 10.10.144.212#015#012s=FreeSWITCH#015#012c=IN IP4 10.10.144.212#015#012t=0 0#015#012m=audio 31130 RTP/AVP 0 101#015#012a=rtpmap:0 PCMU/8000#015#012a=rtpmap:101 telephone-event/8000#015#012a=fmtp:101 0-16#015#012a=ptime:20#015#012a=rtcp:31131 IN IP4 10.10.144.212#015#012", "ICE": "remove", "replace": [ "session-connection", "origin" ], "transport-protocol": "RTP/AVP", "call-id": "CwPAkBQLQ2I1NegR38T2UA..", "received-from": [ "IP4", "10.10.144.212" ], ...
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: ...  "from-tag": "3a3ef342", "to-tag": "NUjpm8ry09Sgj", "command": "answer" }
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [core] Unconfirming peer address for local 10.10.144.212:10000
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [core] Unconfirming peer address for local 10.10.144.212:10018
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [core] Unconfirming peer address for local 10.10.144.212:10001
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [core] Unconfirming peer address for local 10.10.144.212:10019
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [core] Unsubscribing '3a3ef342' from 'NUjpm8ry09Sgj'
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [core] Unsubscribing 'NUjpm8ry09Sgj' from '3a3ef342'
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [core] Subscribing 'NUjpm8ry09Sgj' to '3a3ef342'
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [core] Subscribing '3a3ef342' to 'NUjpm8ry09Sgj'
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [codec] Updating codecs for answerer NUjpm8ry09Sgj #1
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [codec] Adding codec PCMU/8000 (0)
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [codec] Adding codec telephone-event/8000 (101)
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [codec] Setting up codec handlers for NUjpm8ry09Sgj -> 3a3ef342 (media #1)
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [codec] Default sink codec is speex/16000
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [codec] Checking receiver codec PCMU/8000/1 (0)
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [codec] Sink codec is PCMU/8000/1 (0)
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [codec] Setting up codec handlers for NUjpm8ry09Sgj -> 3a3ef342 (media #1)
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [codec] Default sink codec is PCMU/8000
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [codec] Checking receiver codec PCMU/8000/1 (0)
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [codec] Sink codec is PCMU/8000/1 (0)
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [codec] Sink supports codec PCMU/8000 for passthrough
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [codec] Using passthrough handler for PCMU/8000 with DTMF 101, CN -1
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [codec] Checking receiver codec telephone-event/8000/1 (101)
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [codec] Sink codec is telephone-event/8000/1 (101)
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [codec] Sink supports codec telephone-event/8000 for passthrough
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [codec] Using passthrough handler for telephone-event/8000 with DTMF 101, CN -1
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [core] set FILLED flag for stream, local 10.10.144.212:10000 remote 10.10.144.212:31130
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [core] set FILLED flag for stream, local 10.10.144.212:10001 remote 10.10.144.212:31131
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: INFO: [CwPAkBQLQ2I1NegR38T2UA..]: [control] Replying to 'answer' from 127.0.0.1:37700 (elapsed time 0.001859 sec)
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA..]: [control] Response dump for 'answer' to 127.0.0.1:37700: { "sdp": "v=0#015#012o=FreeSWITCH 1644970918 1644970919 IN IP4 103.163.40.13#015#012s=FreeSWITCH#015#012c=IN IP4 103.163.40.13#015#012t=0 0#015#012m=audio 10018 RTP/AVP 0 101#015#012a=rtpmap:0 PCMU/8000#015#012a=rtpmap:101 telephone-event/8000#015#012a=fmtp:101 0-16#015#012a=sendrecv#015#012a=rtcp:10019#015#012a=ptime:20#015#012", "result": "ok" }
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA.. port 10018]: [core] New ingress SSRC for: 192.168.2.235:8000 SSRC: abefb05a
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: WARNING: [CwPAkBQLQ2I1NegR38T2UA.. port 10018]: [core] RTP packet with unknown payload type 95 received from 103.61.114.110:9506
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA.. port 10018]: [core] Peer address changed from 192.168.2.235:8000 to 103.61.114.110:9506
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA.. port 10018]: [core] New egress SSRC for: 10.10.144.212:31130 SSRC: abefb05a
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA.. port 10000]: [core] Forward to sink endpoint: 10.10.144.212:31130 (RTP seq 23203 TS 582870772)
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: INFO: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [control] Received command 'offer' from 127.0.0.1:34710
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [control] Dump for 'offer' from 127.0.0.1:34710: { "sdp": "v=0#015#012o=FreeSWITCH 1644982654 1644982655 IN IP4 10.10.144.212#015#012s=FreeSWITCH#015#012c=IN IP4 10.10.144.212#015#012t=0 0#015#012m=audio 19394 RTP/AVP 9 18 3 102 8 0 101 104#015#012a=rtpmap:9 G722/8000#015#012a=rtpmap:18 G729/8000#015#012a=rtpmap:3 GSM/8000#015#012a=rtpmap:102 opus/48000/2#015#012a=fmtp:102 useinbandfec=1; maxaveragebitrate=30000; maxplaybackrate=48000; ptime=20; minptime=10; maxptime=40#015#012a=rtpmap:8 PCMA/8000#015#012a=rtpmap:0 PCMU/8000#015#012a=rtpmap:101 telephone-event/8000#015#012a=fmt ...
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: ... p:101 0-16#015#012a=rtpmap:104 telephone-event/48000#015#012a=fmtp:104 0-16#015#012a=ptime:20#015#012m=video 35376 RTP/AVP 103#015#012b=AS:1024#015#012a=rtpmap:103 VP8/90000#015#012a=rtcp-fb:103 ccm fir#015#012a=rtcp-fb:103 ccm tmmbr#015#012a=rtcp-fb:103 nack#015#012a=rtcp-fb:103 nack pli#015#012", "ICE": "remove", "replace": [ "session-connection", "origin" ], "transport-protocol": "RTP/AVP", "call-id": "c69d3d74-09a9-123b-a78b-b2533b44fe95", "received-from": [ "IP4", "10.10.144.212" ], "from-tag": "p4BFp391Xjg3D", "command": "offer" }
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: NOTICE: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [core] Creating new call
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [core] Subscribing 'p4BFp391Xjg3D' to ''
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [core] Subscribing '' to 'p4BFp391Xjg3D'
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Updating codecs for offerer p4BFp391Xjg3D #1
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Adding codec G722/8000 (9)
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Adding codec G729/8000 (18)
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Adding codec GSM/8000 (3)
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Adding codec opus/48000/2 (102)
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Sink codec is PCMU/8000/1 (0)
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Sink supports codec PCMU/8000 for passthrough
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Using passthrough handler for PCMU/8000 with DTMF 101, CN -1
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Checking receiver codec telephone-event/8000/1 (101)
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Sink codec is telephone-event/8000/1 (101)
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Sink supports codec telephone-event/8000 for passthrough
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Using passthrough handler for telephone-event/8000 with DTMF 101, CN -1
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Checking receiver codec telephone-event/48000/1 (104)
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Sink codec is telephone-event/48000/1 (104)
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Sink supports codec telephone-event/48000 for passthrough
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Using passthrough handler for telephone-event/48000 with DTMF 104, CN -1
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Updating codecs for offerer p4BFp391Xjg3D #2
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Adding codec VP8/90000 (103)
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Updating codecs for answerer  #2
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Adding codec VP8/90000 (103)
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Updating supplemental codecs for  #2
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Setting up codec handlers for  -> p4BFp391Xjg3D (media #2)
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Checking receiver codec VP8/90000/1 (103)
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Creating codec handler for VP8/90000 (103)
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] No codec support for VP8/90000
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Using passthrough handler for VP8/90000 with DTMF -1, CN -1
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Updating supplemental codecs for  #2
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Setting up codec handlers for  -> p4BFp391Xjg3D (media #2)
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Checking receiver codec VP8/90000/1 (103)
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] No codec support for VP8/90000
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Using passthrough handler for VP8/90000 with DTMF -1, CN -1
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [core] set FILLED flag for stream, local 10.10.144.212:10034 remote 10.10.144.212:19394
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [core] set FILLED flag for stream, local 10.10.144.212:10035 remote 10.10.144.212:19395
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [core] set FILLED flag for stream, local 10.10.144.212:10064 remote 10.10.144.212:35376
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [core] set FILLED flag for stream, local 10.10.144.212:10065 remote 10.10.144.212:35377
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: INFO: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [control] Replying to 'offer' from 127.0.0.1:34710 (elapsed time 0.003627 sec)
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [control] Response dump for 'offer' to 127.0.0.1:34710: { "sdp": "v=0#015#012o=FreeSWITCH 1644982654 1644982655 IN IP4 103.163.40.13#015#012s=FreeSWITCH#015#012c=IN IP4 103.163.40.13#015#012t=0 0#015#012m=audio 10026 RTP/AVP 9 18 3 102 8 0 101 104#015#012a=rtpmap:9 G722/8000#015#012a=rtpmap:18 G729/8000#015#012a=rtpmap:3 GSM/8000#015#012a=rtpmap:102 opus/48000/2#015#012a=fmtp:102 useinbandfec=1; maxaveragebitrate=30000; maxplaybackrate=48000; ptime=20; minptime=10; maxptime=40#015#012a=rtpmap:8 PCMA/8000#015#012a=rtpmap:0 PCMU/8000#015#012a=rtpmap:101 telephone-event/8000 ...
Feb 16 14:30:48 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: ... #015#012a=fmtp:101 0-16#015#012a=rtpmap:104 telephone-event/48000#015#012a=fmtp:104 0-16#015#012a=sendrecv#015#012a=rtcp:10027#015#012a=ptime:20#015#012m=video 10052 RTP/AVP 103#015#012b=AS:1024#015#012a=rtpmap:103 VP8/90000#015#012a=rtcp-fb:103 ccm fir#015#012a=rtcp-fb:103 ccm tmmbr#015#012a=rtcp-fb:103 nack#015#012a=rtcp-fb:103 nack pli#015#012a=sendrecv#015#012a=rtcp:10053#015#012", "result": "ok" }
Feb 16 14:30:49 ectl-pbx rtpengine[46265]: DEBUG: [core] timer run time = 0.000137 sec
Feb 16 14:30:49 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA.. port 10000]: [core] New ingress SSRC for: 10.10.144.212:31130 SSRC: e60d85e8
Feb 16 14:30:49 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA.. port 10000]: [core] Peer address changed from 10.10.144.212:31130 to 103.163.40.13:31130

Feb 16 14:30:52 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA.. port 10001]: [core] New ingress SSRC for: 10.10.144.212:31131 SSRC: e60d85e8
Feb 16 14:30:52 ectl-pbx rtpengine[46265]: INFO: [CwPAkBQLQ2I1NegR38T2UA.. port 10001]: [core] Confirmed peer address as 10.10.144.212:31131
Feb 16 14:30:52 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA.. port 10001]: [core] New egress SSRC for: 103.61.114.110:4115 SSRC: e60d85e8
Feb 16 14:30:52 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA.. port 10001]: [rtcp] Calling handler for RTCP packet type 200
Feb 16 14:30:52 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA.. port 10001]: [core] SR from e60d85e8: RTP TS 26720 PC 167 OC 26720 NTP TS 3853990852/2741928596=3853990852.638405
Feb 16 14:30:52 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA.. port 10001]: [core] RR from e60d85e8 about abefb05a: FL 1 TL 1 HSR 23340 J 0 LSR 0 DLSR 0
Feb 16 14:30:52 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA.. port 10001]: [core] No payload type known for RTCP RR, discarding
Feb 16 14:30:52 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA.. port 10001]: [rtcp] Calling handler for RTCP packet type 202
Feb 16 14:30:52 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA.. port 10019]: [core] Forward to sink endpoint: 103.61.114.110:4115
Feb 16 14:30:52 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA.. port 10018]: [core] Forward to sink endpoint: 103.61.114.110:9506 (RTP seq 47724 TS 26880)
Feb 16 14:30:52 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA.. port 10018]: [core] Forward to sink endpoint: 103.61.114.110:9506 (RTP seq 47725 TS 27040)
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA.. port 10000]: [core] Forward to sink endpoint: 103.163.40.13:31130 (RTP seq 23381 TS 582899092)
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA.. port 10018]: [core] Forward to sink endpoint: 103.61.114.110:9506 (RTP seq 47764 TS 33280)
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA.. port 10000]: [core] Forward to sink endpoint: 103.163.40.13:31130 (RTP seq 23382 TS 582899252)
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA.. port 10018]: [core] Forward to sink endpoint: 103.61.114.110:9506 (RTP seq 47765 TS 33440)
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA.. port 10000]: [core] Forward to sink endpoint: 103.163.40.13:31130 (RTP seq 23383 TS 582899412)
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA.. port 10018]: [core] Forward to sink endpoint: 103.61.114.110:9506 (RTP seq 47766 TS 33600)
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA.. port 10000]: [core] Forward to sink endpoint: 103.163.40.13:31130 (RTP seq 23384 TS 582899572)
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA.. port 10018]: [core] Forward to sink endpoint: 103.61.114.110:9506 (RTP seq 47767 TS 33760)
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA.. port 10000]: [core] Forward to sink endpoint: 103.163.40.13:31130 (RTP seq 23385 TS 582899732)
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA.. port 10018]: [core] Forward to sink endpoint: 103.61.114.110:9506 (RTP seq 47768 TS 33920)
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA.. port 10000]: [core] Forward to sink endpoint: 103.163.40.13:31130 (RTP seq 23386 TS 582899892)
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA.. port 10000]: [core] Forward to sink endpoint: 103.163.40.13:31130 (RTP seq 23387 TS 582900052)
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA.. port 10018]: [core] Forward to sink endpoint: 103.61.114.110:9506 (RTP seq 47769 TS 34080)
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95 port 10026]: [core] New ingress SSRC for: :0 SSRC: f4a83aa
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: WARNING: [c69d3d74-09a9-123b-a78b-b2533b44fe95 port 10026]: [core] RTP packet with unknown payload type 95 received from 103.61.114.110:21278
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95 port 10026]: [core] New egress SSRC for: 10.10.144.212:19394 SSRC: f4a83aa
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95 port 10034]: [core] Forward to sink endpoint: 10.10.144.212:19394 (RTP seq 21466 TS 2905552684)
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA.. port 10000]: [core] Forward to sink endpoint: 103.163.40.13:31130 (RTP seq 23388 TS 582900212)
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: INFO: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [control] Received command 'answer' from 127.0.0.1:37700
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [control] Dump for 'answer' from 127.0.0.1:37700: { "sdp": "v=0#015#012o=Zoiper 0 3 IN IP4 192.168.2.203#015#012s=Z#015#012c=IN IP4 192.168.2.203#015#012t=0 0#015#012m=audio 54605 RTP/AVP 3 0 8 97 110 101#015#012a=rtpmap:97 iLBC/8000#015#012a=fmtp:97 mode=30#015#012a=rtpmap:110 speex/8000#015#012a=rtpmap:101 telephone-event/8000#015#012a=fmtp:101 0-16#015#012a=sendrecv#015#012m=video 0 RTP/AVP 103#015#012a=rtpmap:103 VP8/90000#015#012a=sendrecv#015#012", "ICE": "remove", "replace": [ "session-connection", "origin" ], "transport-protocol": "RTP/AVP", "call-id": "c69d3d74-09a9-123b-a78 ...
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: ... b-b2533b44fe95", "received-from": [ "IP4", "103.61.114.110" ], "from-tag": "p4BFp391Xjg3D", "to-tag": "c7cec137", "command": "answer" }
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [core] Unconfirming peer address for local 10.10.144.212:10026
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [core] Unconfirming peer address for local 10.10.144.212:10034
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [core] Unconfirming peer address for local 10.10.144.212:10027
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [core] Unconfirming peer address for local 10.10.144.212:10035
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [core] Unconfirming peer address for local 10.10.144.212:10052
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [core] Unconfirming peer address for local 10.10.144.212:10064
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [core] Unconfirming peer address for local 10.10.144.212:10053
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [core] Unconfirming peer address for local 10.10.144.212:10065
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [core] Unsubscribing 'p4BFp391Xjg3D' from 'c7cec137'
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [core] Unsubscribing 'c7cec137' from 'p4BFp391Xjg3D'
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [core] Subscribing 'c7cec137' to 'p4BFp391Xjg3D'
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [core] Subscribing 'p4BFp391Xjg3D' to 'c7cec137'
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Updating codecs for answerer c7cec137 #1
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Adding codec GSM/8000 (3)
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Adding codec PCMU/8000 (0)

Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Adding codec PCMA/8000 (8)
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Adding codec iLBC/8000 (97)
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Adding codec speex/8000 (110)
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Adding codec telephone-event/8000 (101)
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Setting up codec handlers for c7cec137 -> p4BFp391Xjg3D (media #1)
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [CwPAkBQLQ2I1NegR38T2UA.. port 10018]: [core] Forward to sink endpoint: 103.61.114.110:9506 (RTP seq 47770 TS 34240)
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Default sink codec is G722/8000
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Checking receiver codec GSM/8000/1 (3)
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Sink codec is GSM/8000/1 (3)
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Sink supports codec GSM/8000 for passthrough
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Using passthrough handler for GSM/8000 with DTMF 101, CN -1
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Checking receiver codec PCMU/8000/1 (0)
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Sink codec is PCMU/8000/1 (0)
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Sink supports codec PCMU/8000 for passthrough
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Using passthrough handler for PCMU/8000 with DTMF 101, CN -1
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Checking receiver codec PCMA/8000/1 (8)
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Sink codec is PCMA/8000/1 (8)
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Sink supports codec PCMA/8000 for passthrough
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Using passthrough handler for PCMA/8000 with DTMF 101, CN -1
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Checking receiver codec iLBC/8000/1 (97)
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Creating codec handler for iLBC/8000 (97)
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] No codec support for iLBC/8000
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Using passthrough handler for iLBC/8000 with DTMF -1, CN -1
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Checking receiver codec speex/8000/1 (110)
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Creating codec handler for speex/8000 (110)
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Sink codec is G722/8000/1 (9)
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Created transcode context for speex/8000 (110) -> G722/8000 (9) with DTMF output 101 and CN output -1
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: DEBUG: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [codec] Creating SSRC transcoder from speex/8000/1 to G722/8000/1
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: ERR: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [ffmpeg] av_log: Specified sample format -1 is invalid or not supported
Feb 16 14:30:53 ectl-pbx rtpengine[46265]: ERR: [c69d3d74-09a9-123b-a78b-b2533b44fe95]: [core] Error returned from libav: Invalid argument
Feb 16 14:30:59 ectl-pbx rtpengine[47593]: INFO: [crypto] Generating new DTLS certificate
Feb 16 14:31:00 ectl-pbx rtpengine[47593]: DEBUG: [srtp] Dump of DTLS certificate:
Feb 16 14:31:00 ectl-pbx rtpengine[47593]: DEBUG: [srtp] --- -----BEGIN CERTIFICATE-----
Feb 16 14:31:00 ectl-pbx rtpengine[47593]: DEBUG: [srtp] --- MIICpDCCAYwCCQC9vEWZ/lwTkzANBgkqhkiG9w0BAQsFADAUMRIwEAYDVQQDDAly



--
Regards



--
You received this message because you are subscribed to the Google Groups "rtpengine" group.
To unsubscribe from this group and stop receiving emails from it, send an email to rtpengine+...@googlegroups.com.
To view this discussion on the web visit https://groups.google.com/d/msgid/rtpengine/7b9143e1-58fd-9863-b2fa-3e099e839cd8%40sipwise.com.
For more options, visit https://groups.google.com/d/optout.

Richard Fuchs

unread,
Feb 16, 2022, 1:47:02 PM2/16/22
to rtpe...@googlegroups.com
Ultimately this is caused by the answer from Zoiper listing codecs that were not offered by FreeSWITCH, speex and iLBC in particular.

Offer:

m=audio 19394 RTP/AVP 9 18 3 102 8 0 101 104
a=rtpmap:9 G722/8000
a=rtpmap:18 G729/8000
a=rtpmap:3 GSM/8000
a=rtpmap:102 opus/48000/2
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=rtpmap:104 telephone-event/48000

Answer:

m=audio 54605 RTP/AVP 3 0 8 97 110 101
a=rtpmap:97 iLBC/8000
a=rtpmap:110 speex/8000
a=rtpmap:101 telephone-event/8000
a=sendrecv

This is unexpected and arguably broken behaviour. That being said, rtpengine should not attempt to transcode here as it was not instructed to do so, and I'll prepare a fix so that this doesn't happen.

There also seems to be a problem with your ffmpeg installation, but since you don't actually want to transcode anything you shouldn't worry about it.

Cheers

Virendra Bhati

unread,
Feb 17, 2022, 2:27:22 AM2/17/22
to Richard Fuchs, rtpe...@googlegroups.com
Dear Richard,
Thanks for your input. It was an issue due to RTPEngine Transcoding, I did fixed coded at both ends and then calls are working fine.

--
Regards
Virendra Bhati



Reply all
Reply to author
Forward
0 new messages