During video call browser to browser using sipml5 and asterisk 11.16 getting the warning res_srtp.c:407 ast_srtp_unprotect: SRTP unprotect failed with: authentication failure 110

I am trying to make video calls (Browser to browser) using sipml5 and asterisk 11.16 running on centos 7

Problems that I am facing are -

  1. when making video calls from browser to browser audio works fine but will get a blank screen and no video with warnings ‘res_srtp.c:407 ast_srtp_unprotect: SRTP unprotect failed with: authentication failure 110’
  2. when making audio calls the called extension receives a video call with the same warnings.

below are the configs that I am using-

sip.conf
[general]
udpbindaddr = 0.0.0.0:5060
realm = 172.16.1.196
transport = udp,ws,wss
externaddr = 172.16.1.196
websocket_enabled = true

[1001]
host=dynamic
secret=123456789
context=sip-users
type=peer
encryption=yes
avpf=yes
icesupport=yes
directmedia=no
disallow=all
dial = SIP/1001
qualify=yes
allow=ulaw
;allow=alaw
;allow=speex
;allow=gsm
;allow=h263
allow=h264
allow=h263p
dtlsenable=yes
dtlsverify=fingerprint
dtlscertfile=/etc/asterisk/keys/asterisk.pem
dtlscafile=/etc/asterisk/keys/ca.crt
dtlssetup=actpass
nat=force_rport,comedia
dtmfmode=rfc2833
videosupport=yes

[1002]
host=dynamic
secret=987654321
context=sip-users
type=peer
encryption=yes
avpf=yes
icesupport=yes
directmedia=no
disallow=all
dial = SIP/1002
disallow=all
qualify=yes
allow=ulaw
;allow=alaw
;allow=speex
;allow=gsm
;allow=h263
allow=h264
allow=h263p
dtlsenable=yes
dtlsverify=fingerprint
dtlscertfile=/etc/asterisk/keys/asterisk.pem
dtlscafile=/etc/asterisk/keys/ca.crt
dtlssetup=actpass
nat=force_rport,comedia
dtmfmode=rfc2833
videosupport=yes

[1003]
host=dynamic
secret=123456789
context=sip-users
type=peer
encryption=yes
avpf=yes
icesupport=yes
directmedia=no
disallow=all
dial = SIP/1003
disallow=all
qualify=yes
allow=ulaw
;allow=alaw
;allow=speex
;allow=gsm
;allow=h263
allow=h264
allow=h263p
dtlsenable=yes
dtlsverify=fingerprint
dtlscertfile=/etc/asterisk/keys/asterisk.pem
dtlscafile=/etc/asterisk/keys/ca.crt
dtlssetup=actpass
nat=force_rport,comedia
dtmfmode=rfc2833
videosupport=yes

Extensions.conf

[sip-users]

exten => 1001,1,Ringing(5)
same => n,Playback(hello-world)
same => n,Dial(SIP/1001,20)
same => n,Playback(vm-goodbye)

exten => 1002,1,Ringing(5)
same => n,Playback(hello-world)
same => n,Dial(SIP/1002,20)
same => n,Playback(vm-goodbye)

exten => 1003,1,Ringing(5)
same => n,Playback(hello-world)
same => n,Dial(SIP/1003,20)
same => n,Playback(vm-goodbye)

It would be really helpful if someone helps me understand the logs and figureout where the problem lies.

<— SIP read from WS:172.16.1.154:56118 —>
INVITE sip:1003@172.16.1.196 SIP/2.0
Via: SIP/2.0/WSS df7jal23ls0d.invalid;branch=z9hG4bK36RgxbeaT2NEvTVWDN9OOIVRvAQlMHcu;rport
From: "1001"sip:1001@172.16.1.196;tag=cw86QskV5knntZ7b3JpV
To: sip:1003@172.16.1.196
Contact: "1001"sips:1001@df7jal23ls0d.invalid;rtcweb-breaker=yes;click2call=no;transport=wss;impi=1001;ha1=5b80c6dbc65c4262f5cc811a36425c08;+g.oma.sip-im;language="en,fr"
Call-ID: 9792f8a1-f729-3cdf-861a-ed1f97dc27bf
CSeq: 22024 INVITE
Content-Type: application/sdp
Content-Length: 4648
Route: sip:172.16.1.196:5060;lr;sipml5-outbound;transport=udp
Max-Forwards: 70
User-Agent: IM-client/OMA1.0 sipML5-v1.2016.03.04
Organization: Doubango Telecom

v=0
o=- 2522336172556612000 2 IN IP4 127.0.0.1
s=Doubango Telecom - chrome
t=0 0
a=group:BUNDLE audio video
a=msid-semantic: WMS kbaxVjoAD2Tv3y1YZmTd2KOv8L9CQpQeMisa
m=audio 61269 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 126
c=IN IP4 180.151.41.90
a=rtcp:61270 IN IP4 180.151.41.90
a=candidate:1529126634 1 udp 2122260223 172.16.1.154 61269 typ host generation 0 network-id 1 network-cost 10
a=candidate:1529126634 2 udp 2122260222 172.16.1.154 61270 typ host generation 0 network-id 1 network-cost 10
a=candidate:363291162 1 tcp 1518280447 172.16.1.154 9 typ host tcptype active generation 0 network-id 1 network-cost 10
a=candidate:363291162 2 tcp 1518280446 172.16.1.154 9 typ host tcptype active generation 0 network-id 1 network-cost 10
a=candidate:2905925438 2 udp 1686052606 180.151.41.90 61270 typ srflx raddr 172.16.1.154 rport 61270 generation 0 network-id 1 network-cost 10
a=candidate:2905925438 1 udp 1686052607 180.151.41.90 61269 typ srflx raddr 172.16.1.154 rport 61269 generation 0 network-id 1 network-cost 10
a=ice-ufrag:7nhd
a=ice-pwd:PnLhhnr/Y73JSF3GohoWT6dB
a=fingerprint:sha-256 0C:71:BF:F8:C4:16:31:D5:42:3B:D3:8A:70:EE:39:DE:3D:A5:FB:E7:5B:69:05:38:8D:90:E1:62:02:E9:80:1A
a=setup:actpass
a=mid:audio
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=sendrecv
a=rtcp-mux
a=rtpmap:111 opus/48000/2
a=rtcp-fb:111 transport-cc
a=fmtp:111 minptime=10;useinbandfec=1
a=rtpmap:103 ISAC/16000
a=rtpmap:104 ISAC/32000
a=rtpmap:9 G722/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:126 telephone-event/8000
a=ssrc:3836577813 cname:/+TVltKqDn6B6XBw
a=ssrc:3836577813 msid:kbaxVjoAD2Tv3y1YZmTd2KOv8L9CQpQeMisa de4203bf-3a44-4bdc-9a56-b8d5bce7d645
a=ssrc:3836577813 mslabel:kbaxVjoAD2Tv3y1YZmTd2KOv8L9CQpQeMisa
a=ssrc:3836577813 label:de4203bf-3a44-4bdc-9a56-b8d5bce7d645
m=video 61271 UDP/TLS/RTP/SAVPF 100 101 107 116 117 96 97 99 98
c=IN IP4 180.151.41.90
a=rtcp:61272 IN IP4 180.151.41.90
a=candidate:1529126634 1 udp 2122260223 172.16.1.154 61271 typ host generation 0 network-id 1 network-cost 10
a=candidate:1529126634 2 udp 2122260222 172.16.1.154 61272 typ host generation 0 network-id 1 network-cost 10
a=candidate:363291162 1 tcp 1518280447 172.16.1.154 9 typ host tcptype active generation 0 network-id 1 network-cost 10
a=candidate:363291162 2 tcp 1518280446 172.16.1.154 9 typ host tcptype active generation 0 network-id 1 network-cost 10
a=candidate:2905925438 2 udp 1686052606 180.151.41.90 61272 typ srflx raddr 172.16.1.154 rport 61272 generation 0 network-id 1 network-cost 10
a=candidate:2905925438 1 udp 1686052607 180.151.41.90 61271 typ srflx raddr 172.16.1.154 rport 61271 generation 0 network-id 1 network-cost 10
a=ice-ufrag:7nhd
a=ice-pwd:PnLhhnr/Y73JSF3GohoWT6dB
a=fingerprint:sha-256 0C:71:BF:F8:C4:16:31:D5:42:3B:D3:8A:70:EE:39:DE:3D:A5:FB:E7:5B:69:05:38:8D:90:E1:62:02:E9:80:1A
a=setup:actpass
a=mid:video
a=extmap:2 urn:ietf:params:rtp-hdrext:toffset
a=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=extmap:4 urn:3gpp:video-orientation
a=extmap:5 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01
a=extmap:6 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay
a=sendrecv
a=rtcp-mux
a=rtcp-rsize
a=rtpmap:100 VP8/90000
a=rtcp-fb:100 ccm fir
a=rtcp-fb:100 nack
a=rtcp-fb:100 nack pli
a=rtcp-fb:100 goog-remb
a=rtcp-fb:100 transport-cc
a=rtpmap:101 VP9/90000
a=rtcp-fb:101 ccm fir
a=rtcp-fb:101 nack
a=rtcp-fb:101 nack pli
a=rtcp-fb:101 goog-remb
a=rtcp-fb:101 transport-cc
a=rtpmap:107 H264/90000
a=rtcp-fb:107 ccm fir
a=rtcp-fb:107 nack
a=rtcp-fb:107 nack pli
a=rtcp-fb:107 goog-remb
a=rtcp-fb:107 transport-cc
a=fmtp:107 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42e01f
a=rtpmap:116 red/90000
a=rtpmap:117 ulpfec/90000
a=rtpmap:96 rtx/90000
a=fmtp:96 apt=100
a=rtpmap:97 rtx/90000
a=fmtp:97 apt=101
a=rtpmap:99 rtx/90000
a=fmtp:99 apt=107
a=rtpmap:98 rtx/90000
a=fmtp:98 apt=116
a=ssrc-group:FID 2507734002 1941043268
a=ssrc:2507734002 cname:/+TVltKqDn6B6XBw
a=ssrc:2507734002 msid:kbaxVjoAD2Tv3y1YZmTd2KOv8L9CQpQeMisa 95c79c6e-df87-45bb-bfc5-cdf3bfaf00d7
a=ssrc:2507734002 mslabel:kbaxVjoAD2Tv3y1YZmTd2KOv8L9CQpQeMisa
a=ssrc:2507734002 label:95c79c6e-df87-45bb-bfc5-cdf3bfaf00d7
a=ssrc:1941043268 cname:/+TVltKqDn6B6XBw
a=ssrc:1941043268 msid:kbaxVjoAD2Tv3y1YZmTd2KOv8L9CQpQeMisa 95c79c6e-df87-45bb-bfc5-cdf3bfaf00d7
a=ssrc:1941043268 mslabel:kbaxVjoAD2Tv3y1YZmTd2KOv8L9CQpQeMisa
a=ssrc:1941043268 label:95c79c6e-df87-45bb-bfc5-cdf3bfaf00d7
<------------->
— (13 headers 99 lines) —
Using INVITE request as basis request - 9792f8a1-f729-3cdf-861a-ed1f97dc27bf
Found peer ‘1001’ for ‘1001’ from 172.16.1.154:56118

<— Reliably Transmitting (NAT) to 172.16.1.154:56118 —>
SIP/2.0 401 Unauthorized
Via: SIP/2.0/WSS df7jal23ls0d.invalid;branch=z9hG4bK36RgxbeaT2NEvTVWDN9OOIVRvAQlMHcu;received=172.16.1.154;rport=56118
From: "1001"sip:1001@172.16.1.196;tag=cw86QskV5knntZ7b3JpV
To: sip:1003@172.16.1.196;tag=as2f227bfb
Call-ID: 9792f8a1-f729-3cdf-861a-ed1f97dc27bf
CSeq: 22024 INVITE
Server: Asterisk PBX 11.16.0
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces, timer
WWW-Authenticate: Digest algorithm=MD5, realm=“172.16.1.196”, nonce="770ce54c"
Content-Length: 0

<------------>
Scheduling destruction of SIP dialog ‘9792f8a1-f729-3cdf-861a-ed1f97dc27bf’ in 6400 ms (Method: INVITE)

<— SIP read from WS:172.16.1.154:56118 —>
ACK sip:1003@172.16.1.196 SIP/2.0
Via: SIP/2.0/WSS df7jal23ls0d.invalid;branch=z9hG4bK36RgxbeaT2NEvTVWDN9OOIVRvAQlMHcu;rport
From: "1001"sip:1001@172.16.1.196;tag=cw86QskV5knntZ7b3JpV
To: sip:1003@172.16.1.196;tag=as2f227bfb
Call-ID: 9792f8a1-f729-3cdf-861a-ed1f97dc27bf
CSeq: 22024 ACK
Content-Length: 0
Route: sip:172.16.1.196:5060;lr;sipml5-outbound;transport=udp
Max-Forwards: 70

<------------->
— (9 headers 0 lines) —

<— SIP read from WS:172.16.1.154:56118 —>
INVITE sip:1003@172.16.1.196 SIP/2.0
Via: SIP/2.0/WSS df7jal23ls0d.invalid;branch=z9hG4bK6o4AnL28OwnKZbzNK2vTsuINuJbcvcrs;rport
From: "1001"sip:1001@172.16.1.196;tag=cw86QskV5knntZ7b3JpV
To: sip:1003@172.16.1.196
Contact: "1001"sips:1001@df7jal23ls0d.invalid;rtcweb-breaker=yes;click2call=no;transport=wss;impi=1001;ha1=5b80c6dbc65c4262f5cc811a36425c08;+g.oma.sip-im;language=“en,fr"
Call-ID: 9792f8a1-f729-3cdf-861a-ed1f97dc27bf
CSeq: 22025 INVITE
Content-Type: application/sdp
Content-Length: 4648
Route: sip:172.16.1.196:5060;lr;sipml5-outbound;transport=udp
Max-Forwards: 70
Authorization: Digest username=“1001”,realm=“172.16.1.196”,nonce=“770ce54c”,uri="sip:1003@172.16.1.196”,response=“1b13997894f8ef147ce6a62e7c46f607”,algorithm=MD5
User-Agent: IM-client/OMA1.0 sipML5-v1.2016.03.04
Organization: Doubango Telecom

v=0
o=- 2522336172556612000 2 IN IP4 127.0.0.1
s=Doubango Telecom - chrome
t=0 0
a=group:BUNDLE audio video
a=msid-semantic: WMS kbaxVjoAD2Tv3y1YZmTd2KOv8L9CQpQeMisa
m=audio 61269 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 126
c=IN IP4 180.151.41.90
a=rtcp:61270 IN IP4 180.151.41.90
a=candidate:1529126634 1 udp 2122260223 172.16.1.154 61269 typ host generation 0 network-id 1 network-cost 10
a=candidate:1529126634 2 udp 2122260222 172.16.1.154 61270 typ host generation 0 network-id 1 network-cost 10
a=candidate:363291162 1 tcp 1518280447 172.16.1.154 9 typ host tcptype active generation 0 network-id 1 network-cost 10
a=candidate:363291162 2 tcp 1518280446 172.16.1.154 9 typ host tcptype active generation 0 network-id 1 network-cost 10
a=candidate:2905925438 2 udp 1686052606 180.151.41.90 61270 typ srflx raddr 172.16.1.154 rport 61270 generation 0 network-id 1 network-cost 10
a=candidate:2905925438 1 udp 1686052607 180.151.41.90 61269 typ srflx raddr 172.16.1.154 rport 61269 generation 0 network-id 1 network-cost 10
a=ice-ufrag:7nhd
a=ice-pwd:PnLhhnr/Y73JSF3GohoWT6dB
a=fingerprint:sha-256 0C:71:BF:F8:C4:16:31:D5:42:3B:D3:8A:70:EE:39:DE:3D:A5:FB:E7:5B:69:05:38:8D:90:E1:62:02:E9:80:1A
a=setup:actpass
a=mid:audio
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=sendrecv
a=rtcp-mux
a=rtpmap:111 opus/48000/2
a=rtcp-fb:111 transport-cc
a=fmtp:111 minptime=10;useinbandfec=1
a=rtpmap:103 ISAC/16000
a=rtpmap:104 ISAC/32000
a=rtpmap:9 G722/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:126 telephone-event/8000
a=ssrc:3836577813 cname:/+TVltKqDn6B6XBw
a=ssrc:3836577813 msid:kbaxVjoAD2Tv3y1YZmTd2KOv8L9CQpQeMisa de4203bf-3a44-4bdc-9a56-b8d5bce7d645
a=ssrc:3836577813 mslabel:kbaxVjoAD2Tv3y1YZmTd2KOv8L9CQpQeMisa
a=ssrc:3836577813 label:de4203bf-3a44-4bdc-9a56-b8d5bce7d645
m=video 61271 UDP/TLS/RTP/SAVPF 100 101 107 116 117 96 97 99 98
c=IN IP4 180.151.41.90
a=rtcp:61272 IN IP4 180.151.41.90
a=candidate:1529126634 1 udp 2122260223 172.16.1.154 61271 typ host generation 0 network-id 1 network-cost 10
a=candidate:1529126634 2 udp 2122260222 172.16.1.154 61272 typ host generation 0 network-id 1 network-cost 10
a=candidate:363291162 1 tcp 1518280447 172.16.1.154 9 typ host tcptype active generation 0 network-id 1 network-cost 10
a=candidate:363291162 2 tcp 1518280446 172.16.1.154 9 typ host tcptype active generation 0 network-id 1 network-cost 10
a=candidate:2905925438 2 udp 1686052606 180.151.41.90 61272 typ srflx raddr 172.16.1.154 rport 61272 generation 0 network-id 1 network-cost 10
a=candidate:2905925438 1 udp 1686052607 180.151.41.90 61271 typ srflx raddr 172.16.1.154 rport 61271 generation 0 network-id 1 network-cost 10
a=ice-ufrag:7nhd
a=ice-pwd:PnLhhnr/Y73JSF3GohoWT6dB
a=fingerprint:sha-256 0C:71:BF:F8:C4:16:31:D5:42:3B:D3:8A:70:EE:39:DE:3D:A5:FB:E7:5B:69:05:38:8D:90:E1:62:02:E9:80:1A
a=setup:actpass
a=mid:video
a=extmap:2 urn:ietf:params:rtp-hdrext:toffset
a=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=extmap:4 urn:3gpp:video-orientation
a=extmap:5 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01
a=extmap:6 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay
a=sendrecv
a=rtcp-mux
a=rtcp-rsize
a=rtpmap:100 VP8/90000
a=rtcp-fb:100 ccm fir
a=rtcp-fb:100 nack
a=rtcp-fb:100 nack pli
a=rtcp-fb:100 goog-remb
a=rtcp-fb:100 transport-cc
a=rtpmap:101 VP9/90000
a=rtcp-fb:101 ccm fir
a=rtcp-fb:101 nack
a=rtcp-fb:101 nack pli
a=rtcp-fb:101 goog-remb
a=rtcp-fb:101 transport-cc
a=rtpmap:107 H264/90000
a=rtcp-fb:107 ccm fir
a=rtcp-fb:107 nack
a=rtcp-fb:107 nack pli
a=rtcp-fb:107 goog-remb
a=rtcp-fb:107 transport-cc
a=fmtp:107 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42e01f
a=rtpmap:116 red/90000
a=rtpmap:117 ulpfec/90000
a=rtpmap:96 rtx/90000
a=fmtp:96 apt=100
a=rtpmap:97 rtx/90000
a=fmtp:97 apt=101
a=rtpmap:99 rtx/90000
a=fmtp:99 apt=107
a=rtpmap:98 rtx/90000
a=fmtp:98 apt=116
a=ssrc-group:FID 2507734002 1941043268
a=ssrc:2507734002 cname:/+TVltKqDn6B6XBw
a=ssrc:2507734002 msid:kbaxVjoAD2Tv3y1YZmTd2KOv8L9CQpQeMisa 95c79c6e-df87-45bb-bfc5-cdf3bfaf00d7
a=ssrc:2507734002 mslabel:kbaxVjoAD2Tv3y1YZmTd2KOv8L9CQpQeMisa
a=ssrc:2507734002 label:95c79c6e-df87-45bb-bfc5-cdf3bfaf00d7
a=ssrc:1941043268 cname:/+TVltKqDn6B6XBw
a=ssrc:1941043268 msid:kbaxVjoAD2Tv3y1YZmTd2KOv8L9CQpQeMisa 95c79c6e-df87-45bb-bfc5-cdf3bfaf00d7
a=ssrc:1941043268 mslabel:kbaxVjoAD2Tv3y1YZmTd2KOv8L9CQpQeMisa
a=ssrc:1941043268 label:95c79c6e-df87-45bb-bfc5-cdf3bfaf00d7
<------------->
— (14 headers 99 lines) —
Using INVITE request as basis request - 9792f8a1-f729-3cdf-861a-ed1f97dc27bf
Found peer ‘1001’ for ‘1001’ from 172.16.1.154:56118
== Using SIP VIDEO CoS mark 6
== Using SIP RTP CoS mark 5
Found RTP audio format 111
Found RTP audio format 103
Found RTP audio format 104
Found RTP audio format 9
Found RTP audio format 0
Found RTP audio format 8
Found RTP audio format 106
Found RTP audio format 105
Found RTP audio format 13
Found RTP audio format 126
Found unknown media description format opus for ID 111
Found unknown media description format ISAC for ID 103
Found unknown media description format ISAC for ID 104
Found audio description format G722 for ID 9
Found audio description format PCMU for ID 0
Found audio description format PCMA for ID 8
Found unknown media description format CN for ID 106
Found unknown media description format CN for ID 105
Found audio description format CN for ID 13
Found audio description format telephone-event for ID 126
Found RTP video format 100
Found RTP video format 101
Found RTP video format 107
Found RTP video format 116
Found RTP video format 117
Found RTP video format 96
Found RTP video format 97
Found RTP video format 99
Found RTP video format 98
Found video description format H264 for ID 107
Capabilities: us - (ulaw|h263p|h264), peer - audio=(ulaw|alaw|g722)/video=(speex16|ilbc|h263p|h264|g719|silk8|silk12)/text=(nothing), combined - (ulaw|h263p|h264)
Non-codec capabilities (dtmf): us - 0x1 (telephone-event|), peer - 0x3 (telephone-event|CN|), combined - 0x1 (telephone-event|)
Peer audio RTP is at port 180.151.41.90:61269
Peer video RTP is at port 180.151.41.90:61271
Looking for 1003 in sip-users (domain 172.16.1.196)
list_route: hop: sips:1001@df7jal23ls0d.invalid;rtcweb-breaker=yes;click2call=no;transport=wss

<— Transmitting (NAT) to 172.16.1.154:56118 —>
SIP/2.0 100 Trying
Via: SIP/2.0/WSS df7jal23ls0d.invalid;branch=z9hG4bK6o4AnL28OwnKZbzNK2vTsuINuJbcvcrs;received=172.16.1.154;rport=56118
From: "1001"sip:1001@172.16.1.196;tag=cw86QskV5knntZ7b3JpV
To: sip:1003@172.16.1.196
Call-ID: 9792f8a1-f729-3cdf-861a-ed1f97dc27bf
CSeq: 22025 INVITE
Server: Asterisk PBX 11.16.0
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces, timer
Contact: sip:1003@172.16.1.196:5060;transport=WS
Content-Length: 0

<------------>
– Executing [1003@sip-users:1] Ringing(“SIP/1001-0000000e”, “5”) in new stack

<— Transmitting (NAT) to 172.16.1.154:56118 —>
SIP/2.0 180 Ringing
Via: SIP/2.0/WSS df7jal23ls0d.invalid;branch=z9hG4bK6o4AnL28OwnKZbzNK2vTsuINuJbcvcrs;received=172.16.1.154;rport=56118
From: "1001"sip:1001@172.16.1.196;tag=cw86QskV5knntZ7b3JpV
To: sip:1003@172.16.1.196;tag=as3381b95a
Call-ID: 9792f8a1-f729-3cdf-861a-ed1f97dc27bf
CSeq: 22025 INVITE
Server: Asterisk PBX 11.16.0
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces, timer
Contact: sip:1003@172.16.1.196:5060;transport=WS
Content-Length: 0

<------------>
– Executing [1003@sip-users:2] Playback(“SIP/1001-0000000e”, “hello-world”) in new stack
Audio is at 12198
Video is at 172.16.1.196:16202
Adding codec 100003 (ulaw) to SDP
Adding video codec 200004 (h264) to SDP
Adding video codec 200003 (h263p) to SDP
Adding non-codec 0x1 (telephone-event) to SDP

<— Reliably Transmitting (NAT) to 172.16.1.154:56118 —>
SIP/2.0 200 OK
Via: SIP/2.0/WSS df7jal23ls0d.invalid;branch=z9hG4bK6o4AnL28OwnKZbzNK2vTsuINuJbcvcrs;received=172.16.1.154;rport=56118
From: "1001"sip:1001@172.16.1.196;tag=cw86QskV5knntZ7b3JpV
To: sip:1003@172.16.1.196;tag=as3381b95a
Call-ID: 9792f8a1-f729-3cdf-861a-ed1f97dc27bf
CSeq: 22025 INVITE
Server: Asterisk PBX 11.16.0
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces, timer
Contact: sip:1003@172.16.1.196:5060;transport=WS
Content-Type: application/sdp
Content-Length: 1561

v=0
o=root 1089657109 1089657109 IN IP4 172.16.1.196
s=Asterisk PBX 11.16.0
c=IN IP4 172.16.1.196
b=CT:384
t=0 0
m=audio 12198 UDP/TLS/RTP/SAVPF 0 126
a=rtpmap:0 PCMU/8000
a=rtpmap:126 telephone-event/8000
a=fmtp:126 0-16
a=ptime:20
a=ice-ufrag:056d4f8a2db61450638a976f0574806c
a=ice-pwd:129ab31d2762e6db0a28acad5f41588e
a=candidate:Hac1001c4 1 UDP 2130706431 172.16.1.196 12198 typ host
a=candidate:S7d100712 1 UDP 1694498815 125.16.7.18 12198 typ srflx raddr 172.16.1.196 rport 12198
a=candidate:Hac1001c4 2 UDP 2130706430 172.16.1.196 12199 typ host
a=candidate:S7d100712 2 UDP 1694498814 125.16.7.18 12199 typ srflx raddr 172.16.1.196 rport 12199
a=connection:new
a=setup:active
a=fingerprint:SHA-256 10:51:6E:BB:44:67:07:DE:14:03:D7:E1:A0:C9:6A:C4:28:EB:BF:7C:72:2A:C8:C7:69:85:36:D2:8F:18:55:3F
a=sendrecv
m=video 16202 UDP/TLS/RTP/SAVPF 99 98
a=ice-ufrag:099112152acfa5ef2eea5e04326ebe56
a=ice-pwd:512052fe0848f63f2c5e15ff0ced0644
a=candidate:Hac1001c4 1 UDP 2130706431 172.16.1.196 16202 typ host
a=candidate:S7d100712 1 UDP 1694498815 125.16.7.18 16202 typ srflx raddr 172.16.1.196 rport 16202
a=candidate:Hac1001c4 2 UDP 2130706430 172.16.1.196 16203 typ host
a=candidate:S7d100712 2 UDP 1694498814 125.16.7.18 16203 typ srflx raddr 172.16.1.196 rport 16203
a=connection:new
a=setup:active
a=fingerprint:SHA-256 10:51:6E:BB:44:67:07:DE:14:03:D7:E1:A0:C9:6A:C4:28:EB:BF:7C:72:2A:C8:C7:69:85:36:D2:8F:18:55:3F
a=rtpmap:99 H264/90000
a=rtpmap:98 H263-1998/90000
a=fmtp:98 F=0;I=0;J=0;T=0;K=0;N=0;BPP=0;HRD=0
a=sendrecv

<------------>

<— SIP read from WS:172.16.1.154:56118 —>
ACK sip:1003@172.16.1.196:5060;transport=WS SIP/2.0
Via: SIP/2.0/WSS df7jal23ls0d.invalid;branch=z9hG4bKovExC14LSQ5x76sRmvhE;rport
From: "1001"sip:1001@172.16.1.196;tag=cw86QskV5knntZ7b3JpV
To: sip:1003@172.16.1.196;tag=as3381b95a
Contact: "1001"sips:1001@df7jal23ls0d.invalid;rtcweb-breaker=yes;click2call=no;transport=wss;+g.oma.sip-im;language="en,fr"
Call-ID: 9792f8a1-f729-3cdf-861a-ed1f97dc27bf
CSeq: 22025 ACK
Content-Length: 0
Route: sip:172.16.1.196:5060;lr;sipml5-outbound;transport=udp
Max-Forwards: 70
Authorization: Digest username=“1001”,realm=“172.16.1.196”,nonce=“770ce54c”,uri=“sip:1003@172.16.1.196:5060;transport=WS”,response=“dfa27d6aa9e29a7cf97b7ba1bde35b02”,algorithm=MD5
User-Agent: IM-client/OMA1.0 sipML5-v1.2016.03.04
Organization: Doubango Telecom

<------------->
— (13 headers 0 lines) —
> 0x7fd24c0559a0 – Probation passed - setting RTP source address to 172.16.1.154:61269
– <SIP/1001-0000000e> Playing ‘hello-world.alaw’ (language ‘en’)
– Executing [1003@sip-users:3] Dial(“SIP/1001-0000000e”, “SIP/1003,20”) in new stack
== Using SIP VIDEO CoS mark 6
== Using SIP RTP CoS mark 5
Audio is at 15264
Video is at 172.16.1.196:11588
Adding codec 100003 (ulaw) to SDP
Adding video codec 200004 (h264) to SDP
Adding video codec 200003 (h263p) to SDP
Adding non-codec 0x1 (telephone-event) to SDP
Reliably Transmitting (NAT) to 172.16.1.154:56096:
INVITE sips:1003@df7jal23ls0d.invalid;rtcweb-breaker=yes;transport=wss SIP/2.0
Via: SIP/2.0/WS 172.16.1.196:5060;branch=z9hG4bK172a6741;rport
Max-Forwards: 70
From: “1001” sip:1001@172.16.1.196;tag=as3aede5d6
To: sips:1003@df7jal23ls0d.invalid;rtcweb-breaker=yes;transport=wss
Contact: sip:1001@172.16.1.196:5060;transport=WS
Call-ID: 7cdd6a6d185bb22b771f1dd86913c284@172.16.1.196:5060
CSeq: 102 INVITE
User-Agent: Asterisk PBX 11.16.0
Date: Thu, 23 Feb 2017 06:59:10 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces, timer
Content-Type: application/sdp
Content-Length: 1563

v=0
o=root 1842866713 1842866713 IN IP4 172.16.1.196
s=Asterisk PBX 11.16.0
c=IN IP4 172.16.1.196
b=CT:384
t=0 0
m=audio 15264 UDP/TLS/RTP/SAVPF 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=ice-ufrag:5388eff3634b61a8667b183c607c5a75
a=ice-pwd:7b64058b63d7574b6f2eaf3871962edc
a=candidate:Hac1001c4 1 UDP 2130706431 172.16.1.196 15264 typ host
a=candidate:S7d100712 1 UDP 1694498815 125.16.7.18 15264 typ srflx raddr 172.16.1.196 rport 15264
a=candidate:Hac1001c4 2 UDP 2130706430 172.16.1.196 15265 typ host
a=candidate:S7d100712 2 UDP 1694498814 125.16.7.18 15265 typ srflx raddr 172.16.1.196 rport 15265
a=connection:new
a=setup:actpass
a=fingerprint:SHA-256 10:51:6E:BB:44:67:07:DE:14:03:D7:E1:A0:C9:6A:C4:28:EB:BF:7C:72:2A:C8:C7:69:85:36:D2:8F:18:55:3F
a=sendrecv
m=video 11588 UDP/TLS/RTP/SAVPF 99 98
a=ice-ufrag:100b55ad15b825b235c0ba561c95d97d
a=ice-pwd:773e2828500322a97e4f7bc1610eac0f
a=candidate:Hac1001c4 1 UDP 2130706431 172.16.1.196 11588 typ host
a=candidate:S7d100712 1 UDP 1694498815 125.16.7.18 11588 typ srflx raddr 172.16.1.196 rport 11588
a=candidate:Hac1001c4 2 UDP 2130706430 172.16.1.196 11589 typ host
a=candidate:S7d100712 2 UDP 1694498814 125.16.7.18 11589 typ srflx raddr 172.16.1.196 rport 11589
a=connection:new
a=setup:actpass
a=fingerprint:SHA-256 10:51:6E:BB:44:67:07:DE:14:03:D7:E1:A0:C9:6A:C4:28:EB:BF:7C:72:2A:C8:C7:69:85:36:D2:8F:18:55:3F
a=rtpmap:99 H264/90000
a=rtpmap:98 H263-1998/90000
a=fmtp:98 F=0;I=0;J=0;T=0;K=0;N=0;BPP=0;HRD=0
a=sendrecv


-- Called SIP/1003

<— SIP read from WS:172.16.1.154:56096 —>
SIP/2.0 100 Trying (sent from the Transaction Layer)
Via: SIP/2.0/WS 172.16.1.196:5060;rport=5060;branch=z9hG4bK172a6741
From: "1001"sip:1001@172.16.1.196;tag=as3aede5d6
To: sips:1003@df7jal23ls0d.invalid;rtcweb-breaker=yes;transport=wss
Call-ID: 7cdd6a6d185bb22b771f1dd86913c284@172.16.1.196:5060
CSeq: 102 INVITE
Content-Length: 0

<------------->
— (7 headers 0 lines) —

<— SIP read from WS:172.16.1.154:56096 —>
SIP/2.0 180 Ringing
Via: SIP/2.0/WS 172.16.1.196:5060;rport=5060;branch=z9hG4bK172a6741
From: "1001"sip:1001@172.16.1.196;tag=as3aede5d6
To: sips:1003@df7jal23ls0d.invalid;rtcweb-breaker=yes;transport=wss;tag=GpSfxytekkq8euA29a7p
Contact: sips:1003@df7jal23ls0d.invalid;transport=wss
Call-ID: 7cdd6a6d185bb22b771f1dd86913c284@172.16.1.196:5060
CSeq: 102 INVITE
Content-Length: 0
Allow: ACK, BYE, CANCEL, INVITE, MESSAGE, NOTIFY, OPTIONS, PRACK, REFER, UPDATE

<------------->
— (9 headers 0 lines) —
list_route: hop: sips:1003@df7jal23ls0d.invalid;transport=wss
– SIP/1003-0000000f is ringing
> 0x7fd24c019220 – Probation passed - setting RTP source address to 172.16.1.154:61271
Reliably Transmitting (NAT) to 172.16.1.154:58411:
OPTIONS sip:7000@172.16.1.154:58411;rinstance=7ea362d55a32cbc8 SIP/2.0
Via: SIP/2.0/UDP 172.16.1.196:5060;branch=z9hG4bK3ecb60ef;rport
Max-Forwards: 70
From: “asterisk” sip:asterisk@172.16.1.196;tag=as3e4b94e2
To: sip:7000@172.16.1.154:58411;rinstance=7ea362d55a32cbc8
Contact: sip:asterisk@172.16.1.196:5060
Call-ID: 355e6b351af08f052ebf377f72db4569@172.16.1.196:5060
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX 11.16.0
Date: Thu, 23 Feb 2017 06:59:10 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces
Content-Length: 0


<— SIP read from UDP:172.16.1.154:58411 —>
SIP/2.0 405 Method Not Allowed
Via: SIP/2.0/UDP 172.16.1.196:5060;branch=z9hG4bK3ecb60ef;rport=5060
To: sip:7000@172.16.1.154:58411;rinstance=7ea362d55a32cbc8;tag=25fa9153
From: “asterisk” sip:asterisk@172.16.1.196;tag=as3e4b94e2
Call-ID: 355e6b351af08f052ebf377f72db4569@172.16.1.196:5060
CSeq: 102 OPTIONS
Allow: SUBSCRIBE, NOTIFY, INVITE, ACK, CANCEL, BYE, REFER, INFO, MESSAGE
Content-Length: 0

<------------->
— (8 headers 0 lines) —
Really destroying SIP dialog ‘355e6b351af08f052ebf377f72db4569@172.16.1.196:5060’ Method: OPTIONS
Really destroying SIP dialog ‘0bce435c-3d64-a25b-b6f4-c0b4b968a61e’ Method: REGISTER

<— SIP read from WS:172.16.1.154:56096 —>
SIP/2.0 200 OK
Via: SIP/2.0/WS 172.16.1.196:5060;rport=5060;branch=z9hG4bK172a6741
From: "1001"sip:1001@172.16.1.196;tag=as3aede5d6
To: sips:1003@df7jal23ls0d.invalid;rtcweb-breaker=yes;transport=wss;tag=GpSfxytekkq8euA29a7p
Contact: sips:1003@df7jal23ls0d.invalid;transport=wss
Call-ID: 7cdd6a6d185bb22b771f1dd86913c284@172.16.1.196:5060
CSeq: 102 INVITE
Content-Type: application/sdp
Content-Length: 1896
Allow: ACK, BYE, CANCEL, INVITE, MESSAGE, NOTIFY, OPTIONS, PRACK, REFER, UPDATE

v=0
o=- 1168784556830536700 2 IN IP4 127.0.0.1
s=Doubango Telecom - chrome
t=0 0
a=msid-semantic: WMS aarzCvh7wGiGwdblUpGy7gx6QF9TU70RwpOn
m=audio 63779 UDP/TLS/RTP/SAVPF 0 101
c=IN IP4 172.16.1.154
a=rtcp:63780 IN IP4 172.16.1.154
a=candidate:1529126634 1 udp 2122260223 172.16.1.154 63779 typ host generation 0 network-id 1 network-cost 10
a=candidate:1529126634 2 udp 2122260222 172.16.1.154 63780 typ host generation 0 network-id 1 network-cost 10
a=ice-ufrag:kwVQ
a=ice-pwd:VQiWigkrT8l+bkmXwEZMAemI
a=fingerprint:sha-256 29:79:2F:A9:87:FE:F8:E9:64:DF:30:82:AD:13:5B:5A:66:C3:1F:B3:5F:46:F0:A7:58:F8:E1:F8:62:CD:72:E4
a=setup:active
a=mid:audio
a=sendrecv
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=ssrc:615836778 cname:X8i8u3GCEV5lQqiq
a=ssrc:615836778 msid:aarzCvh7wGiGwdblUpGy7gx6QF9TU70RwpOn c4067012-30c3-4420-a740-a3bfc8a53b08
a=ssrc:615836778 mslabel:aarzCvh7wGiGwdblUpGy7gx6QF9TU70RwpOn
a=ssrc:615836778 label:c4067012-30c3-4420-a740-a3bfc8a53b08
m=video 63781 UDP/TLS/RTP/SAVPF 99
c=IN IP4 172.16.1.154
a=rtcp:63782 IN IP4 172.16.1.154
a=candidate:1529126634 1 udp 2122260223 172.16.1.154 63781 typ host generation 0 network-id 1 network-cost 10
a=candidate:1529126634 2 udp 2122260222 172.16.1.154 63782 typ host generation 0 network-id 1 network-cost 10
a=ice-ufrag:NRUa
a=ice-pwd:usgPyZjriHO6ewNT+1KSDrWP
a=fingerprint:sha-256 29:79:2F:A9:87:FE:F8:E9:64:DF:30:82:AD:13:5B:5A:66:C3:1F:B3:5F:46:F0:A7:58:F8:E1:F8:62:CD:72:E4
a=setup:active
a=mid:video
a=sendrecv
a=rtpmap:99 H264/90000
a=fmtp:99 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42e01f
a=ssrc:1665384662 cname:X8i8u3GCEV5lQqiq
a=ssrc:1665384662 msid:aarzCvh7wGiGwdblUpGy7gx6QF9TU70RwpOn b9805635-024b-4c84-9dfa-32688e454fa2
a=ssrc:1665384662 mslabel:aarzCvh7wGiGwdblUpGy7gx6QF9TU70RwpOn
a=ssrc:1665384662 label:b9805635-024b-4c84-9dfa-32688e454fa2
<------------->
— (10 headers 39 lines) —
Found RTP audio format 0
Found RTP audio format 101
Found audio description format PCMU for ID 0
Found audio description format telephone-event for ID 101
Found RTP video format 99
Found video description format H264 for ID 99
Capabilities: us - (ulaw|h263p|h264), peer - audio=(ulaw)/video=(h264)/text=(nothing), combined - (ulaw|h264)
Non-codec capabilities (dtmf): us - 0x1 (telephone-event|), peer - 0x1 (telephone-event|), combined - 0x1 (telephone-event|)
Peer audio RTP is at port 172.16.1.154:63779
Peer video RTP is at port 172.16.1.154:63781
list_route: hop: sips:1003@df7jal23ls0d.invalid;transport=wss
set_destination: Parsing sips:1003@df7jal23ls0d.invalid;transport=wss for address/port to send to
set_destination: URI is for WebSocket, we can’t set destination
Transmitting (NAT) to 172.16.1.154:56096:
ACK sips:1003@df7jal23ls0d.invalid;transport=wss SIP/2.0
Via: SIP/2.0/WS 172.16.1.196:5060;branch=z9hG4bK43d6bb2b;rport
Max-Forwards: 70
From: “1001” sip:1001@172.16.1.196;tag=as3aede5d6
To: sips:1003@df7jal23ls0d.invalid;rtcweb-breaker=yes;transport=wss;tag=GpSfxytekkq8euA29a7p
Contact: sip:1001@172.16.1.196:5060;transport=WS
Call-ID: 7cdd6a6d185bb22b771f1dd86913c284@172.16.1.196:5060
CSeq: 102 ACK
User-Agent: Asterisk PBX 11.16.0
Content-Length: 0


-- SIP/1003-0000000f answered SIP/1001-0000000e
   > 0x211a290 -- Probation passed - setting RTP source address to 172.16.1.154:63779
   > 0x2129390 -- Probation passed - setting RTP source address to 172.16.1.154:63781

[Feb 23 01:59:14] WARNING[27895][C-00000008]: res_srtp.c:407 ast_srtp_unprotect: SRTP unprotect failed with: authentication failure 10
[Feb 23 01:59:18] WARNING[27895][C-00000008]: res_srtp.c:407 ast_srtp_unprotect: SRTP unprotect failed with: authentication failure 110
[Feb 23 01:59:19] WARNING[27895][C-00000008]: res_srtp.c:407 ast_srtp_unprotect: SRTP unprotect failed with: authentication failure 10
[Feb 23 01:59:20] WARNING[27895][C-00000008]: res_srtp.c:407 ast_srtp_unprotect: SRTP unprotect failed with: authentication failure 110
[Feb 23 01:59:22] WARNING[27895][C-00000008]: res_srtp.c:407 ast_srtp_unprotect: SRTP unprotect failed with: authentication failure 110

When it comes to WebRTC you have to use the latest version of Asterisk as WebRTC has changed and evolved. I’d suggest upgrading and trying it instead.

You should attach a full RTP log to be able to say anything useful.
Possible reasons:

  • old asterisk version had a related bug. you should upgrade
  • use at least ibsrtp v 1.5
  • libsrtp or libuuid not installed correctly
  • mixed video and audio streams