Stefan Mititelu writes:<br>
<br>
> @juha-h can you try a basic call with DBG mode enable?<br>
> You should see a log like "rtpengine hash table lookup *find* ..." for the rtpengine_delete(); no corner case scenarios can happen now.<br>
<br>
Thanks. I tried by setting rtpengine-deamon log level to 7 and basic<br>
call looked fine (below).  Do you still want me to try with DBG mode<br>
enabled in sip proxy?<br>
<br>
-- Juha<br>
<br>
Feb  9 21:42:20 lohi rtpengine[8740]: [7d8ec027d2946082] Received command 'offer' from 127.0.0.1:49451<br>
Feb  9 21:42:20 lohi rtpengine[8740]: [7d8ec027d2946082] Dump for 'offer' from 127.0.0.1:49451: { "sdp": "v=0#015#012o=- 2334591646 33598050 IN IP4 192.168.43.192#015#012s=-#015#012c=IN IP4 192.168.43.192#015#012t=0 0#015#012a=tool:baresip 0.4.17#015#012m=audio 10048 RTP/AVP 96 97 0 8 101#015#012b=AS:128#015#012a=rtpmap:96 opus/48000/2#015#012a=fmtp:96 stereo=1;sprop-stereo=1;maxaveragebitrate=28000#015#012a=rtpmap:97 speex/8000#015#012a=fmtp:97 mode="3";vbr=off;cng=on#015#012a=rtpmap:0 PCMU/8000#015#012a=rtpmap:8 PCMA/8000#015#012a=rtpmap:101 telephone-event/8000#015#012a=fmtp:101 0-15#015#012a=sendrecv#015#012a=label:1#015#012a=rtcp-rsize#015#012a=ssrc:16163482 ...<br>
Feb  9 21:42:20 lohi rtpengine[8740]: [7d8ec027d2946082] ... 40 cname:sip:test@test.tutpro.com#015#012a=ptime:20#015#012", "ICE": "force", "replace": [ "session-connection", "origin" ], "rtcp-mux": [ "demux" ], "call-id": "7d8ec027d2946082", "via-branch": "z9hG4bK57e0626a25057f600", "received-from": [ "IP4", "192.98.102.10" ], "from-tag": "f689633ed9bd0645", "command": "offer" }<br>
Feb  9 21:42:20 lohi rtpengine[8740]: [7d8ec027d2946082] Creating new call<br>
Feb  9 21:42:20 lohi rtpengine[8740]: [7d8ec027d2946082] set FILLED flag for stream 192.168.43.192:10048<br>
Feb  9 21:42:20 lohi rtpengine[8740]: [7d8ec027d2946082] set FILLED flag for stream 192.168.43.192:10049<br>
Feb  9 21:42:20 lohi rtpengine[8740]: [7d8ec027d2946082] Replying to 'offer' from 127.0.0.1:49451<br>
Feb  9 21:42:20 lohi rtpengine[8740]: [7d8ec027d2946082] Response dump for 'offer' to 127.0.0.1:49451: { "sdp": "v=0#015#012o=- 2334591646 33598050 IN IP4 192.98.102.10#015#012s=-#015#012c=IN IP4 192.98.102.10#015#012t=0 0#015#012a=tool:baresip 0.4.17#015#012m=audio 50166 RTP/AVP 96 97 0 8 101#015#012b=AS:128#015#012a=rtpmap:96 opus/48000/2#015#012a=fmtp:96 stereo=1;sprop-stereo=1;maxaveragebitrate=28000#015#012a=rtpmap:97 speex/8000#015#012a=fmtp:97 mode="3";vbr=off;cng=on#015#012a=rtpmap:0 PCMU/8000#015#012a=rtpmap:8 PCMA/8000#015#012a=rtpmap:101 telephone-event/8000#015#012a=fmtp:101 0-15#015#012a=label:1#015#012a=rtcp-rsize#015#012a=ssrc:1616348240 cnam ...<br>
Feb  9 21:42:20 lohi rtpengine[8740]: [7d8ec027d2946082] ... e:sip:test@test.tutpro.com#015#012a=ptime:20#015#012a=sendrecv#015#012a=rtcp:50167#015#012a=ice-ufrag:5SR7PDNn#015#012a=ice-pwd:VfSLqwyH9CdXbfpQTZSRHDmKve#015#012a=candidate:mUYmXd5Zbyf38MFb 1 UDP 2130706431 192.98.102.10 50166 typ host#015#012a=candidate:mUYmXd5Zbyf38MFb 2 UDP 2130706430 192.98.102.10 50167 typ host#015#012", "result": "ok" }<br>
Feb  9 21:42:24 lohi rtpengine[8740]: [7d8ec027d2946082] Received command 'answer' from 127.0.0.1:43744<br>
Feb  9 21:42:24 lohi rtpengine[8740]: [7d8ec027d2946082] Dump for 'answer' from 127.0.0.1:43744: { "sdp": "v=0#015#012o=- 1380191758 160992788 IN IP4 192.168.43.192#015#012s=-#015#012c=IN IP4 192.168.43.192#015#012t=0 0#015#012a=tool:baresip 0.4.17#015#012m=audio 10490 RTP/AVP 96 97 0 8 101#015#012b=AS:128#015#012a=rtpmap:96 opus/48000/2#015#012a=fmtp:96 stereo=1;sprop-stereo=1;maxaveragebitrate=38000#015#012a=rtpmap:97 speex/8000#015#012a=fmtp:97 mode="3";vbr=off;cng=on#015#012a=rtpmap:0 PCMU/8000#015#012a=rtpmap:8 PCMA/8000#015#012a=rtpmap:101 telephone-event/8000#015#012a=fmtp:101 0-15#015#012a=sendrecv#015#012a=label:1#015#012a=rtcp-rsize#015#012a=ssrc:844455 ...<br>
Feb  9 21:42:24 lohi rtpengine[8740]: [7d8ec027d2946082] ... 395 cname:sip:jh@test.tutpro.com#015#012a=ptime:20#015#012", "ICE": "force", "replace": [ "session-connection", "origin" ], "call-id": "7d8ec027d2946082", "via-branch": "z9hG4bK57e0626a25057f600", "received-from": [ "IP4", "192.98.102.10" ], "from-tag": "f689633ed9bd0645", "to-tag": "24962b8b5e9563f0", "command": "answer" }<br>
Feb  9 21:42:24 lohi rtpengine[8740]: [7d8ec027d2946082] set FILLED flag for stream 192.168.43.192:10490<br>
Feb  9 21:42:24 lohi rtpengine[8740]: [7d8ec027d2946082] set FILLED flag for stream 192.168.43.192:10491<br>
Feb  9 21:42:24 lohi rtpengine[8740]: [7d8ec027d2946082] Shutting down ICE agent (nothing to do)<br>
Feb  9 21:42:24 lohi rtpengine[8740]: [7d8ec027d2946082] Replying to 'answer' from 127.0.0.1:43744<br>
Feb  9 21:42:24 lohi rtpengine[8740]: [7d8ec027d2946082] Response dump for 'answer' to 127.0.0.1:43744: { "sdp": "v=0#015#012o=- 1380191758 160992788 IN IP4 192.98.102.10#015#012s=-#015#012c=IN IP4 192.98.102.10#015#012t=0 0#015#012a=tool:baresip 0.4.17#015#012m=audio 50184 RTP/AVP 96 97 0 8 101#015#012b=AS:128#015#012a=rtpmap:96 opus/48000/2#015#012a=fmtp:96 stereo=1;sprop-stereo=1;maxaveragebitrate=38000#015#012a=rtpmap:97 speex/8000#015#012a=fmtp:97 mode="3";vbr=off;cng=on#015#012a=rtpmap:0 PCMU/8000#015#012a=rtpmap:8 PCMA/8000#015#012a=rtpmap:101 telephone-event/8000#015#012a=fmtp:101 0-15#015#012a=label:1#015#012a=rtcp-rsize#015#012a=ssrc:844455395 cna ...<br>
Feb  9 21:42:24 lohi rtpengine[8740]: [7d8ec027d2946082] ... me:sip:jh@test.tutpro.com#015#012a=ptime:20#015#012a=sendrecv#015#012a=rtcp:50185#015#012a=candidate:mUYmXd5Zbyf38MFb 1 UDP 2130706431 192.98.102.10 50184 typ host#015#012a=candidate:mUYmXd5Zbyf38MFb 2 UDP 2130706430 192.98.102.10 50185 typ host#015#012", "result": "ok" }<br>
Feb  9 21:42:27 lohi /usr/bin/sip-proxy[13530]: INFO: ===== rtpengine_delete()<br>
Feb  9 21:42:27 lohi rtpengine[8740]: [7d8ec027d2946082] Received command 'delete' from 127.0.0.1:43744<br>
Feb  9 21:42:27 lohi rtpengine[8740]: [7d8ec027d2946082] Dump for 'delete' from 127.0.0.1:43744: { "call-id": "7d8ec027d2946082", "received-from": [ "IP4", "192.98.102.10" ], "from-tag": "24962b8b5e9563f0", "command": "delete" }<br>
Feb  9 21:42:27 lohi rtpengine[8740]: [7d8ec027d2946082] Scheduling deletion of call branch '24962b8b5e9563f0' (via-branch '') in 30 seconds<br>
Feb  9 21:42:27 lohi rtpengine[8740]: [7d8ec027d2946082] Replying to 'delete' from 127.0.0.1:43744<br>
Feb  9 21:42:27 lohi rtpengine[8740]: [7d8ec027d2946082] Response dump for 'delete' to 127.0.0.1:43744: { "created": 1455046940, "last signal": 1455046944, "tags": { "24962b8b5e9563f0": { "tag": "24962b8b5e9563f0", "via-branch": "z9hG4bK57e0626a25057f600", "created": 1455046940, "in dialogue with": "f689633ed9bd0645", "medias": [ { "index": 1, "type": "audio", "protocol": "RTP/AVP", "streams": [ { "local port": 50166, "endpoint": { "family": "IPv4", "address": "192.98.102.10", "port": 10490 }, "advertised endpoint": { "family": "IPv4", "address": "192 ...<br>


<p style="font-size:small;-webkit-text-size-adjust:none;color:#666;">—<br>Reply to this email directly or <a href="https://github.com/kamailio/kamailio/pull/505#issuecomment-182030839">view it on GitHub</a>.<img alt="" height="1" src="https://github.com/notifications/beacon/AF36ZRyn75bM0jCCaVsbG2atY__TM9tCks5pijpzgaJpZM4HWZN8.gif" width="1" /></p>
<div itemscope itemtype="http://schema.org/EmailMessage">
<div itemprop="action" itemscope itemtype="http://schema.org/ViewAction">
  <link itemprop="url" href="https://github.com/kamailio/kamailio/pull/505#issuecomment-182030839"></link>
  <meta itemprop="name" content="View Pull Request"></meta>
</div>
<meta itemprop="description" content="View this Pull Request on GitHub"></meta>
</div>