<p>herein the debug trace:</p>
<p>17(3643) INFO: <script>: New message:<br>
INVITE sip:<a href="mailto:edi-2001@mydomain.com">edi-2001@mydomain.com</a> SIP/2.0<br>
Via: SIP/2.0/TCP 192.168.0.162:34348;branch=z9hG4bK.Mm9c9oajI;rport<br>
From: sip:edi-1@mydomain.com;tag=J8Qbs6r5C<br>
To: sip:<a href="mailto:edi-2001@mydomain.com">edi-2001@mydomain.com</a><br>
CSeq: 20 INVITE<br>
Call-ID: JRsgN1qwek<br>
Max-Forwards: 70<br>
Route: sip:195.206.195.66:5062;transport=tcp;lr<br>
Supported: replaces, outbound<br>
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO, UPDATE<br>
Content-Type: application/sdp<br>
Content-Length: 258<br>
Contact: sip:edi-1@218.118.243.20:52470;transport=tcp;+sip.instance="urn:uuid:dc62b3bd-0e31-41c1-a688-3f9b3cbbd170"<br>
User-Agent: LinphoneAndroid/3.2.7 (belle-sip/1.6.1)</p>
<p>v=0<br>
o=edi-1 1263 2377 IN IP4 192.168.0.162<br>
s=Talk<br>
c=IN IP4 192.168.0.162<br>
b=AS:380<br>
t=0 0<br>
a=rtcp-xr:rcvr-rtt=all:10000 stat-summary=loss,dup,jitt,TTL voip-metrics<br>
m=audio 7076 RTP/AVP 0 8 3 101<br>
a=rtpmap:101 telephone-event/8000<br>
a=rtcp-fb:* ccm tmmbr<br>
17(3643) DEBUG: [parser/parse_addr_spec.c:898]: parse_addr_spec(): end of header reached, state=9<br>
17(3643) DEBUG: [parser/msg_parser.c:190]: get_hdr_field(): DEBUG: get_hdr_field: [32]; uri=[sip:<a href="mailto:edi-2001@mydomain.com">edi-2001@mydomain.com</a>]<br>
17(3643) DEBUG: [parser/msg_parser.c:192]: get_hdr_field(): DEBUG: to body [sip:<a href="mailto:edi-2001@mydomain.com">edi-2001@mydomain.com</a><br>
]<br>
17(3643) DEBUG: [parser/msg_parser.c:170]: get_hdr_field(): get_hdr_field: cseq : <20> <br>
17(3643) DEBUG: maxfwd [mf_funcs.c:85]: is_maxfwd_present(): value = 70<br>
17(3643) DEBUG: [parser/msg_parser.c:204]: get_hdr_field(): DEBUG: get_hdr_body : content_length=258<br>
17(3643) DEBUG: [parser/msg_parser.c:106]: get_hdr_field(): found end of header<br>
17(3643) DEBUG: [parser/parse_addr_spec.c:176]: parse_to_param(): DEBUG: add_param: tag=J8Qbs6r5C<br>
17(3643) DEBUG: [parser/parse_addr_spec.c:898]: parse_addr_spec(): end of header reached, state=29<br>
17(3643) DEBUG: sanity [mod_sanity.c:255]: w_sanity_check(): sanity checks result: 1<br>
17(3643) DEBUG: siputils [checks.c:103]: has_totag(): no totag<br>
17(3643) DEBUG: tm [t_lookup.c:1072]: t_check_msg(): DEBUG: t_check_msg: msg id=1 global id=0 T start=0xffffffffffffffff<br>
17(3643) DEBUG: tm [t_lookup.c:527]: t_lookup_request(): t_lookup_request: start searching: hash=63038, isACK=0<br>
17(3643) DEBUG: tm [t_lookup.c:485]: matching_3261(): DEBUG: RFC3261 transaction matching failed<br>
17(3643) DEBUG: tm [t_lookup.c:709]: t_lookup_request(): DEBUG: t_lookup_request: no transaction found<br>
17(3643) DEBUG: tm [t_lookup.c:1141]: t_check_msg(): DEBUG: t_check_msg: msg id=1 global id=1 T end=(nil)<br>
17(3643) DEBUG: outbound [ob_mod.c:496]: use_outbound(): Analysing INVITE for outbound markers<br>
17(3643) DEBUG: [socket_info.c:583]: grep_sock_info(): grep_sock_info - checking if host==us: 14==9 && [195.206.195.66] == [127.0.0.1]<br>
17(3643) DEBUG: [socket_info.c:587]: grep_sock_info(): grep_sock_info - checking if port 5060 (advertise 0) matches port 5062<br>
17(3643) DEBUG: [socket_info.c:583]: grep_sock_info(): grep_sock_info - checking if host==us: 14==10 && [195.206.195.66] == [10.42.0.11]<br>
17(3643) DEBUG: [socket_info.c:587]: grep_sock_info(): grep_sock_info - checking if port 5060 (advertise 0) matches port 5062<br>
17(3643) DEBUG: [socket_info.c:583]: grep_sock_info(): grep_sock_info - checking if host==us: 14==9 && [195.206.195.66] == [127.0.0.1]<br>
17(3643) DEBUG: [socket_info.c:587]: grep_sock_info(): grep_sock_info - checking if port 5060 (advertise 0) matches port 5062<br>
17(3643) DEBUG: [socket_info.c:583]: grep_sock_info(): grep_sock_info - checking if host==us: 14==10 && [195.206.195.66] == [10.42.0.11]<br>
17(3643) DEBUG: [socket_info.c:587]: grep_sock_info(): grep_sock_info - checking if port 5060 (advertise 0) matches port 5062<br>
17(3643) DEBUG: [forward.c:448]: check_self(): check_self: host != me<br>
17(3643) DEBUG: outbound [ob_mod.c:378]: use_outbound_non_reg(): top Route-URI is not me - outbound not used<br>
17(3643) ERROR: <script>: 3. =============================================><br>
17(3643) DEBUG: [select.c:429]: run_select(): Calling SELECT 0x7f8fedeae7b8<br>
17(3643) INFO: <script>: if 218.118.243.20 == 10.42.0.70?<br>
17(3643) DEBUG: [select.c:429]: run_select(): Calling SELECT 0x7f8fedeae7b8<br>
17(3643) INFO: <script>: Method (INVITE) ==> from Peer<br>
17(3643) INFO: <script>: Route from peer<br>
17(3643) DEBUG: dispatcher [dispatch.c:1664]: ds_select_dst_limit(): set [1]<br>
17(3643) DEBUG: dispatcher [dispatch.c:1772]: ds_select_dst_limit(): alg hash [2334507456]<br>
17(3643) DEBUG: dispatcher [dispatch.c:1815]: ds_select_dst_limit(): selected [0-1/0] sip:10.42.0.70:5060;transport=TCP<br>
17(3643) INFO: <script>: Relay message to sip:edi-2001@mydomain.com via sip:10.42.0.70:5060;transport=TCP<br>
17(3643) DEBUG: tm [t_lookup.c:1373]: t_newtran(): DEBUG: t_newtran: msg id=1 , global msg id=1 , T on entrance=(nil)<br>
17(3643) DEBUG: tm [t_lookup.c:527]: t_lookup_request(): t_lookup_request: start searching: hash=63038, isACK=0<br>
17(3643) DEBUG: tm [t_lookup.c:485]: matching_3261(): DEBUG: RFC3261 transaction matching failed<br>
17(3643) DEBUG: tm [t_lookup.c:709]: t_lookup_request(): DEBUG: t_lookup_request: no transaction found<br>
17(3643) DEBUG: tm [t_hooks.c:380]: run_reqin_callbacks_internal(): DBG: trans=0x7f8fe11b1a80, callback type 1, id 0 entered<br>
17(3643) DEBUG: [md5utils.c:67]: MD5StringArray(): DEBUG: MD5 calculated: 435a550d1fcde96f6297d49dd19084f2<br>
17(3643) DEBUG: tm [t_funcs.c:347]: t_relay_to(): SER: new INVITE<br>
17(3643) DEBUG: [mem/shm_mem.c:111]: _shm_resize(): WARNING:vqm_resize: resize(0) called<br>
17(3643) DEBUG: [tcp_main.c:2281]: tcpconn_send_put(): tcp_send: send from reader (3643 (17)), reusing fd<br>
17(3643) DEBUG: [tcp_main.c:2516]: tcpconn_do_send(): tcp_send: sending...<br>
17(3643) DEBUG: [tcp_main.c:2550]: tcpconn_do_send(): tcp_send: after real write: c= 0x7f8fe119b3e8 n=535 fd=12<br>
17(3643) DEBUG: [tcp_main.c:2551]: tcpconn_do_send(): tcp_send: buf=<br>
SIP/2.0 100 trying -- your call is important to us<br>
Via: SIP/2.0/TCP 192.168.0.162:34348;branch=z9hG4bK.Mm9c9oajI;rport=52470;received=218.118.243.20<br>
From: sip:edi-1@mydomain.com;tag=J8Qbs6r5C<br>
To: sip:<a href="mailto:edi-2001@mydomain.com">edi-2001@mydomain.com</a><br>
CSeq: 20 INVITE<br>
Call-ID: JRsgN1qwek<br>
Server: kamailio (4.2.3 (x86_64/linux))<br>
Content-Length: 0<br>
Warning: 392 10.42.0.11:5060 "Noisy feedback tells: pid=3643 req_src_ip=218.118.243.20 req_src_port=52470 in_uri=sip:<a href="mailto:edi-2001@mydomain.com">edi-2001@mydomain.com</a> out_uri=sip:<a href="mailto:edi-2001@mydomain.com">edi-2001@mydomain.com</a> via_cnt==1"</p>
<p>17(3643) DEBUG: tm [t_reply.c:728]: _reply_light(): DEBUG: reply sent out. buf=0x7f8fede9a1d8: SIP/2.0 100 trying -..., shmem=0x7f8fe11b1190: SIP/2.0 100 trying -<br>
17(3643) DEBUG: tm [t_reply.c:738]: _reply_light(): DEBUG: _reply_light: finished<br>
17(3643) INFO: <script>: FIRST LEG======>>>>>>>new branch [0] to sip:<a href="mailto:edi-2001@mydomain.com">edi-2001@mydomain.com</a><br>
17(3643) DEBUG: siputils [checks.c:103]: has_totag(): no totag<br>
17(3643) DEBUG: [select.c:429]: run_select(): Calling SELECT 0x7f8fedeae7b8<br>
17(3643) INFO: <script>: if 218.118.243.20 == 10.42.0.70?<br>
17(3643) DEBUG: [select.c:429]: run_select(): Calling SELECT 0x7f8fedeae7b8<br>
17(3643) INFO: <script>: Method (INVITE) ==> from Peer<br>
17(3643) DEBUG: [parser/sdp/sdp_helpr_funcs.c:504]: extract_mediaip(): located IP address [192.168.0.162] in <code>o=' field 17(3643) DEBUG: <core> [parser/sdp/sdp_helpr_funcs.c:504]: extract_mediaip(): located IP address [192.168.0.162] in</code>c=' field<br>
17(3643) DEBUG: [parser/sdp/sdp.c:574]: parse_sdp_session(): ignoring unknown type in a= line: `a=rtcp-fb:* ccm tmmbr<br>
'<br>
17(3643) DEBUG: rtpproxy [rtpproxy_funcs.c:148]: check_content_type(): type <application/sdp> found valid<br>
17(3643) DEBUG: rtpproxy [rtpproxy.c:2704]: force_rtp_proxy(): proxy reply: 10862 195.206.195.66</p>
<p>17(3643) DEBUG: siputils [checks.c:103]: has_totag(): no totag<br>
17(3643) DEBUG: [msg_translator.c:470]: clen_builder(): clen_builder: content-length: 279 (279)<br>
17(3643) DEBUG: [msg_translator.c:2893]: create_via_hf(): create_via_hf: id added: <;i=1>, rcv proto=2<br>
17(3643) DEBUG: [tcp_main.c:2297]: tcpconn_send_put(): tcp_send: tcp connection found (0x7f8fe11a2938), acquiring fd<br>
17(3643) DEBUG: [tcp_main.c:2307]: tcpconn_send_put(): tcp_send, c= 0x7f8fe11a2938, n=16<br>
18(3644) DEBUG: [tcp_main.c:3565]: handle_ser_child(): handle_ser_child: read response= 7f8fe11a2938, 2, fd -1 from 17 (3643)<br>
17(3643) DEBUG: [tcp_main.c:2337]: tcpconn_send_put(): tcp_send: after receive_fd: c= 0x7f8fe11a2938 n=8 fd=13<br>
17(3643) DEBUG: [tcp_main.c:2516]: tcpconn_do_send(): tcp_send: sending...<br>
17(3643) DEBUG: [tcp_main.c:2550]: tcpconn_do_send(): tcp_send: after real write: c= 0x7f8fe11a2938 n=1169 fd=13<br>
17(3643) DEBUG: [tcp_main.c:2551]: tcpconn_do_send(): tcp_send: buf=<br>
INVITE sip:<a href="mailto:edi-2001@mydomain.com">edi-2001@mydomain.com</a> SIP/2.0<br>
Record-Route: sip:10.42.0.11;transport=tcp;lr=on;ftag=J8Qbs6r5C;nat=yes<br>
Via: SIP/2.0/TCP 195.206.195.66:5062;branch=z9hG4bKe36f.435a550d1fcde96f6297d49dd19084f2.0;i=1<br>
Via: SIP/2.0/TCP 192.168.0.162:34348;received=218.118.243.20;branch=z9hG4bK.Mm9c9oajI;rport=52470<br>
From: sip:edi-1@mydomain.com;tag=J8Qbs6r5C<br>
To: sip:<a href="mailto:edi-2001@mydomain.com">edi-2001@mydomain.com</a><br>
CSeq: 20 INVITE<br>
Call-ID: JRsgN1qwek<br>
Contact: sip:edi-2001@10.42.0.11:5060;transport=TCP<br>
Max-Forwards: 69<br>
Supported: replaces, outbound<br>
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO, UPDATE<br>
Content-Type: application/sdp<br>
Content-Length: 279<br>
sip:edi-1@218.118.243.20:52470;transport=tcpUser-Agent: LinphoneAndroid/3.2.7 (belle-sip/1.6.1)<br>
Path: sip:195.206.195.66:5062;transport=tcp;lr;received=sip:218.118.243.20:52470%3Btransport%3Dtcp</p>
<p>v=0<br>
o=edi-1 1263 2377 IN IP4 195.206.195.66<br>
s=Talk<br>
c=IN IP4 195.206.195.66<br>
b=AS:380<br>
t=0 0<br>
a=rtcp-xr:rcvr-rtt=all:10000 stat-summary=loss,dup,jitt,TTL voip-metrics<br>
m=audio 10862 RTP/AVP 0 8 3 101<br>
a=rtpmap:101 telephone-event/8000<br>
a=rtcp-fb:* ccm tmmbr<br>
a=nortpproxy:yes</p>
<p style="font-size:small;-webkit-text-size-adjust:none;color:#666;">—<br />You are receiving this because you are subscribed to this thread.<br />Reply to this email directly, <a href="https://github.com/kamailio/kamailio/issues/1257#issuecomment-333592693">view it on GitHub</a>, or <a href="https://github.com/notifications/unsubscribe-auth/AF36ZY0DE8wThOEtGS3bFdnlQ4iHtSeWks5soRMygaJpZM4Povjo">mute the thread</a>.<img alt="" height="1" src="https://github.com/notifications/beacon/AF36ZYpLvVryrxdxekEXxznWdQ-FEvOBks5soRMygaJpZM4Povjo.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/issues/1257#issuecomment-333592693"></link>
<meta itemprop="name" content="View Issue"></meta>
</div>
<meta itemprop="description" content="View this Issue on GitHub"></meta>
</div>
<script type="application/json" data-scope="inboxmarkup">{"api_version":"1.0","publisher":{"api_key":"05dde50f1d1a384dd78767c55493e4bb","name":"GitHub"},"entity":{"external_key":"github/kamailio/kamailio","title":"kamailio/kamailio","subtitle":"GitHub repository","main_image_url":"https://cloud.githubusercontent.com/assets/143418/17495839/a5054eac-5d88-11e6-95fc-7290892c7bb5.png","avatar_image_url":"https://cloud.githubusercontent.com/assets/143418/15842166/7c72db34-2c0b-11e6-9aed-b52498112777.png","action":{"name":"Open in GitHub","url":"https://github.com/kamailio/kamailio"}},"updates":{"snippets":[{"icon":"PERSON","message":"@defeden in #1257: herein the debug trace:\r\n\r\n17(3643) INFO: \u003cscript\u003e: New message:\r\n INVITE sip:edi-2001@mydomain.com SIP/2.0\r\nVia: SIP/2.0/TCP 192.168.0.162:34348;branch=z9hG4bK.Mm9c9oajI;rport\r\nFrom: \u003csip:edi-1@mydomain.com\u003e;tag=J8Qbs6r5C\r\nTo: sip:edi-2001@mydomain.com\r\nCSeq: 20 INVITE\r\nCall-ID: JRsgN1qwek\r\nMax-Forwards: 70\r\nRoute: \u003csip:195.206.195.66:5062;transport=tcp;lr\u003e\r\nSupported: replaces, outbound\r\nAllow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO, UPDATE\r\nContent-Type: application/sdp\r\nContent-Length: 258\r\nContact: \u003csip:edi-1@218.118.243.20:52470;transport=tcp\u003e;+sip.instance=\"\u003curn:uuid:dc62b3bd-0e31-41c1-a688-3f9b3cbbd170\u003e\"\r\nUser-Agent: LinphoneAndroid/3.2.7 (belle-sip/1.6.1)\r\n\r\nv=0\r\no=edi-1 1263 2377 IN IP4 192.168.0.162\r\ns=Talk\r\nc=IN IP4 192.168.0.162\r\nb=AS:380\r\nt=0 0\r\na=rtcp-xr:rcvr-rtt=all:10000 stat-summary=loss,dup,jitt,TTL voip-metrics\r\nm=audio 7076 RTP/AVP 0 8 3 101\r\na=rtpmap:101 telephone-event/8000\r\na=rtcp-fb:* ccm tmmbr\r\n17(3643) DEBUG: \u003ccore\u003e [parser/parse_addr_spec.c:898]: parse_addr_spec(): end of header reached, state=9\r\n17(3643) DEBUG: \u003ccore\u003e [parser/msg_parser.c:190]: get_hdr_field(): DEBUG: get_hdr_field: \u003cTo\u003e [32]; uri=[sip:edi-2001@mydomain.com] \r\n17(3643) DEBUG: \u003ccore\u003e [parser/msg_parser.c:192]: get_hdr_field(): DEBUG: to body [sip:edi-2001@mydomain.com\r\n]\r\n17(3643) DEBUG: \u003ccore\u003e [parser/msg_parser.c:170]: get_hdr_field(): get_hdr_field: cseq \u003cCSeq\u003e: \u003c20\u003e \u003cINVITE\u003e\r\n17(3643) DEBUG: maxfwd [mf_funcs.c:85]: is_maxfwd_present(): value = 70 \r\n17(3643) DEBUG: \u003ccore\u003e [parser/msg_parser.c:204]: get_hdr_field(): DEBUG: get_hdr_body : content_length=258\r\n17(3643) DEBUG: \u003ccore\u003e [parser/msg_parser.c:106]: get_hdr_field(): found end of header\r\n17(3643) DEBUG: \u003ccore\u003e [parser/parse_addr_spec.c:176]: parse_to_param(): DEBUG: add_param: tag=J8Qbs6r5C\r\n17(3643) DEBUG: \u003ccore\u003e [parser/parse_addr_spec.c:898]: parse_addr_spec(): end of header reached, state=29\r\n17(3643) DEBUG: sanity [mod_sanity.c:255]: w_sanity_check(): sanity checks result: 1\r\n17(3643) DEBUG: siputils [checks.c:103]: has_totag(): no totag\r\n17(3643) DEBUG: tm [t_lookup.c:1072]: t_check_msg(): DEBUG: t_check_msg: msg id=1 global id=0 T start=0xffffffffffffffff\r\n17(3643) DEBUG: tm [t_lookup.c:527]: t_lookup_request(): t_lookup_request: start searching: hash=63038, isACK=0\r\n17(3643) DEBUG: tm [t_lookup.c:485]: matching_3261(): DEBUG: RFC3261 transaction matching failed\r\n17(3643) DEBUG: tm [t_lookup.c:709]: t_lookup_request(): DEBUG: t_lookup_request: no transaction found\r\n17(3643) DEBUG: tm [t_lookup.c:1141]: t_check_msg(): DEBUG: t_check_msg: msg id=1 global id=1 T end=(nil)\r\n17(3643) DEBUG: outbound [ob_mod.c:496]: use_outbound(): Analysing INVITE for outbound markers\r\n17(3643) DEBUG: \u003ccore\u003e [socket_info.c:583]: grep_sock_info(): grep_sock_info - checking if host==us: 14==9 \u0026\u0026 [195.206.195.66] == [127.0.0.1]\r\n17(3643) DEBUG: \u003ccore\u003e [socket_info.c:587]: grep_sock_info(): grep_sock_info - checking if port 5060 (advertise 0) matches port 5062\r\n17(3643) DEBUG: \u003ccore\u003e [socket_info.c:583]: grep_sock_info(): grep_sock_info - checking if host==us: 14==10 \u0026\u0026 [195.206.195.66] == [10.42.0.11]\r\n17(3643) DEBUG: \u003ccore\u003e [socket_info.c:587]: grep_sock_info(): grep_sock_info - checking if port 5060 (advertise 0) matches port 5062\r\n17(3643) DEBUG: \u003ccore\u003e [socket_info.c:583]: grep_sock_info(): grep_sock_info - checking if host==us: 14==9 \u0026\u0026 [195.206.195.66] == [127.0.0.1]\r\n17(3643) DEBUG: \u003ccore\u003e [socket_info.c:587]: grep_sock_info(): grep_sock_info - checking if port 5060 (advertise 0) matches port 5062\r\n17(3643) DEBUG: \u003ccore\u003e [socket_info.c:583]: grep_sock_info(): grep_sock_info - checking if host==us: 14==10 \u0026\u0026 [195.206.195.66] == [10.42.0.11]\r\n17(3643) DEBUG: \u003ccore\u003e [socket_info.c:587]: grep_sock_info(): grep_sock_info - checking if port 5060 (advertise 0) matches port 5062\r\n17(3643) DEBUG: \u003ccore\u003e [forward.c:448]: check_self(): check_self: host != me\r\n17(3643) DEBUG: outbound [ob_mod.c:378]: use_outbound_non_reg(): top Route-URI is not me - outbound not used\r\n17(3643) ERROR: \u003cscript\u003e: 3. =============================================\u003e\r\n17(3643) DEBUG: \u003ccore\u003e [select.c:429]: run_select(): Calling SELECT 0x7f8fedeae7b8 \r\n17(3643) INFO: \u003cscript\u003e: if 218.118.243.20 == 10.42.0.70?\r\n17(3643) DEBUG: \u003ccore\u003e [select.c:429]: run_select(): Calling SELECT 0x7f8fedeae7b8 \r\n17(3643) INFO: \u003cscript\u003e: Method (INVITE) ==\u003e from Peer\r\n17(3643) INFO: \u003cscript\u003e: Route from peer\r\n17(3643) DEBUG: dispatcher [dispatch.c:1664]: ds_select_dst_limit(): set [1]\r\n17(3643) DEBUG: dispatcher [dispatch.c:1772]: ds_select_dst_limit(): alg hash [2334507456]\r\n17(3643) DEBUG: dispatcher [dispatch.c:1815]: ds_select_dst_limit(): selected [0-1/0] \u003csip:10.42.0.70:5060;transport=TCP\u003e\r\n17(3643) INFO: \u003cscript\u003e: Relay message to \u003csip:edi-2001@mydomain.com\u003e via \u003csip:10.42.0.70:5060;transport=TCP\u003e\r\n17(3643) DEBUG: tm [t_lookup.c:1373]: t_newtran(): DEBUG: t_newtran: msg id=1 , global msg id=1 , T on entrance=(nil)\r\n17(3643) DEBUG: tm [t_lookup.c:527]: t_lookup_request(): t_lookup_request: start searching: hash=63038, isACK=0\r\n17(3643) DEBUG: tm [t_lookup.c:485]: matching_3261(): DEBUG: RFC3261 transaction matching failed\r\n17(3643) DEBUG: tm [t_lookup.c:709]: t_lookup_request(): DEBUG: t_lookup_request: no transaction found\r\n17(3643) DEBUG: tm [t_hooks.c:380]: run_reqin_callbacks_internal(): DBG: trans=0x7f8fe11b1a80, callback type 1, id 0 entered\r\n17(3643) DEBUG: \u003ccore\u003e [md5utils.c:67]: MD5StringArray(): DEBUG: MD5 calculated: 435a550d1fcde96f6297d49dd19084f2\r\n17(3643) DEBUG: tm [t_funcs.c:347]: t_relay_to(): SER: new INVITE\r\n17(3643) DEBUG: \u003ccore\u003e [mem/shm_mem.c:111]: _shm_resize(): WARNING:vqm_resize: resize(0) called\r\n17(3643) DEBUG: \u003ccore\u003e [tcp_main.c:2281]: tcpconn_send_put(): tcp_send: send from reader (3643 (17)), reusing fd\r\n17(3643) DEBUG: \u003ccore\u003e [tcp_main.c:2516]: tcpconn_do_send(): tcp_send: sending...\r\n17(3643) DEBUG: \u003ccore\u003e [tcp_main.c:2550]: tcpconn_do_send(): tcp_send: after real write: c= 0x7f8fe119b3e8 n=535 fd=12\r\n17(3643) DEBUG: \u003ccore\u003e [tcp_main.c:2551]: tcpconn_do_send(): tcp_send: buf=\r\nSIP/2.0 100 trying -- your call is important to us\r\nVia: SIP/2.0/TCP 192.168.0.162:34348;branch=z9hG4bK.Mm9c9oajI;rport=52470;received=218.118.243.20\r\nFrom: \u003csip:edi-1@mydomain.com\u003e;tag=J8Qbs6r5C\r\nTo: sip:edi-2001@mydomain.com\r\nCSeq: 20 INVITE\r\nCall-ID: JRsgN1qwek\r\nServer: kamailio (4.2.3 (x86_64/linux))\r\nContent-Length: 0\r\nWarning: 392 10.42.0.11:5060 \"Noisy feedback tells: pid=3643 req_src_ip=218.118.243.20 req_src_port=52470 in_uri=sip:edi-2001@mydomain.com out_uri=sip:edi-2001@mydomain.com via_cnt==1\"\r\n\r\n\r\n17(3643) DEBUG: tm [t_reply.c:728]: _reply_light(): DEBUG: reply sent out. buf=0x7f8fede9a1d8: SIP/2.0 100 trying -..., shmem=0x7f8fe11b1190: SIP/2.0 100 trying -\r\n17(3643) DEBUG: tm [t_reply.c:738]: _reply_light(): DEBUG: _reply_light: finished\r\n17(3643) INFO: \u003cscript\u003e: FIRST LEG======\u003e\u003e\u003e\u003e\u003e\u003e\u003enew branch [0] to sip:edi-2001@mydomain.com\r\n17(3643) DEBUG: siputils [checks.c:103]: has_totag(): no totag\r\n17(3643) DEBUG: \u003ccore\u003e [select.c:429]: run_select(): Calling SELECT 0x7f8fedeae7b8 \r\n17(3643) INFO: \u003cscript\u003e: if 218.118.243.20 == 10.42.0.70?\r\n17(3643) DEBUG: \u003ccore\u003e [select.c:429]: run_select(): Calling SELECT 0x7f8fedeae7b8 \r\n17(3643) INFO: \u003cscript\u003e: Method (INVITE) ==\u003e from Peer\r\n17(3643) DEBUG: \u003ccore\u003e [parser/sdp/sdp_helpr_funcs.c:504]: extract_mediaip(): located IP address [192.168.0.162] in `o=' field\r\n17(3643) DEBUG: \u003ccore\u003e [parser/sdp/sdp_helpr_funcs.c:504]: extract_mediaip(): located IP address [192.168.0.162] in `c=' field\r\n17(3643) DEBUG: \u003ccore\u003e [parser/sdp/sdp.c:574]: parse_sdp_session(): ignoring unknown type in a= line: `a=rtcp-fb:* ccm tmmbr\r\n'\r\n17(3643) DEBUG: rtpproxy [rtpproxy_funcs.c:148]: check_content_type(): type \u003capplication/sdp\u003e found valid\r\n17(3643) DEBUG: rtpproxy [rtpproxy.c:2704]: force_rtp_proxy(): proxy reply: 10862 195.206.195.66\r\n\r\n17(3643) DEBUG: siputils [checks.c:103]: has_totag(): no totag\r\n17(3643) DEBUG: \u003ccore\u003e [msg_translator.c:470]: clen_builder(): clen_builder: content-length: 279 (279)\r\n17(3643) DEBUG: \u003ccore\u003e [msg_translator.c:2893]: create_via_hf(): create_via_hf: id added: \u003c;i=1\u003e, rcv proto=2\r\n17(3643) DEBUG: \u003ccore\u003e [tcp_main.c:2297]: tcpconn_send_put(): tcp_send: tcp connection found (0x7f8fe11a2938), acquiring fd\r\n17(3643) DEBUG: \u003ccore\u003e [tcp_main.c:2307]: tcpconn_send_put(): tcp_send, c= 0x7f8fe11a2938, n=16\r\n18(3644) DEBUG: \u003ccore\u003e [tcp_main.c:3565]: handle_ser_child(): handle_ser_child: read response= 7f8fe11a2938, 2, fd -1 from 17 (3643)\r\n17(3643) DEBUG: \u003ccore\u003e [tcp_main.c:2337]: tcpconn_send_put(): tcp_send: after receive_fd: c= 0x7f8fe11a2938 n=8 fd=13\r\n17(3643) DEBUG: \u003ccore\u003e [tcp_main.c:2516]: tcpconn_do_send(): tcp_send: sending...\r\n17(3643) DEBUG: \u003ccore\u003e [tcp_main.c:2550]: tcpconn_do_send(): tcp_send: after real write: c= 0x7f8fe11a2938 n=1169 fd=13\r\n17(3643) DEBUG: \u003ccore\u003e [tcp_main.c:2551]: tcpconn_do_send(): tcp_send: buf=\r\nINVITE sip:edi-2001@mydomain.com SIP/2.0\r\nRecord-Route: \u003csip:10.42.0.11;transport=tcp;lr=on;ftag=J8Qbs6r5C;nat=yes\u003e\r\nVia: SIP/2.0/TCP 195.206.195.66:5062;branch=z9hG4bKe36f.435a550d1fcde96f6297d49dd19084f2.0;i=1\r\nVia: SIP/2.0/TCP 192.168.0.162:34348;received=218.118.243.20;branch=z9hG4bK.Mm9c9oajI;rport=52470\r\nFrom: \u003csip:edi-1@mydomain.com\u003e;tag=J8Qbs6r5C\r\nTo: sip:edi-2001@mydomain.com\r\nCSeq: 20 INVITE\r\nCall-ID: JRsgN1qwek\r\nContact: \u003csip:edi-2001@10.42.0.11:5060;transport=TCP\u003e\r\nMax-Forwards: 69\r\nSupported: replaces, outbound\r\nAllow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO, UPDATE\r\nContent-Type: application/sdp\r\nContent-Length: 279\r\nsip:edi-1@218.118.243.20:52470;transport=tcpUser-Agent: LinphoneAndroid/3.2.7 (belle-sip/1.6.1)\r\nPath: \u003csip:195.206.195.66:5062;transport=tcp;lr;received=sip:218.118.243.20:52470%3Btransport%3Dtcp\u003e\r\n\r\nv=0\r\no=edi-1 1263 2377 IN IP4 195.206.195.66\r\ns=Talk\r\nc=IN IP4 195.206.195.66\r\nb=AS:380\r\nt=0 0\r\na=rtcp-xr:rcvr-rtt=all:10000 stat-summary=loss,dup,jitt,TTL voip-metrics\r\nm=audio 10862 RTP/AVP 0 8 3 101\r\na=rtpmap:101 telephone-event/8000\r\na=rtcp-fb:* ccm tmmbr\r\na=nortpproxy:yes"}],"action":{"name":"View Issue","url":"https://github.com/kamailio/kamailio/issues/1257#issuecomment-333592693"}}}</script>