ul  8 14:45:44 test /usr/sbin/kamailio[7424]: INFO: <script>: SIP request received on 4443
Jul  8 14:45:44 test /usr/sbin/kamailio[7424]: INFO: <script>: NATDECECT for {INVITE}
Jul  8 14:45:44 test /usr/sbin/kamailio[7424]: INFO: <script>: No Tag for {INVITE}
Jul  8 14:45:44 test /usr/sbin/kamailio[7424]: INFO: <script>: gointg auth {INVITE}
Jul  8 14:45:45 test /usr/sbin/kamailio[7424]: INFO: <script>: SIP request received on 4443
Jul  8 14:45:45 test /usr/sbin/kamailio[7424]: INFO: <script>: NATDECECT for {INVITE}
Jul  8 14:45:45 test /usr/sbin/kamailio[7424]: INFO: <script>: No Tag for {INVITE}
Jul  8 14:45:45 test /usr/sbin/kamailio[7424]: INFO: <script>: gointg auth {INVITE}
Jul  8 14:45:45 test /usr/sbin/kamailio[7424]: INFO: <script>: Removed header at {INVITE}
Jul  8 14:45:45 test /usr/sbin/kamailio[7424]: INFO: <script>: Goes through REGISTRAR Route {INVITE}
Jul  8 14:45:45 test /usr/sbin/kamailio[7424]: INFO: <script>: Contact is {0}
Jul  8 14:45:45 test /usr/sbin/kamailio[7424]: INFO: <script>: Request coming from WS
Jul  8 14:45:45 test rtpengine[16835]: Got valid command from 127.0.0.1:56429: offer - { "sdp": "v=0#015#012o=- 3654744445740762925 2 IN IP4 127.0.0.1#015#012s=-#015#012t=0 0#015#012a=group:BUNDLE audio#015#012a=msid-semantic: WMS LCuy7b2RExIh7nnmC1hm1VhRSukVUzVB5nSe#015#012m=audio 59286 RTP/SAVPF 111 103 104 0 8 106 105 13 126#015#012c=IN IP4 192.168.56.1#015#012a=rtcp:59286 IN IP4 192.168.56.1#015#012a=candidate:2999745851 1 udp 2122260223 192.168.56.1 59286 typ host generation 0#015#012a=candidate:2999745851 2 udp 2122260223 192.168.56.1 59286 typ host generation 0#015#012a=candidate:2448668656 1 udp 2122194687 192.168.142.1 59287 typ host generation 0#015#012a=candidate:2448668656 2 udp 2122194687 192.168.142.1 59287 typ host generation 0#015#012a=candidate:2131708102 1 udp 2122129151 192.168.0.100 59288 typ host generation 0#015#012a=candidate:2131708102 2 udp 2122129151 192.168.0.100 59288 typ host generation 0#015#012a=candidate:2602400937 1 udp 2122063615 192.168.214.1 59289 typ host generation 0#015#012a=candidate:2602400937 2 udp 2122063615 192.168.214.1 59289 typ host generation 0#015#012a=candidate:4233069003 1 tcp 1518280447 192.168.56.1 0 typ host generation 0#015#012a=candidate:4233069003 2 tcp 1518280447 192.168.56.1 0 typ host generation 0#015#012a=candidate:3748678400 1 tcp 1518214911 192.168.142.1 0 typ host generation 0#015#012a=candidate:3748678400 2 tcp 1518214911 192.168.142.1 0 typ host generation 0#015#012a=candidate:831304758 1 tcp 1518149375 192.168.0.100 0 typ host generation 0#015#012a=candidate:831304758 2 tcp 1518149375 192.168.0.100 0 typ host generation 0#015#012a=candidate:3583934553 1 tcp 1518083839 192.168.214.1 0 typ host generation 0#015#012a=candidate:3583934553 2 tcp 1518083839 192.168.214.1 0 typ host generation 0#015#012a=ice-ufrag:VzWu0LcrLcChoSd9#015#012a=ice-pwd:WaA3ZYgMq663AbfxRY/e2fdQ#015#012a=ice-options:google-ice#015#012a=fingerprint:sha-256 82:F3:22:8B:C6:FA:41:50:3E:0F:F1:5D:7D:97:5A:77:B9:94:44:10:C8:00:BC:DF:AC:AF:A9:14:8F:67:1B:A4#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#015#012a=rtpmap:103 ISAC/16000#015#012a=rtpmap:104 ISAC/32000#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 CN/8000#015#012a=rtpmap:126 telephone-event/8000#015#012a=maxptime:60#015#012a=ssrc:1673493949 cname:e4092wt5bQ7mBox/#015#012a=ssrc:1673493949 msid:LCuy7b2RExIh7nnmC1hm1VhRSukVUzVB5nSe f0e2ffdc-f17b-43b0-938c-1ce9e30aa225#015#012a=ssrc:1673493949 mslabel:LCuy7b2RExIh7nnmC1hm1VhRSukVUzVB5nSe#015#012a=ssrc:1673493949 label:f0e2ffdc-f17b-43b0-938c-1ce9e30aa225#015#012", "ICE": "remove", "flags": [ "force", "trust-address" ], "replace": [ "origin", "session-connection" ], "transport-protocol": "RTP/AVP", "call-id": "f4vpj2kb6ih0ajferu29", "received-from": [ "IP4", "3.3.3.3" ], "from-tag": "cnhud9704o", "command": "offer" }
Jul  8 14:45:45 test rtpengine[16835]: Unknown flag encountered: 'force'
Jul  8 14:45:45 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29] Creating new call
Jul  8 14:45:45 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29] Returning to SIP proxy: d3:sdp770:v=0#015#012o=- 3654744445740762925 2 IN IP4 1.1.1.1#015#012s=-#015#012t=0 0#015#012a=msid-semantic: WMS LCuy7b2RExIh7nnmC1hm1VhRSukVUzVB5nSe#015#012m=audio 30716 RTP/AVP 111 103 104 0 8 106 105 13 126#015#012c=IN IP4 1.1.1.1#015#012a=rtpmap:111 opus/48000/2#015#012a=fmtp:111 minptime=10#015#012a=rtpmap:103 ISAC/16000#015#012a=rtpmap:104 ISAC/32000#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 CN/8000#015#012a=rtpmap:126 telephone-event/8000#015#012a=maxptime:60#015#012a=ssrc:1673493949 cname:e4092wt5bQ7mBox/#015#012a=ssrc:1673493949 msid:LCuy7b2RExIh7nnmC1hm1VhRSukVUzVB5nSe f0e2ffdc-f17b-43b0-938c-1ce9e30aa225#015#012a=ssrc:1673493949 mslabel:LCuy7b2RExIh7nnmC1hm1VhRSukVUzVB5nSe#015#012a=ssrc:1673493949 label:f0e2ffdc-f17b-43b0-938c-1ce9e30aa225#015#012a=sendrecv#015#012a=rtcp:30717#015#012a=rtcp-mux#015#0126:result2:oke
Jul  8 14:45:45 test /usr/sbin/kamailio[7424]: INFO: <script>: Faltured {INVITE}
Jul  8 14:45:45 test /usr/sbin/kamailio[7424]: INFO: <script>: This is not falture {INVITE}
Jul  8 14:45:45 test /usr/sbin/kamailio[7424]: INFO: <script>: destination {0} to asterisk
Jul  8 14:45:45 test /usr/sbin/kamailio[7424]: INFO: <script>: [mycompany.device-1884@3.3.3.3:63439]{INVITE} From Outside World to Asterisk Box sip:2.2.2.2:50600
Jul  8 14:45:45 test /usr/sbin/kamailio[7424]: INFO: <script>: Translate {INVITE} to asterisk
Jul  8 14:45:45 test /usr/sbin/kamailio[7412]: INFO: <script>: WS Reply from softphone: 100
Jul  8 14:45:45 test /usr/sbin/kamailio[7412]: INFO: <script>: flagset {INVITE}
Jul  8 14:45:45 test /usr/sbin/kamailio[7412]: INFO: <script>: reply  {INVITE}
Jul  8 14:45:45 test /usr/sbin/kamailio[7411]: INFO: <script>: SIP request received on 5060
Jul  8 14:45:45 test /usr/sbin/kamailio[7411]: INFO: <script>: NATDECECT for {INVITE}
Jul  8 14:45:45 test /usr/sbin/kamailio[7411]: INFO: <script>: No Tag for {INVITE}
Jul  8 14:45:45 test /usr/sbin/kamailio[7411]: INFO: <script>: gointg auth {INVITE}
Jul  8 14:45:45 test /usr/sbin/kamailio[7411]: INFO: <script>: Removed header at {INVITE}
Jul  8 14:45:45 test /usr/sbin/kamailio[7411]: INFO: <script>: Goes through REGISTRAR Route {INVITE}
Jul  8 14:45:45 test /usr/sbin/kamailio[7411]: INFO: <script>: Contact is {sip:65kfrpn0@jb2ebovsk5vl.invalid;transport=ws}
Jul  8 14:45:45 test /usr/sbin/kamailio[7411]: INFO: <script>: Request going to WS
Jul  8 14:45:45 test rtpengine[16835]: Got valid command from 127.0.0.1:48472: offer - { "sdp": "v=0#015#012o=root 247958601 247958601 IN IP4 2.2.2.2#015#012s=Asterisk PBX 12.3.2#015#012c=IN IP4 2.2.2.2#015#012t=0 0#015#012m=audio 14162 RTP/AVP 0 3 8 101#015#012a=rtpmap:0 PCMU/8000#015#012a=rtpmap:3 GSM/8000#015#012a=rtpmap:8 PCMA/8000#015#012a=rtpmap:101 telephone-event/8000#015#012a=fmtp:101 0-16#015#012a=ptime:20#015#012a=maxptime:150#015#012a=sendrecv#015#012", "ICE": "force", "flags": [ "force", "trust-address" ], "replace": [ "origin", "session-connection" ], "transport-protocol": "RTP/SAVPF", "call-id": "1b6fc6a73a35f52d00cdbeca34246128@2.2.2.2:50600", "received-from": [ "IP4", "2.2.2.2" ], "from-tag": "as5d5be016", "command": "offer" }
Jul  8 14:45:45 test rtpengine[16835]: Unknown flag encountered: 'force'
Jul  8 14:45:45 test rtpengine[16835]: [1b6fc6a73a35f52d00cdbeca34246128@2.2.2.2:50600] Creating new call
Jul  8 14:45:45 test rtpengine[16835]: [1b6fc6a73a35f52d00cdbeca34246128@2.2.2.2:50600] Returning to SIP proxy: d3:sdp726:v=0#015#012o=root 247958601 247958601 IN IP4 1.1.1.1#015#012s=Asterisk PBX 12.3.2#015#012c=IN IP4 1.1.1.1#015#012t=0 0#015#012a=ice-lite#015#012m=audio 30720 RTP/SAVPF 0 3 8 101#015#012a=rtpmap:0 PCMU/8000#015#012a=rtpmap:3 GSM/8000#015#012a=rtpmap:8 PCMA/8000#015#012a=rtpmap:101 telephone-event/8000#015#012a=fmtp:101 0-16#015#012a=ptime:20#015#012a=maxptime:150#015#012a=sendrecv#015#012a=rtcp:30721#015#012a=crypto:0 AES_CM_128_HMAC_SHA1_80 inline:FEYysKL6jz4ZP13jwlULy9KMYWvb/gThZGKNJDzJ#015#012a=setup:actpass#015#012a=fingerprint:sha-1 F9:F5:10:95:65:65:F6:A3:60:1F:9A:34:05:4A:0D:34:BB:0E:8A:B0#015#012a=ice-ufrag:JXzhrMD5#015#012a=ice-pwd:4wo1lsSo6ckBx5v3hSxgsEZazwr0#015#012a=candidate:Ki5mpzv9D3rv7wSw 1 UDP 2130706432 1.1.1.1 30720 typ host#015#012a=candidate:Ki5mpzv9D3rv7wSw 2 UDP 2130706431 1.1.1.1 30721 typ host#015#0126:result2:oke
Jul  8 14:45:45 test /usr/sbin/kamailio[7411]: INFO: <script>: Faltured {INVITE}
Jul  8 14:45:45 test /usr/sbin/kamailio[7411]: INFO: <script>: This is not falture {INVITE}
Jul  8 14:45:45 test /usr/sbin/kamailio[7411]: INFO: <script>: destination {sip:2.2.2.2:50600} to asterisk
Jul  8 14:45:45 test /usr/sbin/kamailio[7411]: INFO: <script>: [1054@2.2.2.2:50600]{INVITE} Call from Media-Server Cluster
Jul  8 14:45:45 test /usr/sbin/kamailio[7411]: INFO: <script>: SQL query return {sip:4.4.4.4:63381;transport=WS} for {mycompany.device-1901}
Jul  8 14:45:45 test /usr/sbin/kamailio[7411]: INFO: <script>: Destination URI is {sip:4.4.4.4:63381;transport=WS} for {mycompany.device-1901}
Jul  8 14:45:45 test /usr/sbin/kamailio[7425]: INFO: <script>: Reply from webrtc client: 100
Jul  8 14:45:46 test /usr/sbin/kamailio[7425]: INFO: <script>: Reply from webrtc client: 180
Jul  8 14:45:46 test /usr/sbin/kamailio[7413]: INFO: <script>: WS Reply from softphone: 180
Jul  8 14:45:46 test /usr/sbin/kamailio[7413]: INFO: <script>: flagset {INVITE}
Jul  8 14:45:46 test /usr/sbin/kamailio[7413]: INFO: <script>: reply  {INVITE}
Jul  8 14:45:57 test rtpengine[16835]: [1b6fc6a73a35f52d00cdbeca34246128@2.2.2.2:50600 port 30720] Successful STUN binding request from 4.4.4.4:58205
Jul  8 14:45:57 test rtpengine[16835]: [1b6fc6a73a35f52d00cdbeca34246128@2.2.2.2:50600 port 30721] Successful STUN binding request from 4.4.4.4:58207
Jul  8 14:45:59 test /usr/sbin/kamailio[7422]: INFO: <script>: Reply from webrtc client: 200
Jul  8 14:45:59 test rtpengine[16835]: Got valid command from 127.0.0.1:59789: answer - { "sdp": "v=0#015#012o=Mozilla-SIPUA-30.0 1146 0 IN IP4 0.0.0.0#015#012s=SIP Call#015#012t=0 0#015#012a=ice-ufrag:7a1d38e9#015#012a=ice-pwd:c1949ba1d7d528e3916f824ba3de9d63#015#012a=fingerprint:sha-256 DC:16:B1:8E:A0:AD:97:91:70:71:17:6D:EA:15:D1:DB:95:B8:3C:FF:A9:7A:1F:58:7E:12:06:38:C8:1A:A3:A5#015#012m=audio 58205 RTP/SAVPF 0 101#015#012c=IN IP4 192.168.1.138#015#012a=rtpmap:0 PCMU/8000#015#012a=rtpmap:101 telephone-event/8000#015#012a=fmtp:101 0-15#015#012a=sendrecv#015#012a=setup:active#015#012a=candidate:0 1 UDP 2128609535 192.168.1.138 58205 typ host#015#012a=candidate:0 2 UDP 2128609534 192.168.1.138 58207 typ host#015#012", "ICE": "remove", "flags": [ "force", "trust-address" ], "replace": [ "origin", "session-connection" ], "transport-protocol": "RTP/AVP", "call-id": "1b6fc6a73a35f52d00cdbeca34246128@2.2.2.2:50600", "received-from": [ "IP4", "4.4.4.4" ], "from-tag": "as5d5be016", "to-tag": "lu5akkpnnv", "command": "answer" }
Jul  8 14:45:59 test rtpengine[16835]: Unknown flag encountered: 'force'
Jul  8 14:45:59 test rtpengine[16835]: [1b6fc6a73a35f52d00cdbeca34246128@2.2.2.2:50600] Returning to SIP proxy: d3:sdp222:v=0#015#012o=Mozilla-SIPUA-30.0 1146 0 IN IP4 0.0.0.0#015#012s=SIP Call#015#012t=0 0#015#012m=audio 30722 RTP/AVP 0 101#015#012c=IN IP4 1.1.1.1#015#012a=rtpmap:0 PCMU/8000#015#012a=rtpmap:101 telephone-event/8000#015#012a=fmtp:101 0-15#015#012a=sendrecv#015#012a=rtcp:30723#015#0126:result2:oke
Jul  8 14:45:59 test /usr/sbin/kamailio[7412]: INFO: <script>: SIP request received on 5060
Jul  8 14:45:59 test /usr/sbin/kamailio[7412]: INFO: <script>: NATDECECT for {ACK}
Jul  8 14:45:59 test /usr/sbin/kamailio[7412]: ERROR: <script>: ==> duri=[<null>]
Jul  8 14:45:59 test /usr/sbin/kamailio[7412]: INFO: <script>: request {ACK}
Jul  8 14:45:59 test /usr/sbin/kamailio[7412]: INFO: <script>: flagset {ACK}
Jul  8 14:45:59 test /usr/sbin/kamailio[7411]: INFO: <script>: WS Reply from softphone: 200
Jul  8 14:45:59 test rtpengine[16835]: Got valid command from 127.0.0.1:48472: answer - { "sdp": "v=0#015#012o=root 620628928 620628928 IN IP4 2.2.2.2#015#012s=Asterisk PBX 12.3.2#015#012c=IN IP4 2.2.2.2#015#012t=0 0#015#012m=audio 15966 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=fmtp:126 0-16#015#012a=ptime:20#015#012a=maxptime:150#015#012a=sendrecv#015#012", "ICE": "force", "flags": [ "force", "trust-address" ], "replace": [ "origin", "session-connection" ], "transport-protocol": "RTP/SAVPF", "call-id": "f4vpj2kb6ih0ajferu29", "received-from": [ "IP4", "2.2.2.2" ], "from-tag": "cnhud9704o", "to-tag": "as73beca6d", "command": "answer" }
Jul  8 14:45:59 test rtpengine[16835]: Unknown flag encountered: 'force'
Jul  8 14:45:59 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29] Returning to SIP proxy: d3:sdp618:v=0#015#012o=root 620628928 620628928 IN IP4 1.1.1.1#015#012s=Asterisk PBX 12.3.2#015#012c=IN IP4 1.1.1.1#015#012t=0 0#015#012a=ice-lite#015#012m=audio 30718 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=fmtp:126 0-16#015#012a=ptime:20#015#012a=maxptime:150#015#012a=sendrecv#015#012a=rtcp:30719#015#012a=setup:active#015#012a=fingerprint:sha-1 F9:F5:10:95:65:65:F6:A3:60:1F:9A:34:05:4A:0D:34:BB:0E:8A:B0#015#012a=ice-ufrag:i53kzrjV#015#012a=ice-pwd:S9hYlAxQF3RWTpal17vAEVyU0Cdz#015#012a=candidate:Ki5mpzv9D3rv7wSw 1 UDP 2130706432 1.1.1.1 30718 typ host#015#012a=candidate:Ki5mpzv9D3rv7wSw 2 UDP 2130706431 1.1.1.1 30719 typ host#015#0126:result2:oke
Jul  8 14:45:59 test /usr/sbin/kamailio[7411]: INFO: <script>: flagset {INVITE}
Jul  8 14:45:59 test /usr/sbin/kamailio[7411]: INFO: <script>: reply  {INVITE}
Jul  8 14:45:59 test /usr/sbin/kamailio[7412]: INFO: <script>: Contact is {sip:65kfrpn0@jb2ebovsk5vl.invalid;transport=ws}
Jul  8 14:45:59 test /usr/sbin/kamailio[7412]: INFO: <script>: Request going to WS
Jul  8 14:45:59 test /usr/sbin/kamailio[7412]: INFO: <script>: destination {sip:2.2.2.2:50600} to asterisk
Jul  8 14:45:59 test /usr/sbin/kamailio[7412]: INFO: <script>: [1054@2.2.2.2:50600]{ACK} Call from Media-Server Cluster
Jul  8 14:45:59 test /usr/sbin/kamailio[7412]: INFO: <script>: SQL query return {sip:4.4.4.4:63381;transport=WS} for {mycompany.device-1901}
Jul  8 14:45:59 test /usr/sbin/kamailio[7412]: INFO: <script>: Destination URI is {sip:4.4.4.4:63381;transport=WS} for {mycompany.device-1901}
Jul  8 14:45:59 test /usr/sbin/kamailio[7423]: INFO: <script>: SIP request received on 4443
Jul  8 14:45:59 test /usr/sbin/kamailio[7423]: INFO: <script>: NATDECECT for {ACK}
Jul  8 14:45:59 test /usr/sbin/kamailio[7423]: ERROR: <script>: ==> duri=[<null>]
Jul  8 14:45:59 test /usr/sbin/kamailio[7423]: INFO: <script>: request {ACK}
Jul  8 14:45:59 test /usr/sbin/kamailio[7423]: INFO: <script>: flagset {ACK}
Jul  8 14:45:59 test /usr/sbin/kamailio[7423]: INFO: <script>: Contact is {0}
Jul  8 14:45:59 test /usr/sbin/kamailio[7423]: INFO: <script>: Request coming from WS
Jul  8 14:45:59 test /usr/sbin/kamailio[7423]: INFO: <script>: destination {0} to asterisk
Jul  8 14:45:59 test /usr/sbin/kamailio[7423]: INFO: <script>: [mycompany.device-1884@3.3.3.3:63439]{ACK} From Outside World to Asterisk Box sip:2.2.2.2:50600
Jul  8 14:45:59 test /usr/sbin/kamailio[7423]: INFO: <script>: Translate {ACK} to asterisk
Jul  8 14:45:59 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30719] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:45:59 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30718] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:45:59 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30718] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:45:59 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30719] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:00 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30718] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:00 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30719] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:01 test /usr/sbin/kamailio[7422]: INFO: <script>: SIP request received on 4443
Jul  8 14:46:01 test /usr/sbin/kamailio[7422]: INFO: <script>: NATDECECT for {REGISTER}
Jul  8 14:46:01 test /usr/sbin/kamailio[7422]: INFO: <script>: No Tag for {REGISTER}
Jul  8 14:46:01 test /usr/sbin/kamailio[7422]: INFO: <script>: gointg auth {REGISTER}
Jul  8 14:46:01 test /usr/sbin/kamailio[7422]: INFO: <script>: SIP request received on 4443
Jul  8 14:46:01 test /usr/sbin/kamailio[7422]: INFO: <script>: NATDECECT for {REGISTER}
Jul  8 14:46:01 test /usr/sbin/kamailio[7422]: INFO: <script>: No Tag for {REGISTER}
Jul  8 14:46:01 test /usr/sbin/kamailio[7422]: INFO: <script>: gointg auth {REGISTER}
Jul  8 14:46:01 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30718] DTLS: Peer certificate accepted
Jul  8 14:46:01 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30719] DTLS: Peer certificate accepted
Jul  8 14:46:01 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30718] DTLS-SRTP successfully negotiated
Jul  8 14:46:01 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30719] DTLS-SRTP successfully negotiated
Jul  8 14:46:01 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30718] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:01 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30719] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:02 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30718] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:02 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30719] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:03 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30718] Confirmed peer address as 3.3.3.3:59288
Jul  8 14:46:03 test rtpengine[16835]: [1b6fc6a73a35f52d00cdbeca34246128@2.2.2.2:50600 port 30722] Confirmed peer address as 2.2.2.2:14162
Jul  8 14:46:03 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30718] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:03 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30719] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:03 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30719] Confirmed peer address as 3.3.3.3:59288
Jul  8 14:46:04 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30718] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:04 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30719] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:05 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30718] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:05 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30719] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:06 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30718] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:06 test rtpengine[16835]: [1b6fc6a73a35f52d00cdbeca34246128@2.2.2.2:50600 port 30723] Confirmed peer address as 2.2.2.2:14163
Jul  8 14:46:06 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30717] Confirmed peer address as 2.2.2.2:15967
Jul  8 14:46:06 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30719] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:07 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30718] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:07 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30719] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:08 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30718] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:08 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30719] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:09 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30718] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:09 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30719] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:10 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30718] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:10 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30719] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:11 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30718] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:11 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30719] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:12 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30718] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:12 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30719] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:13 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30718] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:13 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30719] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:14 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30718] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:14 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30719] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:14 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30718] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:14 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30719] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:14 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30718] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:15 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30719] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:15 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30718] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:15 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30719] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:15 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30718] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:15 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30719] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:16 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30718] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:16 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30719] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:16 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30718] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:16 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30719] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:17 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30718] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:17 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30719] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:17 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30718] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:17 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30719] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:18 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30718] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:18 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30719] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:18 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30718] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:18 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30719] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:19 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30718] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:19 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30719] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:19 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30718] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:19 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30719] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:20 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30718] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:20 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30719] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:20 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30718] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:20 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29 port 30719] Successful STUN binding request from 3.3.3.3:59288
Jul  8 14:46:21 test /usr/sbin/kamailio[7424]: INFO: <script>: SIP request received on 4443
Jul  8 14:46:21 test /usr/sbin/kamailio[7424]: INFO: <script>: NATDECECT for {BYE}
Jul  8 14:46:21 test /usr/sbin/kamailio[7424]: ERROR: <script>: ==> duri=[<null>]
Jul  8 14:46:21 test /usr/sbin/kamailio[7424]: INFO: <script>: Contact is {0}
Jul  8 14:46:21 test /usr/sbin/kamailio[7424]: INFO: <script>: Request coming from WS
Jul  8 14:46:21 test rtpengine[16835]: Got valid command from 127.0.0.1:56429: delete - { "ICE": "remove", "transport-protocol": "RTP/AVP", "call-id": "f4vpj2kb6ih0ajferu29", "received-from": [ "IP4", "3.3.3.3" ], "from-tag": "cnhud9704o", "command": "delete" }
Jul  8 14:46:21 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29] Deleting full call
Jul  8 14:46:21 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29] Final packet stats:
Jul  8 14:46:21 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29] --- Tag 'as73beca6d', created 0:36 ago, in dialogue with 'cnhud9704o'
Jul  8 14:46:21 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29] ------ Media #1, port 30718 <>   3.3.3.3:59288, 1013 p, 172316 b, 0 e
Jul  8 14:46:21 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29] ------ Media #1, port 30719 <>   3.3.3.3:59288 (RTCP), 33 p, 3344 b, 0 e
Jul  8 14:46:21 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29] --- Tag 'cnhud9704o', created 0:36 ago, in dialogue with 'as73beca6d'
Jul  8 14:46:21 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29] ------ Media #1, port 30716 <>  2.2.2.2:15966, 0 p, 0 b, 0 e
Jul  8 14:46:21 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29] ------ Media #1, port 30717 <>  2.2.2.2:15967 (RTCP), 3 p, 174 b, 0 e
Jul  8 14:46:21 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29] Returning to SIP proxy: d7:createdi1404845145e11:last signali1404845159e4:tagsd10:cnhud9704od3:tag10:cnhud9704o7:createdi1404845145e16:in dialogue with10:as73beca6d6:mediasld5:indexi1e4:type5:audio8:protocol7:RTP/AVP7:streamsld10:local porti30716e8:endpointd6:family4:IPv47:address14:2.2.2.24:porti15966ee19:advertised endpointd6:family4:IPv47:address14:2.2.2.24:porti15966ee11:last packeti1404845145e5:flagsl3:RTP6:fillede5:statsd7:packetsi0e5:bytesi0e6:errorsi0eeed10:local porti30717e8:endpointd6:family4:IPv47:address14:2.2.2.24:porti15967ee19:advertised endpointd6:family4:IPv47:address14:2.2.2.24:porti15967ee11:last packeti1404845176e5:flagsl4:RTCP6:filled9:confirmed10:kernelized17:no kernel supporte5:statsd7:packetsi3e5:bytesi174e6:errorsi0eeee5:flagsl11:initializedeeee10:as73beca6dd3:tag10:as73beca6d7:createdi1404845145e16:in dialogue with10:cnhud9704o6:mediasld5:indexi1e4:type5:audio8:protocol9:RTP/SAVPF7:streamsld10:local porti30718e8:endpointd6:family4:IPv47:address13:3.3.3.34:porti59288ee19:advertised endpointd6:family4:IPv47:address12:192.168.56.14:porti59286ee12:crypto suite23:AES_CM_128_HMAC_SHA1_3211:last packeti1404845181e5:flagsl3:RTP6:filled9:confirmede5:statsd7:packetsi1013e5:bytesi172316e6:errorsi0eeed10:local porti30719e8:endpointd6:family4:IPv47:address13:3.3.3.34:porti59288ee19:advertised endpointd6:family4:IPv67:address2:::4:porti0ee12:crypto suite23:AES_CM_128_HMAC_SHA1_8011:last packeti1404845181e5:flagsl4:RTCP6:filled9:confirmed10:kernelized17:no kernel supporte5:statsd7:packetsi33e5:bytesi3344e6:errorsi0eeee5:flagsl11:initialized9:DTLS-SRTP3:ICEeeeee6:totalsd3:RTPd7:packetsi1013e5:bytesi172316e6:errorsi0ee4:RTCPd7:packetsi36e5:bytesi3518e6:errorsi0eee6:result2:oke
Jul  8 14:46:21 test /usr/sbin/kamailio[7424]: INFO: <script>: destination {0} to asterisk
Jul  8 14:46:21 test /usr/sbin/kamailio[7424]: INFO: <script>: [mycompany.device-1884@3.3.3.3:63439]{BYE} From Outside World to Asterisk Box sip:2.2.2.2:50600
Jul  8 14:46:21 test /usr/sbin/kamailio[7424]: INFO: <script>: Translate {BYE} to asterisk
Jul  8 14:46:21 test /usr/sbin/kamailio[7414]: INFO: <script>: WS Reply from softphone: 200
Jul  8 14:46:21 test rtpengine[16835]: Got valid command from 127.0.0.1:59348: delete - { "ICE": "force", "transport-protocol": "RTP/SAVPF", "call-id": "f4vpj2kb6ih0ajferu29", "received-from": [ "IP4", "2.2.2.2" ], "from-tag": "as73beca6d", "to-tag": "cnhud9704o", "command": "delete" }
Jul  8 14:46:21 test rtpengine[16835]: [f4vpj2kb6ih0ajferu29] Call-ID to delete not found
Jul  8 14:46:21 test rtpengine[16835]: Returning to SIP proxy: d7:warning38:Call-ID not found or tags didn't match6:result2:oke
Jul  8 14:46:21 test /usr/sbin/kamailio[7414]: INFO: <script>: flagset {BYE}
Jul  8 14:46:21 test /usr/sbin/kamailio[7414]: INFO: <script>: reply  {BYE}
Jul  8 14:46:21 test /usr/sbin/kamailio[7411]: INFO: <script>: SIP request received on 5060
Jul  8 14:46:21 test /usr/sbin/kamailio[7411]: INFO: <script>: NATDECECT for {BYE}
Jul  8 14:46:21 test /usr/sbin/kamailio[7411]: ERROR: <script>: ==> duri=[<null>]
Jul  8 14:46:21 test /usr/sbin/kamailio[7411]: INFO: <script>: Contact is {sip:65kfrpn0@jb2ebovsk5vl.invalid;transport=ws}
Jul  8 14:46:21 test /usr/sbin/kamailio[7411]: INFO: <script>: Request going to WS
Jul  8 14:46:21 test rtpengine[16835]: Got valid command from 127.0.0.1:48472: delete - { "ICE": "force", "transport-protocol": "RTP/SAVPF", "call-id": "1b6fc6a73a35f52d00cdbeca34246128@2.2.2.2:50600", "received-from": [ "IP4", "2.2.2.2" ], "from-tag": "as5d5be016", "command": "delete" }
Jul  8 14:46:21 test rtpengine[16835]: [1b6fc6a73a35f52d00cdbeca34246128@2.2.2.2:50600] Deleting full call
Jul  8 14:46:21 test rtpengine[16835]: [1b6fc6a73a35f52d00cdbeca34246128@2.2.2.2:50600] Final packet stats:
Jul  8 14:46:21 test rtpengine[16835]: [1b6fc6a73a35f52d00cdbeca34246128@2.2.2.2:50600] --- Tag 'lu5akkpnnv', created 0:36 ago, in dialogue with 'as5d5be016'
Jul  8 14:46:21 test rtpengine[16835]: [1b6fc6a73a35f52d00cdbeca34246128@2.2.2.2:50600] ------ Media #1, port 30722 <>  2.2.2.2:14162, 983 p, 178906 b, 0 e
Jul  8 14:46:21 test rtpengine[16835]: [1b6fc6a73a35f52d00cdbeca34246128@2.2.2.2:50600] ------ Media #1, port 30723 <>  2.2.2.2:14163 (RTCP), 3 p, 234 b, 0 e
Jul  8 14:46:21 test rtpengine[16835]: [1b6fc6a73a35f52d00cdbeca34246128@2.2.2.2:50600] --- Tag 'as5d5be016', created 0:36 ago, in dialogue with 'lu5akkpnnv'
Jul  8 14:46:21 test rtpengine[16835]: [1b6fc6a73a35f52d00cdbeca34246128@2.2.2.2:50600] ------ Media #1, port 30720 <>   192.168.1.138:58205, 0 p, 0 b, 0 e
Jul  8 14:46:21 test rtpengine[16835]: [1b6fc6a73a35f52d00cdbeca34246128@2.2.2.2:50600] ------ Media #1, port 30721 <>   192.168.1.138:58206 (RTCP), 0 p, 0 b, 0 e
Jul  8 14:46:21 test rtpengine[16835]: [1b6fc6a73a35f52d00cdbeca34246128@2.2.2.2:50600] Returning to SIP proxy: d7:createdi1404845145e11:last signali1404845159e4:tagsd10:as5d5be016d3:tag10:as5d5be0167:createdi1404845145e16:in dialogue with10:lu5akkpnnv6:mediasld5:indexi1e4:type5:audio8:protocol9:RTP/SAVPF7:streamsld10:local porti30720e8:endpointd6:family4:IPv47:address13:192.168.1.1384:porti58205ee19:advertised endpointd6:family4:IPv47:address13:192.168.1.1384:porti58205ee12:crypto suite23:AES_CM_128_HMAC_SHA1_8011:last packeti1404845145e5:flagsl3:RTP6:fillede5:statsd7:packetsi0e5:bytesi0e6:errorsi0eeed10:local porti30721e8:endpointd6:family4:IPv47:address13:192.168.1.1384:porti58206ee19:advertised endpointd6:family4:IPv47:address13:192.168.1.1384:porti58206ee12:crypto suite23:AES_CM_128_HMAC_SHA1_8011:last packeti1404845145e5:flagsl4:RTCP6:fillede5:statsd7:packetsi0e5:bytesi0e6:errorsi0eeee5:flagsl11:initialized9:DTLS-SRTP4:SDES3:ICEeeee10:lu5akkpnnvd3:tag10:lu5akkpnnv7:createdi1404845145e16:in dialogue with10:as5d5be0166:mediasld5:indexi1e4:type5:audio8:protocol7:RTP/AVP7:streamsld10:local porti30722e8:endpointd6:family4:IPv47:address14:2.2.2.24:porti14162ee19:advertised endpointd6:family4:IPv47:address14:2.2.2.24:porti14162ee11:last packeti1404845181e5:flagsl3:RTP6:filled9:confirmede5:statsd7:packetsi983e5:bytesi178906e6:errorsi0eeed10:local porti30723e8:endpointd6:family4:IPv47:address14:2.2.2.24:porti14163ee19:advertised endpointd6:family4:IPv47:address14:2.2.2.24:porti14163ee11:last packeti1404845176e5:flagsl4:RTCP6:filled9:confirmede5:statsd7:packetsi3e5:bytesi234e6:errorsi0eeee5:flagsl11:initializedeeeee6:totalsd3:RTPd7:packetsi983e5:bytesi178906e6:errorsi0ee4:RTCPd7:packetsi3e5:bytesi234e6:errorsi0eee6:result2:oke
Jul  8 14:46:21 test /usr/sbin/kamailio[7411]: INFO: <script>: destination {sip:2.2.2.2:50600} to asterisk
Jul  8 14:46:21 test /usr/sbin/kamailio[7411]: INFO: <script>: [1054@2.2.2.2:50600]{BYE} Call from Media-Server Cluster
Jul  8 14:46:21 test /usr/sbin/kamailio[7411]: INFO: <script>: SQL query return {sip:4.4.4.4:63381;transport=WS} for {mycompany.device-1901}
Jul  8 14:46:21 test /usr/sbin/kamailio[7411]: INFO: <script>: Destination URI is {sip:4.4.4.4:63381;transport=WS} for {mycompany.device-1901}
Jul  8 14:46:21 test /usr/sbin/kamailio[7425]: INFO: <script>: Reply from webrtc client: 200
Jul  8 14:46:21 test rtpengine[16835]: Got valid command from 127.0.0.1:51347: delete - { "ICE": "remove", "transport-protocol": "RTP/AVP", "call-id": "1b6fc6a73a35f52d00cdbeca34246128@2.2.2.2:50600", "received-from": [ "IP4", "4.4.4.4" ], "from-tag": "lu5akkpnnv", "to-tag": "as5d5be016", "command": "delete" }
Jul  8 14:46:21 test rtpengine[16835]: [1b6fc6a73a35f52d00cdbeca34246128@2.2.2.2:50600] Call-ID to delete not found
Jul  8 14:46:21 test rtpengine[16835]: Returning to SIP proxy: d7:warning38:Call-ID not found or tags didn't match6:result2:oke