Skip to content

Instantly share code, notes, and snippets.

Embed
What would you like to do?
rtpengine log of reinvite failure
rtp engine logs
*** initial call setup works
*** call direction is 'private' (RTP) => 'public' (SRTP)
Apr 23 20:08:39 ip-172-31-0-20 rtpengine[24367]: INFO: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Received command 'offer' from 172.31.1.10:34912
Apr 23 20:08:39 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Dump for 'offer' from 172.31.1.10:34912: { "ICE": "force", "SDES": "off", "call-id": "8957589d-1f12-123a-269a-0a1d0f3877f3", "command": "offer", "direction": [ "private", "public" ], "flags": [ "generate mid", "SDES-no", "media handover", "port-latching" ], "from-tag": "UUKF63KS2e06H", "replace": [ "origin", "session-connection" ], "rtcp-mux": [ "require" ], "sdp": "v=0#015#012o=FreeSWITCH 1619174241 1619174242 IN IP4 172.31.1.243#015#012s=FreeSWITCH#015#012c=IN IP4 172.31.1.243#015#012t=0 0#015#012m=audio 34278 RTP/AVP 0 8 ...
Apr 23 20:08:39 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: ... 102 9 101 103#015#012a=rtpmap:0 PCMU/8000#015#012a=rtpmap:8 PCMA/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:9 G722/8000#015#012a=rtpmap:101 telephone-event/8000#015#012a=fmtp:101 0-16#015#012a=rtpmap:103 telephone-event/48000#015#012a=fmtp:103 0-16#015#012a=ptime:20#015#012a=sendrecv#015#012", "transport-protocol": "UDP/TLS/RTP/SAVPF" }
Apr 23 20:08:39 ip-172-31-0-20 rtpengine[24367]: NOTICE: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Creating new call
Apr 23 20:08:39 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Default sink codec is PCMU/8000
Apr 23 20:08:39 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: 0 DTMF sink entries
Apr 23 20:08:39 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Creating codec handler for PCMU/8000
Apr 23 20:08:39 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Sink supports codec PCMU/8000
Apr 23 20:08:39 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Using passthrough handler for PCMU/8000
Apr 23 20:08:39 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Creating codec handler for PCMA/8000
Apr 23 20:08:39 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Sink supports codec PCMA/8000
Apr 23 20:08:39 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Using passthrough handler for PCMA/8000
Apr 23 20:08:39 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Creating codec handler for opus/48000/2
Apr 23 20:08:39 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Sink supports codec opus/48000/2
Apr 23 20:08:39 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Using passthrough handler for opus/48000/2
Apr 23 20:08:39 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Creating codec handler for G722/8000
Apr 23 20:08:39 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Sink supports codec G722/8000
Apr 23 20:08:39 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Using passthrough handler for G722/8000
Apr 23 20:08:39 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Creating codec handler for telephone-event/8000
Apr 23 20:08:39 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Sink supports codec telephone-event/8000
Apr 23 20:08:39 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Using passthrough handler for telephone-event/8000
Apr 23 20:08:39 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Creating codec handler for telephone-event/48000
Apr 23 20:08:39 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Sink supports codec telephone-event/48000
Apr 23 20:08:39 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Using passthrough handler for telephone-event/48000
Apr 23 20:08:39 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: creating send_timer
Apr 23 20:08:39 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: creating send_timer
Apr 23 20:08:39 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: creating send_timer
Apr 23 20:08:39 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: creating send_timer
Apr 23 20:08:39 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: set FILLED flag for stream 172.31.1.243:34278
Apr 23 20:08:39 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: set FILLED flag for stream 172.31.1.243:34279
Apr 23 20:08:39 ip-172-31-0-20 rtpengine[24367]: INFO: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Replying to 'offer' from 172.31.1.10:34912 (elapsed time 0.000945 sec)
Apr 23 20:08:39 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Response dump for 'offer' to 172.31.1.10:34912: { "sdp": "v=0#015#012o=FreeSWITCH 1619174241 1619174242 IN IP4 54.75.202.242#015#012s=FreeSWITCH#015#012c=IN IP4 54.75.202.242#015#012t=0 0#015#012m=audio 40354 UDP/TLS/RTP/SAVPF 0 8 102 9 101 103#015#012a=mid:1#015#012a=rtpmap:0 PCMU/8000#015#012a=rtpmap:8 PCMA/8000#015#012a=rtpmap:102 opus/48000/2#015#012a=rtpmap:9 G722/8000#015#012a=rtpmap:101 telephone-event/8000#015#012a=rtpmap:103 telephone-event/48000#015#012a=fmtp:102 useinbandfec=1; maxaveragebitrate=30000; maxplaybackrate=48000; ptime=20; minptime=10; maxptime=40#015#012 ...
Apr 23 20:08:39 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: ... a=fmtp:101 0-16#015#012a=fmtp:103 0-16#015#012a=sendrecv#015#012a=rtcp:40354#015#012a=rtcp-mux#015#012a=setup:actpass#015#012a=fingerprint:sha-1 49:12:68:AF:83:DB:93:12:14:FF:19:D0:AB:EB:68:B6:03:7F:07:2F#015#012a=ptime:20#015#012a=ice-ufrag:60irUX7L#015#012a=ice-pwd:Hx5WT5Zv5sAEwK1U0ku46SiN7l#015#012a=candidate:2gYv8zXcssake06f 1 UDP 2130706431 54.75.202.242 40354 typ host
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Dump for 'answer' from 172.31.1.10:34912: { "DTLS": "off", "ICE": "remove", "SDES": "off", "call-id": "8957589d-1f12-123a-269a-0a1d0f3877f3", "command": "answer", "from-tag": "UUKF63KS2e06H", "replace": [ "origin", "session-connection" ], "rtcp-mux": [ "demux" ], "sdp": "v=0#015#012o=- 6056638454914285597 2 IN IP4 127.0.0.1#015#012s=-#015#012t=0 0#015#012a=msid-semantic: WMS WhXgI1rH4WGmRSv1zw0knStUaSnf232nfcUL#015#012m=audio 46482 UDP/TLS/RTP/SAVPF 0 8 102 9 101 103#015#012c=IN IP4 96.67.37.126#015#012a=rtcp:9 IN IP4 0.0.0.0#015#012a=candida ...
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: ... te:913812169 1 udp 2122260223 192.168.194.138 64574 typ host generation 0 network-id 2#015#012a=candidate:3456662903 1 udp 2122194687 10.0.1.5 49276 typ host generation 0 network-id 1 network-cost 10#015#012a=candidate:4050557278 1 udp 1685987071 96.67.37.126 46482 typ srflx raddr 10.0.1.5 rport 49276 generation 0 network-id 1 network-cost 10#015#012a=ice-ufrag:1/yr#015#012a=ice-pwd:SdWgwQILV9NSbcgYK5A6KRye#015#012a=ice-options:trickle#015#012a=fingerprint:sha-256 D2:8E:E4:0C:C2:F3:F9:CA:80:7D:61:F0:50:7C:10:A0:79:F9:1F:54:C5:B1:4 ...
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: ... 0:56:BB:42:2A:51:37:F0:54:11#015#012a=setup:active#015#012a=mid:1#015#012a=sendrecv#015#012a=msid:WhXgI1rH4WGmRSv1zw0knStUaSnf232nfcUL 70048776-e8a1-4f70-94d6-9248f638c0a4#015#012a=rtcp-mux#015#012a=rtpmap:0 PCMU/8000#015#012a=rtpmap:8 PCMA/8000#015#012a=rtpmap:102 opus/48000/2#015#012a=fmtp:102 minptime=10;useinbandfec=1#015#012a=rtpmap:9 G722/8000#015#012a=rtpmap:101 telephone-event/8000#015#012a=rtpmap:103 telephone-event/48000#015#012a=ssrc:4140947162 cname:VGFCjXcLcNjN84He#015#012a=ssrc:4140947162 msid:WhXgI1rH4WGmRSv1zw0knStUaSnf232nfcUL 70048776-e8a1-4f70-94d6-9248f638c0 ...
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: ... a4#015#012a=ssrc:4140947162 mslabel:WhXgI1rH4WGmRSv1zw0knStUaSnf232nfcUL#015#012a=ssrc:4140947162 label:70048776-e8a1-4f70-94d6-9248f638c0a4#015#012", "to-tag": "49kraktqtv", "transport protocol": "RTP/AVP" }
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Default sink codec is PCMU/8000
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: 0 DTMF sink entries
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Creating codec handler for PCMU/8000
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Sink supports codec PCMU/8000
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Using passthrough handler for PCMU/8000
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Creating codec handler for PCMA/8000
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Sink supports codec PCMA/8000
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Using passthrough handler for PCMA/8000
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Creating codec handler for opus/48000/2
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Sink supports codec opus/48000/2
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Using passthrough handler for opus/48000/2
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Creating codec handler for G722/8000
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Sink supports codec G722/8000
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Using passthrough handler for G722/8000
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Creating codec handler for telephone-event/8000
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Sink supports codec telephone-event/8000
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Using passthrough handler for telephone-event/8000
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Creating codec handler for telephone-event/48000
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Sink supports codec telephone-event/48000
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Using passthrough handler for telephone-event/48000
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: set FILLED flag for stream 96.67.37.126:46482
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: set FILLED flag for stream :0
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Learning new ICE candidate 913812169:1
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Created candidate pair 2gYv8zXcssake06f:913812169:1 between 172.31.0.20 and 192.168.194.138:64574, type host
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Learning new ICE candidate 3456662903:1
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Created candidate pair 2gYv8zXcssake06f:3456662903:1 between 172.31.0.20 and 10.0.1.5:49276, type host
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Learning new ICE candidate 4050557278:1
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Created candidate pair 2gYv8zXcssake06f:4050557278:1 between 172.31.0.20 and 96.67.37.126:46482, type srflx
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: scheduling timer object at 1619208529.251909
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Sending ICE/STUN request for candidate pair 2gYv8zXcssake06f:913812169:1 from 172.31.0.20 to 192.168.194.138:64574
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: scheduling timer object at 1619208529.151909
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3/49kraktqtv/1]: scheduling timer object at 1619208529.252312
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: INFO: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Replying to 'answer' from 172.31.1.10:34912 (elapsed time 0.000394 sec)
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3/49kraktqtv/1]: Sending ICE/STUN request for candidate pair 2gYv8zXcssake06f:3456662903:1 from 172.31.0.20 to 10.0.1.5:49276
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Response dump for 'answer' to 172.31.1.10:34912: { "sdp": "v=0#015#012o=- 6056638454914285597 2 IN IP4 172.31.0.20#015#012s=-#015#012t=0 0#015#012a=msid-semantic: WMS WhXgI1rH4WGmRSv1zw0knStUaSnf232nfcUL#015#012m=audio 40364 RTP/AVP 0 8 102 9 101 103#015#012c=IN IP4 172.31.0.20#015#012a=msid:WhXgI1rH4WGmRSv1zw0knStUaSnf232nfcUL 70048776-e8a1-4f70-94d6-9248f638c0a4#015#012a=ssrc:4140947162 cname:VGFCjXcLcNjN84He#015#012a=ssrc:4140947162 msid:WhXgI1rH4WGmRSv1zw0knStUaSnf232nfcUL 70048776-e8a1-4f70-94d6-9248f638c0a4#015#012a=ssrc:4140947162 mslabel:WhXgI1rH ...
Apr 23 20:08:49 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: ... 4WGmRSv1zw0knStUaSnf232nfcUL#015#012a=ssrc:4140947162 label:70048776-e8a1-4f70-94d6-9248f638c0a4#015#012a=rtpmap:0 PCMU/8000#015#012a=rtpmap:8 PCMA/8000#015#012a=rtpmap:102 opus/48000/2#015#012a=rtpmap:9 G722/8000#015#012a=rtpmap:101 telephone-event/8000#015#012a=rtpmap:103 telephone-event/48000#015#012a=fmtp:102 minptime=10;useinbandfec=1#015#012a=sendrecv#015#012a=rtcp:40
** we get a re-INVITE from the SRTP client, because he went on hold
** direction of re-INVITE is 'public' (SRTP) => 'private' (RTP)
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: INFO: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Received command 'offer' from 172.31.1.10:34912
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Dump for 'offer' from 172.31.1.10:34912: { "DTLS": "off", "ICE": "remove", "SDES": "off", "call-id": "8957589d-1f12-123a-269a-0a1d0f3877f3", "command": "offer", "direction": [ "public", "private" ], "from-tag": "UUKF63KS2e06H", "replace": [ "origin", "session-connection" ], "rtcp-mux": [ "demux" ], "sdp": "v=0#015#012o=- 6056638454914285597 3 IN IP4 127.0.0.1#015#012s=-#015#012t=0 0#015#012a=extmap-allow-mixed#015#012a=msid-semantic: WMS WhXgI1rH4WGmRSv1zw0knStUaSnf232nfcUL#015#012a=group:BUNDLE 1#015#012m=audio 46482 UDP/TLS/RTP/SAVPF ...
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: ... 0 8 102 9 101 103 127 104 106 105 13 112 113#015#012c=IN IP4 96.67.37.126#015#012a=rtpmap:0 PCMU/8000#015#012a=rtpmap:8 PCMA/8000#015#012a=rtpmap:102 opus/48000/2#015#012a=rtpmap:9 G722/8000#015#012a=rtpmap:101 telephone-event/8000#015#012a=rtpmap:103 telephone-event/48000#015#012a=rtpmap:127 ISAC/16000#015#012a=rtpmap:104 ISAC/32000#015#012a=rtpmap:106 CN/32000#015#012a=rtpmap:105 CN/16000#015#012a=rtpmap:13 CN/8000#015#012a=rtpmap:112 telephone-event/32000#015#012a=rtpmap:113 telephone-event/16000#015#012a=fmtp:102 minptime=10;useinbandfec=1#015#012a=rtcp:9 IN IP4 0.0.0.0#015#012a=extmap:1 urn ...
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: ... :ietf:params:rtp-hdrext:ssrc-audio-level#015#012a=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time#015#012a=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01#015#012a=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid#015#012a=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id#015#012a=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id#015#012a=setup:actpass#015#012a=mid:1#015#012a=msid:WhXgI1rH4WGmRSv1zw0knStUaSnf232nfcUL 70048776-e8a1-4f70-94d6-9248f638c0a4#015#012a=sendonly#015#012a=ice-uf ...
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: ... rag:1/yr#015#012a=ice-pwd:SdWgwQILV9NSbcgYK5A6KRye#015#012a=fingerprint:sha-256 D2:8E:E4:0C:C2:F3:F9:CA:80:7D:61:F0:50:7C:10:A0:79:F9:1F:54:C5:B1:40:56:BB:42:2A:51:37:F0:54:11#015#012a=candidate:913812169 1 udp 2122260223 192.168.194.138 64574 typ host generation 0 network-id 2#015#012a=candidate:3456662903 1 udp 2122194687 10.0.1.5 49276 typ host generation 0 network-id 1 network-cost 10#015#012a=candidate:4050557278 1 udp 1685987071 96.67.37.126 46482 typ srflx raddr 10.0.1.5 rport 49276 generation 0 network-id 1 network-c ...
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: ... ost 10#015#012a=candidate:2029278777 1 tcp 1518280447 192.168.194.138 9 typ host tcptype active generation 0 network-id 2#015#012a=candidate:2156626311 1 tcp 1518214911 10.0.1.5 9 typ host tcptype active generation 0 network-id 1 network-cost 10#015#012a=ice-options:trickle#015#012a=ssrc:4140947162 cname:VGFCjXcLcNjN84He#015#012a=ssrc:4140947162 msid:WhXgI1rH4WGmRSv1zw0knStUaSnf232nfcUL 70048776-e8a1-4f70-94d6-9248f638c0a4#015#012a=ssrc:4140947162 mslabel:WhXgI1rH4WGmRSv1zw0knStUaSnf232nfcUL#015#012a=ssrc:4140947162 label:70048776-e8a1- ...
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: ... 4f70-94d6-9248f638c0a4#015#012a=rtcp-mux#015#012", "to-tag": "49kraktqtv", "transport protocol": "RTP/AVP" }
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Default sink codec is PCMU/8000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: 0 DTMF sink entries
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Sink supports codec PCMU/8000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Using passthrough handler for PCMU/8000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Sink supports codec PCMA/8000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Using passthrough handler for PCMA/8000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Resetting codec handler for PT 102
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Creating codec handler for opus/48000/2
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Sink supports codec opus/48000/2
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Using passthrough handler for opus/48000/2
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Sink supports codec G722/8000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Using passthrough handler for G722/8000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Resetting codec handler for PT 101
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Creating codec handler for telephone-event/8000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Sink supports codec telephone-event/8000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Using passthrough handler for telephone-event/8000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Resetting codec handler for PT 103
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Creating codec handler for telephone-event/48000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Sink supports codec telephone-event/48000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Using passthrough handler for telephone-event/48000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Creating codec handler for ISAC/16000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Using passthrough handler for ISAC/16000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Creating codec handler for ISAC/32000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Using passthrough handler for ISAC/32000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Creating codec handler for CN/32000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Using passthrough handler for CN/32000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Using passthrough handler for CN/32000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Creating codec handler for CN/16000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Using passthrough handler for CN/16000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Creating codec handler for CN/8000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Using passthrough handler for CN/8000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Creating codec handler for telephone-event/32000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Sink supports codec telephone-event/32000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Using passthrough handler for telephone-event/32000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Creating codec handler for telephone-event/16000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Sink supports codec telephone-event/16000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Using passthrough handler for telephone-event/16000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: set FILLED flag for stream 96.67.37.126:46482
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: set FILLED flag for stream :0
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Learning new ICE candidate 913812169:1
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Created candidate pair 6tWystCrquBsp72z:913812169:1 between 172.31.0.20 and 192.168.194.138:64574, type host
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Learning new ICE candidate 3456662903:1
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Created candidate pair 6tWystCrquBsp72z:3456662903:1 between 172.31.0.20 and 10.0.1.5:49276, type host
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Learning new ICE candidate 4050557278:1
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Created candidate pair 6tWystCrquBsp72z:4050557278:1 between 172.31.0.20 and 96.67.37.126:46482, type srflx
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: scheduling timer object at 1619208536.827669
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Sending ICE/STUN request for candidate pair 6tWystCrquBsp72z:913812169:1 from 172.31.0.20 to 192.168.194.138:64574
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: scheduling timer object at 1619208536.727669
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: WARNING: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Priority collision between candidate pairs 2gYv8zXcssake06f:913812169:1 and 6tWystCrquBsp72z:913812169:1 - ICE will likely fail
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Created candidate pair 6tWystCrquBsp72z:913812169:1 between 172.31.0.20 and 192.168.194.138:64574, type host
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: WARNING: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Priority collision between candidate pairs 2gYv8zXcssake06f:3456662903:1 and 6tWystCrquBsp72z:3456662903:1 - ICE will likely fail
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Created candidate pair 6tWystCrquBsp72z:3456662903:1 between 172.31.0.20 and 10.0.1.5:49276, type host
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: WARNING: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Priority collision between candidate pairs 2gYv8zXcssake06f:4050557278:1 and 6tWystCrquBsp72z:4050557278:1 - ICE will likely fail
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Created candidate pair 6tWystCrquBsp72z:4050557278:1 between 172.31.0.20 and 96.67.37.126:46482, type srflx
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3/UUKF63KS2e06H/1]: scheduling timer object at 1619208536.828788
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: INFO: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Replying to 'offer' from 172.31.1.10:34912 (elapsed time 0.001182 sec)
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3/UUKF63KS2e06H/1]: Sending ICE/STUN request for candidate pair 6tWystCrquBsp72z:3456662903:1 from 172.31.0.20 to 10.0.1.5:49276
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Response dump for 'offer' to 172.31.1.10:34912: { "sdp": "v=0#015#012o=- 6056638454914285597 3 IN IP4 172.31.0.20#015#012s=-#015#012t=0 0#015#012a=extmap-allow-mixed#015#012a=msid-semantic: WMS WhXgI1rH4WGmRSv1zw0knStUaSnf232nfcUL#015#012m=audio 40372 RTP/AVP 0 8 102 9 101 103 127 104 106 105 13 112 113#015#012c=IN IP4 172.31.0.20#015#012a=msid:WhXgI1rH4WGmRSv1zw0knStUaSnf232nfcUL 70048776-e8a1-4f70-94d6-9248f638c0a4#015#012a=ssrc:4140947162 cname:VGFCjXcLcNjN84He#015#012a=ssrc:4140947162 msid:WhXgI1rH4WGmRSv1zw0knStUaSnf232nfcUL 70048776-e8a1-4f70-94d6- ...
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: ... 9248f638c0a4#015#012a=ssrc:4140947162 mslabel:WhXgI1rH4WGmRSv1zw0knStUaSnf232nfcUL#015#012a=ssrc:4140947162 label:70048776-e8a1-4f70-94d6-9248f638c0a4#015#012a=mid:1#015#012a=rtpmap:0 PCMU/8000#015#012a=rtpmap:8 PCMA/8000#015#012a=rtpmap:102 opus/48000/2#015#012a=rtpmap:9 G722/8000#015#012a=rtpmap:101 telephone-event/8000#015#012a=rtpmap:103 telephone-event/48000#015#012a=rtpmap:127 ISAC/16000#015#012a=rtpmap:104 ISAC/32000#015#012a=rtpmap:106 CN/32000#015#012a=rtpmap:105 CN/16000#015#012a=rtpmap:13 CN/8000#015#012a=rtpmap:112 telephone-event/32000#015#012a=rtpmap:113 telephone-event/16000 ...
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: ... #015#012a=fmtp:102 minptime=10;useinbandfec=1#015#012a=sendonly#015#012a=rtcp:40373#015#012a=ptime:20#015#012a=ice-options:trickle#015#012a=end-of-candidates#015#012", "result": "ok" }
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3/UUKF63KS2e06H/1]: scheduling timer object at 1619208536.748788
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [176410d0-647dc7e2-4aa4b-7f3741aa94b0-de641fac-13e2-7225]: Forward to sink endpoint: 172.31.1.243:33184 (RTP seq 32160 TS 1091744664)
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: ERR: [8957589d-1f12-123a-269a-0a1d0f3877f3 port 40364]: SRTP output wanted, but no crypto suite was negotiated
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: ERR: [8957589d-1f12-123a-269a-0a1d0f3877f3 port 40354]: SRTP output wanted, but no crypto suite was negotiated
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: INFO: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Received command 'answer' from 172.31.1.10:34912
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Dump for 'answer' from 172.31.1.10:34912: { "ICE": "force", "SDES": "off", "call-id": "8957589d-1f12-123a-269a-0a1d0f3877f3", "command": "answer", "flags": [ "generate mid", "SDES-no", "media handover", "port-latching" ], "from-tag": "UUKF63KS2e06H", "replace": [ "origin", "session-connection" ], "rtcp-mux": [ "require" ], "sdp": "v=0#015#012o=FreeSWITCH 1619174241 1619174243 IN IP4 172.31.1.243#015#012s=FreeSWITCH#015#012c=IN IP4 172.31.1.243#015#012t=0 0#015#012m=audio 34278 RTP/AVP 0 101 103#015#012a=rtpmap:0 PCMU/8000#015#012a=rtpma ...
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: ... p:101 telephone-event/8000#015#012a=fmtp:101 0-16#015#012a=rtpmap:103 telephone-event/48000#015#012a=fmtp:103 0-16#015#012a=recvonly#015#012a=ptime:20#015#012", "to-tag": "49kraktqtv", "transport-protocol": "UDP/TLS/RTP/SAVPF" }
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Eliminating asymmetric inbound codec PCMA/8000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Eliminating asymmetric inbound codec opus/48000/2
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Eliminating asymmetric inbound codec G722/8000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Eliminating asymmetric inbound codec ISAC/16000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Eliminating asymmetric inbound codec ISAC/32000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Eliminating asymmetric inbound codec CN/32000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Eliminating asymmetric inbound codec CN/16000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Eliminating asymmetric inbound codec CN/8000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Default sink codec is PCMU/8000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: 0 DTMF sink entries
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Eliminating asymmetric outbound codec PCMA/8000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Eliminating asymmetric outbound codec opus/48000/2
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Eliminating asymmetric outbound codec G722/8000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Eliminating asymmetric outbound codec ISAC/16000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Eliminating asymmetric outbound codec ISAC/32000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Eliminating asymmetric outbound codec CN/32000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Eliminating asymmetric outbound codec CN/16000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Eliminating asymmetric outbound codec CN/8000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Sink supports codec PCMU/8000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Using passthrough handler for PCMU/8000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Resetting codec handler for PT 101
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Creating codec handler for telephone-event/8000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Sink supports codec telephone-event/8000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Using passthrough handler for telephone-event/8000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Resetting codec handler for PT 103
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Creating codec handler for telephone-event/48000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Sink supports codec telephone-event/48000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Using passthrough handler for telephone-event/48000
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: INFO: [8957589d-1f12-123a-269a-0a1d0f3877f3]: DTLS fingerprint changed, restarting DTLS
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: set FILLED flag for stream 172.31.1.243:34278
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: set FILLED flag for stream 172.31.1.243:34279
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: ICE restart, resetting ICE agent
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: WARNING: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Priority collision between candidate pairs 6tWystCrquBsp72z:913812169:1 and 2gYv8zXcssake06f:913812169:1 - ICE will likely fail
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Created candidate pair 2gYv8zXcssake06f:913812169:1 between 172.31.0.20 and 192.168.194.138:64574, type host
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: WARNING: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Priority collision between candidate pairs 6tWystCrquBsp72z:3456662903:1 and 2gYv8zXcssake06f:3456662903:1 - ICE will likely fail
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Created candidate pair 2gYv8zXcssake06f:3456662903:1 between 172.31.0.20 and 10.0.1.5:49276, type host
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: WARNING: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Priority collision between candidate pairs 6tWystCrquBsp72z:4050557278:1 and 2gYv8zXcssake06f:4050557278:1 - ICE will likely fail
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Created candidate pair 2gYv8zXcssake06f:4050557278:1 between 172.31.0.20 and 96.67.37.126:46482, type srflx
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Sending ICE/STUN request for candidate pair 2gYv8zXcssake06f:913812169:1 from 172.31.0.20 to 192.168.194.138:64574
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: scheduling timer object at 1619208536.867786
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: INFO: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Replying to 'answer' from 172.31.1.10:34912 (elapsed time 0.000654 sec)
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: Response dump for 'answer' to 172.31.1.10:34912: { "sdp": "v=0#015#012o=FreeSWITCH 1619174241 1619174243 IN IP4 54.75.202.242#015#012s=FreeSWITCH#015#012c=IN IP4 54.75.202.242#015#012t=0 0#015#012m=audio 40386 UDP/TLS/RTP/SAVPF 0 101 103#015#012a=mid:1#015#012a=rtpmap:0 PCMU/8000#015#012a=rtpmap:101 telephone-event/8000#015#012a=rtpmap:103 telephone-event/48000#015#012a=fmtp:101 0-16#015#012a=fmtp:103 0-16#015#012a=recvonly#015#012a=rtcp:40386#015#012a=rtcp-mux#015#012a=setup:active#015#012a=fingerprint:sha-1 49:12:68:AF:83:DB:93:12:14:FF:19:D0:AB:EB:68:B6:03:7F:07:2F#015#012a=ptime:20#015#012a=ice-uf ...
Apr 23 20:08:56 ip-172-31-0-20 rtpengine[24367]: DEBUG: [8957589d-1f12-123a-269a-0a1d0f3877f3]: ... rag:kLpDD9lL#015#012a=ice-pwd:WwlM24MqBP42lPq25CQuywCuR2#015#012a=ice-options:trickle#015#012a=candidate:2gYv8zXcssake06f 1 UDP 2130706431 54.75.202.242 40386 typ host#015#012a=end-of-candidates#015#012", "result": "ok" }
*** we return a 200 OK to SRTP client with the sdp from the 'answer' immediately above.
*** however, the jssip client immediately sends a BYE with error message:
JsSIP:ERROR:RTCSession emit "peerconnection:setremotedescriptionfailed" [error:DOMException: Failed to execute 'setRemoteDescription' on 'RTCPeerConnection': Failed to set remote answer sdp: Failed to apply the description for m= section with mid='1': Failed to set SSL role for the transport.]
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment