i have not been able to figure out, why i can't hear any audio when i
call from webrtc client (using UDP/TLS/RTP/SAVPF profile) to sems echo
server (using RTP/AVP profile):
1) webrtc client - UDP/TLS/RTP/SAVPF - rtpengine - RTP/AVP - sems echo server
if i call from the same webrtc client to baresip, audio works fine:
2) webrtc client - UDP/TLS/RTP/SAVPF - rtpengine - RTP/AVP - baresip
also, if i call from baresip using UDP/TLS/RTP/SAVPF profile to sems,
audio works fine:
3) basesip - UDP/TLS/RTP/SAVPF - rtpengine - RTP/AVP - sems echo server
below is level 7 debug from the problem case (1). stats at the bottom
tell that audio packets were flowing both ways fine. what does not seem
correct is that the webrtc client is constantly sending "Successful STUN
binding requests" to rtpengine.
any advise for further debugging this problem would be highly
appreciated.
-- juha
------------------------------------------------------------------------------
May 18 11:47:34 box /usr/bin/sip-proxy[18299]: INFO: =====
rtpengine_offer(ICE=force replace-session-connection replace-origin
via-branch=1 rtcp-mux-demux RTP/AVP)
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] Received command
'offer' from 127.0.0.1:43378
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] Dump for 'offer'
from 127.0.0.1:43378: { "sdp": "v=0#015#012o=- 4880355588178147449 2 IN IP4
127.0.0.1#015#012s=-#015#012t=0 0#015#012a=group:BUNDLE
audio#015#012a=msid-semantic: WMS
k2qrqNs5yzQcMjup0H0E85yNYAP5aA0w4SeM#015#012m=audio 35551 UDP/TLS/RTP/SAVPF 111
103 104 9 0 8 106 105 13 126#015#012c=IN IP4 93.106.207.11#015#012a=rtcp:35551
IN IP4 93.106.207.11#015#012a=candidate:1603072777 1 udp 2122260223
192.168.43.146 35551 typ host generation 0#015#012a=candidate:1603072777 2 udp
2122260223 192.168.43.146 35551 typ host generation 0#015#012a=candidate:2861
...
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] ... 99801 1 tcp
1518280447 192.168.43.146 0 typ host tcptype active generation
0#015#012a=candidate:286199801 2 tcp 1518280447 192.168.43.146 0 typ host
tcptype active generation 0#015#012a=candidate:2466368666 1 udp 1686052607
93.106.207.11 35551 typ srflx raddr 192.168.43.146 rport 35551 generation
0#015#012a=candidate:2466368666 2 udp 1686052607 93.106.207.11 35551 typ srflx
raddr 192.168.43.146 rport 35551 generation
0#015#012a=ice-ufrag:U+gG6hyUzfrt859a#015#012a=ice-pwd:FQwGMInhUjWl8bbYIbSJS1pz#015#012a=fingerprint:sha-256
09:D6: ...
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] ...
AA:5B:F2:9E:D6:A7:CE:69:D3:76:67:EF:36:A6:F4:87:94:B7:37:82:AF:17:9E:4B:E8:B7:F4:F1:8C:A0#015#012a=setup:actpass#015#012a=mid:audio#015#012a=extmap:1
urn:ietf:params:rtp-hdrext:ssrc-audio-level#015#012a=extmap:3
http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time#015#012a=sendrecv#015#012a=rtcp-mux#015#012a=rtpmap:111
opus/48000/2#015#012a=fmtp:111 minptime=10; useinbandfec=1#015#012a=rtpmap:103
ISAC/16000#015#012a=rtpmap:104 ISAC/32000#015#012a=rtpmap:9
G722/8000#015#012a=rtpmap:0 PCMU/8000#015#012a=rtpmap:8
PCMA/8000#015#012a=rtpmap:106 CN/32000#015#012a=rtpmap:105 CN/16000#015 ...
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] ... #012a=rtpmap:13
CN/8000#015#012a=rtpmap:126
telephone-event/8000#015#012a=maxptime:60#015#012a=ssrc:2202238380
cname:zcLA/sUaZsuYHC73#015#012a=ssrc:2202238380
msid:k2qrqNs5yzQcMjup0H0E85yNYAP5aA0w4SeM
2053b0c2-35f2-48f8-ae79-419a078169f4#015#012a=ssrc:2202238380
mslabel:k2qrqNs5yzQcMjup0H0E85yNYAP5aA0w4SeM#015#012a=ssrc:2202238380
label:2053b0c2-35f2-48f8-ae79-419a078169f4#015#012", "ICE": "force", "replace":
[ "session-connection", "origin" ], "transport-protocol": "RTP/AVP",
"rtcp-mux": [ "demux" ], "call-id": "e91aj9gq39qr07b6dn6u", "vi ...
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] ... a-branch":
"z9hG4bK1294663", "received-from": [ "IP4", "<sip-proxy-rtpengine-ip>" ],
"from-tag": "0m9av72lp5", "command": "offer" }
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] Creating new call
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] Opened ports
8012..8013 for media relay
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] Opened ports
8028..8029 for media relay
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] Learning new ICE
candidate 1603072777:1
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] Created candidate
pair MmPVRTRG3mIW6Esg:1603072777:1 between <sip-proxy-rtpengine-ip> and
192.168.43.146:35551, type host
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] Learning new ICE
candidate 1603072777:2
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] Learning new ICE
candidate 2466368666:1
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] Created candidate
pair MmPVRTRG3mIW6Esg:2466368666:1 between <sip-proxy-rtpengine-ip> and
93.106.207.11:35551, type srflx
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] Learning new ICE
candidate 2466368666:2
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] Sending ICE/STUN
request for candidate pair MmPVRTRG3mIW6Esg:1603072777:1 from
<sip-proxy-rtpengine-ip> to 192.168.43.146:35551
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] Replying to 'offer'
from 127.0.0.1:43378
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] Response dump for
'offer' to 127.0.0.1:43378: { "sdp": "v=0#015#012o=- 4880355588178147449 2 IN
IP4 <sip-proxy-rtpengine-ip>#015#012s=-#015#012t=0 0#015#012a=msid-semantic:
WMS k2qrqNs5yzQcMjup0H0E85yNYAP5aA0w4SeM#015#012m=audio 8012 RTP/AVP 111 103
104 9 0 8 106 105 13 126#015#012c=IN IP4
<sip-proxy-rtpengine-ip>#015#012a=rtpmap:111 opus/48000/2#015#012a=fmtp:111
minptime=10; useinbandfec=1#015#012a=rtpmap:103 ISAC/16000#015#012a=rtpmap:104
ISAC/32000#015#012a=rtpmap:9 G722/8000#015#012a=rtpmap:0
PCMU/8000#015#012a=rtpmap:8 PCMA/8000#015#012a=rtpmap:106
CN/32000#015#012a=rtpmap:105 CN/16000#015#012a=rtpmap:13 ...
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] ...
CN/8000#015#012a=rtpmap:126
telephone-event/8000#015#012a=maxptime:60#015#012a=ssrc:2202238380
cname:zcLA/sUaZsuYHC73#015#012a=ssrc:2202238380
msid:k2qrqNs5yzQcMjup0H0E85yNYAP5aA0w4SeM
2053b0c2-35f2-48f8-ae79-419a078169f4#015#012a=ssrc:2202238380
mslabel:k2qrqNs5yzQcMjup0H0E85yNYAP5aA0w4SeM#015#012a=ssrc:2202238380
label:2053b0c2-35f2-48f8-ae79-419a078169f4#015#012a=sendrecv#015#012a=rtcp:8013#015#012a=ice-ufrag:aEaiKI4d#015#012a=ice-pwd:S0ET0fRwnGLZ6lYSdXuAfvCo9K#015#012a=candidate:MmPVRTRG3mIW6Esg
1 UDP 2130706431 <sip-proxy-rtpengine-ip> 8012 typ host#015#012a=candidate:MmP
...
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] ... VRTRG3mIW6Esg 2
UDP 2130706430 <sip-proxy-rtpengine-ip> 8013 typ host#015#012", "result": "ok" }
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u/0m9av72lp5/1]
Sending ICE/STUN request for candidate pair MmPVRTRG3mIW6Esg:2466368666:1 from
<sip-proxy-rtpengine-ip> to 93.106.207.11:35551
May 18 11:47:34 box /usr/bin/sip-proxy[18242]: INFO: =====
rtpengine_answer(ICE=force via-branch=2 trust-address)
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] Received command
'answer' from 127.0.0.1:49396
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] Dump for 'answer'
from 127.0.0.1:49396: { "sdp": "v=0#015#012o=sems 1244512444 1372754 IN IP4
<sip-proxy-rtpengine-ip>#015#012s=sems#015#012c=IN IP4
<sip-proxy-rtpengine-ip>#015#012t=0 0#015#012m=audio 8064 RTP/AVP 0 8
126#015#012a=rtpmap:0 PCMU/8000#015#012a=rtpmap:8 PCMA/8000#015#012a=rtpmap:126
telephone-event/8000#015#012a=sendrecv#015#012a=direction:both#015#012", "ICE":
"force", "flags": [ "trust-address" ], "call-id": "e91aj9gq39qr07b6dn6u",
"via-branch": "z9hG4bK1294663", "received-from": [ "IP4", "127.0.0.1" ],
"from-tag": "0m9av72lp5", "to-tag": "627A71DC-5559A726000163C1 ...
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] ... -AA759700",
"command": "answer" }
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] Shutting down ICE
agent (nothing to do)
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] Replying to
'answer' from 127.0.0.1:49396
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] Response dump for
'answer' to 127.0.0.1:49396: { "sdp": "v=0#015#012o=sems 1244512444 1372754 IN
IP4 <sip-proxy-rtpengine-ip>#015#012s=sems#015#012c=IN IP4
<sip-proxy-rtpengine-ip>#015#012t=0 0#015#012m=audio 8028 UDP/TLS/RTP/SAVPF 0 8
126#015#012a=rtpmap:0 PCMU/8000#015#012a=rtpmap:8 PCMA/8000#015#012a=rtpmap:126
telephone-event/8000#015#012a=direction:both#015#012a=sendrecv#015#012a=rtcp:8028#015#012a=rtcp-mux#015#012a=setup:active#015#012a=fingerprint:sha-1
B0:27:8A:76:DE:C4:2A:18:7D:C9:32:F6:78:79:5E:7B:1D:7C:DB:68#015#012a=ice-ufrag:joFSF896#015#012a=ice-pwd:AMtcYr30DYw7PhCsz1LU1Eoi12#015#012a=candidate:MmPVRTRG
...
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] ... 3mIW6Esg 1 UDP
2130706431 <sip-proxy-rtpengine-ip> 8028 typ host#015#012", "result": "ok" }
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8012] SRTP
output wanted, but no crypto suite was negotiated
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u/0m9av72lp5/1]
Sending ICE/STUN request for candidate pair MmPVRTRG3mIW6Esg:1603072777:1 from
<sip-proxy-rtpengine-ip> to 192.168.43.146:35551
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u/0m9av72lp5/1]
Sending ICE/STUN request for candidate pair MmPVRTRG3mIW6Esg:2466368666:1 from
<sip-proxy-rtpengine-ip> to 93.106.207.11:35551
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Triggering check for MmPVRTRG3mIW6Esg:2466368666:1
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028] ICE pair
MmPVRTRG3mIW6Esg:2466368666:1 has been nominated by peer
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028] ICE not
completed yet
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u/0m9av72lp5/1]
Sending ICE/STUN request for candidate pair MmPVRTRG3mIW6Esg:2466368666:1 from
<sip-proxy-rtpengine-ip> to 93.106.207.11:35551
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Triggering check for MmPVRTRG3mIW6Esg:2466368666:1
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u/0m9av72lp5/1]
Sending ICE/STUN request for candidate pair MmPVRTRG3mIW6Esg:2466368666:1 from
<sip-proxy-rtpengine-ip> to 93.106.207.11:35551
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028] Received
ICE/STUN response code 0 for candidate pair MmPVRTRG3mIW6Esg:2466368666:1 from
93.106.207.11:35551 to <sip-proxy-rtpengine-ip>
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028] Setting
ICE candidate pair MmPVRTRG3mIW6Esg:2466368666:1 as succeeded
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028] Best
succeeded ICE pair with all components is MmPVRTRG3mIW6Esg:2466368666:1
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028] ICE
completed, using pair MmPVRTRG3mIW6Esg:2466368666:1
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u/0m9av72lp5/1]
Sending ICE/STUN request for candidate pair MmPVRTRG3mIW6Esg:1603072777:1 from
<sip-proxy-rtpengine-ip> to 192.168.43.146:35551
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028] Received
ICE/STUN response code 0 for candidate pair MmPVRTRG3mIW6Esg:2466368666:1 from
93.106.207.11:35551 to <sip-proxy-rtpengine-ip>
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028] DTLS:
Peer certificate accepted
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028] DTLS
handshake successful
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
DTLS-SRTP successfully negotiated
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028] SRTP
keys, incoming:
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028] ---
AES_CM_128_HMAC_SHA1_32 key jZlg8WlCjfEiFoilpz7BQg== salt gUcb/yOXBOIuNY1ItSw=
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028] SRTP
keys, outgoing:
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028] ---
AES_CM_128_HMAC_SHA1_32 key e3hQ8pCcc04HD8I7KWdl/g== salt mrNX5VDOk0+Tif2xv5I=
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
DTLS-SRTP successfully negotiated
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028] SRTP
keys, incoming:
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028] ---
AES_CM_128_HMAC_SHA1_32 key jZlg8WlCjfEiFoilpz7BQg== salt gUcb/yOXBOIuNY1ItSw=
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028] SRTP
keys, outgoing:
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028] ---
AES_CM_128_HMAC_SHA1_32 key e3hQ8pCcc04HD8I7KWdl/g== salt mrNX5VDOk0+Tif2xv5I=
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u/0m9av72lp5/1]
Sending ICE/STUN request for candidate pair MmPVRTRG3mIW6Esg:1603072777:1 from
<sip-proxy-rtpengine-ip> to 192.168.43.146:35551
May 18 11:47:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:35 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:35 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u/0m9av72lp5/1]
Sending ICE/STUN request for candidate pair MmPVRTRG3mIW6Esg:1603072777:1 from
<sip-proxy-rtpengine-ip> to 192.168.43.146:35551
May 18 11:47:35 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:36 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:36 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:37 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u/0m9av72lp5/1]
Sending ICE/STUN request for candidate pair MmPVRTRG3mIW6Esg:1603072777:1 from
<sip-proxy-rtpengine-ip> to 192.168.43.146:35551
May 18 11:47:37 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:37 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:38 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8012]
Confirmed peer address as <sip-proxy-rtpengine-ip>:8064
May 18 11:47:38 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Confirmed peer address as 93.106.207.11:35551
May 18 11:47:38 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Kernelizing media stream
May 18 11:47:38 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8012]
Kernelizing media stream
May 18 11:47:38 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:38 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:39 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:39 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:40 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:40 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u/0m9av72lp5/1]
Sending ICE/STUN request for candidate pair MmPVRTRG3mIW6Esg:1603072777:1 from
<sip-proxy-rtpengine-ip> to 192.168.43.146:35551
May 18 11:47:40 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:41 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:41 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:42 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:42 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:43 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:43 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:43 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:44 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:44 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:45 box proxy_monitor[24109]: SIP test succeeded with proxy
192.98.100.34!
May 18 11:47:45 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:45 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:46 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:46 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u/0m9av72lp5/1]
Sending ICE/STUN request for candidate pair MmPVRTRG3mIW6Esg:1603072777:1 from
<sip-proxy-rtpengine-ip> to 192.168.43.146:35551
May 18 11:47:46 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:47 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:47 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:48 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:48 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:49 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:49 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:50 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:50 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:51 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:51 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:52 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:52 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:53 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:53 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:54 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:54 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:55 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:55 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:55 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:56 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:56 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:57 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:57 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:58 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:58 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:59 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:47:59 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u/0m9av72lp5/1]
Sending ICE/STUN request for candidate pair MmPVRTRG3mIW6Esg:1603072777:1 from
<sip-proxy-rtpengine-ip> to 192.168.43.146:35551
May 18 11:47:59 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:00 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:00 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:01 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:01 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:02 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:02 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:03 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:03 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:04 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:04 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:05 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:05 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:06 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:06 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:07 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:07 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:07 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:08 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:08 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:09 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:09 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:10 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:10 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:11 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:11 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:12 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:12 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:13 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:13 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:14 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:14 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:15 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:15 box proxy_monitor[24109]: SIP test succeeded with proxy
192.98.100.34!
May 18 11:48:15 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:16 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:16 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:17 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:17 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:18 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:18 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:19 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:19 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:20 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:20 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:20 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:21 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:21 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:22 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:22 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:23 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:23 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:24 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:24 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:25 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u/0m9av72lp5/1]
Setting ICE candidate pair MmPVRTRG3mIW6Esg:1603072777:1 as failed
May 18 11:48:25 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:25 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:26 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:26 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:27 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:27 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:28 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:28 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:29 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:29 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:30 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:30 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:31 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:31 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:32 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:32 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:32 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:33 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:33 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:34 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:35 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:35 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u port 8028]
Successful STUN binding request from 93.106.207.11:35551
May 18 11:48:36 box /usr/bin/sip-proxy[18297]: INFO: =====
rtpengine_delete(via-branch=1)
May 18 11:48:36 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] Received command
'delete' from 127.0.0.1:60722
May 18 11:48:36 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] Dump for 'delete'
from 127.0.0.1:60722: { "call-id": "e91aj9gq39qr07b6dn6u", "via-branch":
"z9hG4bK3605983", "received-from": [ "IP4", "<sip-proxy-rtpengine-ip>" ],
"from-tag": "0m9av72lp5", "command": "delete" }
May 18 11:48:36 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] Scheduling deletion
of call branch '0m9av72lp5' in 30 seconds
May 18 11:48:36 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] Replying to
'delete' from 127.0.0.1:60722
May 18 11:48:36 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] Response dump for
'delete' to 127.0.0.1:60722: { "created": 1431938854, "last signal":
1431938854, "tags": { "0m9av72lp5": { "tag": "0m9av72lp5", "created":
1431938854, "in dialogue with": "627A71DC-5559A726000163C1-AA759700", "medias":
[ { "index": 1, "type": "audio", "protocol": "UDP/TLS/RTP/SAVPF", "streams": [
{ "local port": 8028, "endpoint": { "family": "IPv4", "address":
"93.106.207.11", "port": 35551 }, "advertised endpoint": { "family": "IPv4",
"address": "93.106.207.11", "port": 35551 ...
May 18 11:48:36 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] ... }, "crypto
suite": "AES_CM_128_HMAC_SHA1_32", "last packet": 1431938916, "flags": [ "RTP",
"RTCP", "filled", "confirmed", "kernelized", "DTLS fingerprint verified" ],
"stats": { "packets": 3084, "bytes": 540700, "errors": 0 } }, { "local port":
8029, "endpoint": { "family": "IPv6", "address": "::", "port": 0 }, "advertised
endpoint": { "family": "IPv6", "address": "::", "port": 0 }, "crypto suite":
"AES_CM_128_HMAC_SHA1_32", "last packet": 1431938854, "flags": [ "RTCP",
"fallback RTCP", "filled" ...
May 18 11:48:36 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] ... ], "stats": {
"packets": 0, "bytes": 0, "errors": 0 } } ], "flags": [ "initialized", "send",
"recv", "rtcp-mux", "DTLS-SRTP", "DTLS role active", "ICE" ] } ] },
"627A71DC-5559A726000163C1-AA759700": { "tag":
"627A71DC-5559A726000163C1-AA759700", "created": 1431938854, "in dialogue
with": "0m9av72lp5", "medias": [ { "index": 1, "type": "audio", "protocol":
"RTP/AVP", "streams": [ { "local port": 8012, "endpoint": { "family": "IPv4",
"address": "<sip-proxy-rtpengine-ip>", "port": 8064 }, "advertised endpoin ...
May 18 11:48:36 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] ... t": { "family":
"IPv4", "address": "<sip-proxy-rtpengine-ip>", "port": 8064 }, "last packet":
1431938916, "flags": [ "RTP", "filled", "confirmed", "kernelized" ], "stats": {
"packets": 3095, "bytes": 533040, "errors": 0 } }, { "local port": 8013,
"endpoint": { "family": "IPv4", "address": "<sip-proxy-rtpengine-ip>", "port":
8065 }, "advertised endpoint": { "family": "IPv4", "address":
"<sip-proxy-rtpengine-ip>", "port": 8065 }, "last packet": 1431938854, "flags":
[ "RTCP", "filled" ], "stats": { "packets": 0, "bytes": 0, "error ...
May 18 11:48:36 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] ... s": 0 } } ],
"flags": [ "initialized", "send", "recv" ] } ] } }, "totals": { "RTP": {
"packets": 6179, "bytes": 1073740, "errors": 0 }, "RTCP": { "packets": 0,
"bytes": 0, "errors": 0 } }, "result": "ok" }
May 18 11:49:06 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] Call branch
'0m9av72lp5' deleted, no more branches remaining
May 18 11:49:06 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] Final packet stats:
May 18 11:49:06 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] --- Tag
'627A71DC-5559A726000163C1-AA759700', created 1:32 ago, in dialogue with
'0m9av72lp5'
May 18 11:49:06 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] ------ Media #1
(audio over RTP/AVP) using PCMU/8000
May 18 11:49:06 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] --------- Port
8012 <> <sip-proxy-rtpengine-ip>:8064 , 3110 p, 535620 b, 0 e, 1431938917
last_packet
May 18 11:49:06 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] --------- Port
8013 <> <sip-proxy-rtpengine-ip>:8065 (RTCP), 0 p, 0 b, 0 e, 1431938854
last_packet
May 18 11:49:06 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] --- Tag
'0m9av72lp5', created 1:32 ago, in dialogue with
'627A71DC-5559A726000163C1-AA759700'
May 18 11:49:06 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] ------ Media #1
(audio over UDP/TLS/RTP/SAVPF) using PCMU/8000
May 18 11:49:06 box rtpengine[4025]: [e91aj9gq39qr07b6dn6u] --------- Port
8028 <> 93.106.207.11:35551, 3101 p, 543584 b, 0 e, 1431938917 last_packet
_______________________________________________
SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing list
sr-users@lists.sip-router.org
http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
