Sorry for late question will it also be applied for the case when bye is receives in dlg state 2 results in Critical log ?
FYI: Its discussed here http://lists.opensips.org/pipermail/users/2012-March/020890.html On Mon, Aug 3, 2015 at 11:33 PM, Trevor Steyn <[email protected]> wrote: > Thanks for the Info Vlad I will update. > > Regards > Trevor Steyn > > > On 03/08/2015 16:41, Vlad Paiu wrote: > > Hello, > > > > Please update your OpenSIPS sources. There was a recent bug fix which > > addresses this issue - see > > > https://github.com/OpenSIPS/opensips/commit/d171b7aaa47a23481a1e374ca58305d1898511a6 > > > > Best Regards, > > > > Vlad Paiu > > OpenSIPS Developer > > http://www.opensips-solutions.com > > > > On 03.08.2015 16:52, Trevor Steyn wrote: > >> Anyone have any ideas? > >> > >> On 28/07/2015 11:01, Trevor Steyn wrote: > >>> Hi Guys, > >>> > >>> I seem to be having some trouble with the new topology_hiding module in > >>> opensips 2.1 > >>> > >>> here is the call scenario > >>> > >>> UAC --> Opensips --> UAS > >>> > >>> UAC Sends Invite to UAS with topology hiding module > >>> UAS sends 180 with to-tag > >>> UAC sends BYE > >>> > >>> When the Bye is sent opensips loops the call till max forwards is > >>> reached > >>> > >>> from what i can see from the debugs the Bye from UAC is accepted and > >>> matches the topology_hiding_match function but does not rewrite the > >>> destination IP so when the message passes t_relay() its sending the Bye > >>> to Itself from Itself. > >>> > >>> I have tried this without topology hiding and the BYE is relayed as it > >>> should > >>> . > >>> > >>> My route looks as follows > >>> > >>> > >>> route{ > >>> script_trace( 3, "$rm from $si, ruri=$ru", "me"); > >>> > >>> if (!mf_process_maxfwd_header("10")) { > >>> sl_send_reply("483","Too Many Hops"); > >>> exit; > >>> } > >>> > >>> if ( check_source_address("1","$avp(trunk_attrs)") ) { > >>> # request comes from trunks > >>> setflag(IS_TRUNK); > >>> } else if ( is_from_gw() ) { > >>> # request comes from GWs > >>> } else { > >>> # send_reply("403","Forbidden"); > >>> xlog("Message is not from Trunk or GW $si"); > >>> # exit; > >>> } > >>> > >>> if (has_totag()) { > >>> # sequential request withing a dialog should > >>> # take the path determined by record-routing > >>> #if (loose_route()) { > >>> if(topology_hiding_match()) { > >>> # validate the sequential request against > >>> dialog > >>> if ( $DLG_status!=NULL && !validate_dialog() ) { > >>> xlog("In-Dialog $rm from $si (callid=$ci) is not valid > >>> according to dialog\n"); > >>> ## exit; > >>> } > >>> if (is_method("BYE")) { > >>> setflag(ACC_DO); # do accounting ... > >>> setflag(ACC_FAILED); # ... even if the transaction > >>> fails > >>> } else if (is_method("INVITE")) { > >>> # even if in most of the cases is useless, do RR for > >>> # re-INVITEs alos, as some buggy clients do change > >>> route set > >>> # during the dialog. > >>> record_route(); > >>> } > >>> > >>> # lets handle re-invites and offer proxy > >>> if (has_body("application/sdp")) { > >>> # Begin rtp session update gyrations > >>> if (method == "INVITE") { > >>> # INVITE w/ SDP, so early neg > >>> # This is offer, reply is answer > >>> rtpproxy_offer("iewlz20"); > >>> t_on_reply("1"); > >>> } else if (method == "ACK") { > >>> # ACK w/ SDP, so late neg (done now) > >>> # This is answer > >>> rtpproxy_answer("iewlz20"); > >>> } > >>> } > >>> > >>> ............. > >>> > >>> if (is_method("INVITE")) { > >>> force_send_socket(udp:XXX.XXX.XXX.XXX:5060); > >>> #rtpproxy_engage('ierz20'); > >>> topology_hiding(); > >>> } > >>> > >>> if (has_body("application/sdp")) { > >>> if (rtpproxy_offer('iewz20')) { > >>> t_on_reply("1"); > >>> } else { > >>> t_on_reply("2"); > >>> } > >>> } > >>> > >>> > >>> route(RELAY); > >>> } > >>> > >>> > >>> route[RELAY] { > >>> if (!t_relay()) { > >>> sl_reply_error(); > >>> }; > >>> exit; > >>> } > >>> > >>> > >>> > >>> > >>> > >>> > >>> Debug below > >>> > >>> > >>> [Script Trace][/etc/opensips/opensips.cfg:176][me][core if] -> (BYE > >>> from > >>> 10.10.16.1, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> [Script Trace][/etc/opensips/opensips.cfg:171][me][module > >>> mf_process_maxfwd_header] -> (BYE from 10.10.16.1, > >>> ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> Jul 23 16:01:16 [22780] DBG:core:parse_headers: flags=100 > >>> Jul 23 16:01:16 [22780] DBG:core:parse_to_param: tag=6pou4pvn6xe2phuk.i > >>> Jul 23 16:01:16 [22780] DBG:core:parse_to: end of header reached, > >>> state=29 > >>> Jul 23 16:01:16 [22780] DBG:core:parse_to: display={}, > >>> ruri={sip:[email protected]:5060;user=phone} > >>> Jul 23 16:01:16 [22780] DBG:core:get_hdr_field: <To> [70]; > >>> uri=[sip:[email protected]:5060;user=phone] > >>> Jul 23 16:01:16 [22780] DBG:core:get_hdr_field: to body > >>> [<sip:[email protected]:5060;user=phone>] > >>> Jul 23 16:01:16 [22780] DBG:core:get_hdr_field: cseq <CSeq>: <2> <BYE> > >>> Jul 23 16:01:16 [22780] DBG:maxfwd:is_maxfwd_present: value = 67 > >>> [Script Trace][/etc/opensips/opensips.cfg:185][me][core if] -> (BYE > >>> from > >>> 10.10.16.1, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> [Script Trace][/etc/opensips/opensips.cfg:176][me][module > >>> check_source_address] -> (BYE from 10.10.16.1, > >>> ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> Jul 23 16:01:16 [22780] DBG:permissions:check_src_addr_3: Looking for : > >>> <1, 10.10.16.1, 5060, 1> in tables > >>> Jul 23 16:01:16 [22780] DBG:permissions:hash_match: no pattern to match > >>> Jul 23 16:01:16 [22780] DBG:permissions:hash_match: match found in the > >>> hash table > >>> [Script Trace][/etc/opensips/opensips.cfg:178][me][core setflag] -> > >>> (BYE > >>> from 10.10.16.1, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> [Script Trace][/etc/opensips/opensips.cfg:248][me][core if] -> (BYE > >>> from > >>> 10.10.16.1, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> [Script Trace][/etc/opensips/opensips.cfg:187][me][module has_totag] -> > >>> (BYE from 10.10.16.1, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> Jul 23 16:01:16 [22780] DBG:uri:has_totag: totag found > >>> [Script Trace][/etc/opensips/opensips.cfg:242][me][core if] -> (BYE > >>> from > >>> 10.10.16.1, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> [Script Trace][/etc/opensips/opensips.cfg:191][me][module > >>> topology_hiding_match] -> (BYE from 10.10.16.1, > >>> ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> Jul 23 16:01:16 [22780] DBG:core:parse_headers: flags=200 > >>> Jul 23 16:01:16 [22780] DBG:core:get_hdr_field: content_length=0 > >>> Jul 23 16:01:16 [22780] DBG:core:get_hdr_field: found end of header > >>> Jul 23 16:01:16 [22780] DBG:core:grep_sock_info: checking if host==us: > >>> 13==13 && [10.10.16.2] == [10.10.16.2] > >>> Jul 23 16:01:16 [22780] DBG:core:grep_sock_info: checking if port 5060 > >>> matches port 5060 > >>> Jul 23 16:01:16 [22780] DBG:dialog:w_match_dialog: We found DID > >>> param in > >>> R-URI with value of dbf.d239f4f3 > >>> Jul 23 16:01:16 [22780] DBG:dialog:dlg_onroute: route param is > >>> 'dbf.d239f4f3' (len=12) > >>> Jul 23 16:01:16 [22780] DBG:dialog:lookup_dlg: ref dlg 0x7f81e1b3c2f8 > >>> with 1 -> 4 > >>> Jul 23 16:01:16 [22780] DBG:dialog:lookup_dlg: dialog id=1062179629 > >>> found on entry 4029 > >>> Jul 23 16:01:16 [22780] DBG:core:parse_headers: flags=58 > >>> Jul 23 16:01:16 [22780] DBG:core:parse_to_param: > >>> tag=SDl3i7c02-55B0F3A1-1DDB4E1-0ADE2C1B > >>> Jul 23 16:01:16 [22780] DBG:core:parse_to: end of header reached, > >>> state=29 > >>> Jul 23 16:01:16 [22780] DBG:core:parse_to: display={}, > >>> ruri={sip:[email protected];user=phone} > >>> Jul 23 16:01:16 [22780] DBG:dialog:next_state_dlg: dialog > >>> 0x7f81e1b3c2f8 > >>> changed from state 2 to state 2, due event 7 > >>> [Script Trace][/etc/opensips/opensips.cfg:199][me][core if] -> (BYE > >>> from > >>> 10.10.16.1, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> [Script Trace][/etc/opensips/opensips.cfg:194][me][module > >>> validate_dialog] -> (BYE from 10.10.16.1, > >>> ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> Jul 23 16:01:16 [22780] DBG:dialog:dlg_validate_dialog: CSEQ validation > >>> passed > >>> [Script Trace][/etc/opensips/opensips.cfg:210][me][core if] -> (BYE > >>> from > >>> 10.10.16.1, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> [Script Trace][/etc/opensips/opensips.cfg:199][me][module is_method] -> > >>> (BYE from 10.10.16.1, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> [Script Trace][/etc/opensips/opensips.cfg:200][me][core setflag] -> > >>> (BYE > >>> from 10.10.16.1, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> [Script Trace][/etc/opensips/opensips.cfg:201][me][core setflag] -> > >>> (BYE > >>> from 10.10.16.1, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> [Script Trace][/etc/opensips/opensips.cfg:227][me][core if] -> (BYE > >>> from > >>> 10.10.16.1, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> [Script Trace][/etc/opensips/opensips.cfg:210][me][module has_body] -> > >>> (BYE from 10.10.16.1, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> Jul 23 16:01:16 [22780] DBG:sipmsgops:has_body_f: content length is > >>> zero > >>> [Script Trace][/etc/opensips/opensips.cfg:227][me][route RELAY] -> (BYE > >>> from 10.10.16.1, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> [Script Trace][/etc/opensips/opensips.cfg:340][me][core if] -> (BYE > >>> from > >>> 10.10.16.1, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> [Script Trace][/etc/opensips/opensips.cfg:338][me][module t_relay] -> > >>> (BYE from 10.10.16.1, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> Jul 23 16:01:16 [22780] DBG:tm:t_newtran: transaction on > >>> entrance=0xffffffffffffffff > >>> Jul 23 16:01:16 [22780] DBG:core:parse_headers: flags=ffffffffffffffff > >>> Jul 23 16:01:16 [22780] DBG:core:parse_headers: flags=78 > >>> Jul 23 16:01:16 [22780] DBG:tm:t_lookup_request: start searching: > >>> hash=40946, isACK=0 > >>> Jul 23 16:01:16 [22780] DBG:tm:matching_3261: RFC3261 transaction > >>> matching failed > >>> Jul 23 16:01:16 [22780] DBG:tm:t_lookup_request: no transaction found > >>> Jul 23 16:01:16 [22780] DBG:tm:run_reqin_callbacks: > >>> trans=0x7f81e1b41548, callback type 1, id 1 entered > >>> Jul 23 16:01:16 [22780] DBG:core:parse_headers: flags=78 > >>> Jul 23 16:01:16 [22780] DBG:tm:run_reqin_callbacks: > >>> trans=0x7f81e1b41548, callback type 1, id 0 entered > >>> Jul 23 16:01:16 [22780] DBG:dialog:ref_dlg: ref dlg 0x7f81e1b3c2f8 with > >>> 1 -> 5 > >>> Jul 23 16:01:16 [22780] DBG:core:mk_proxy: doing DNS lookup... > >>> Jul 23 16:01:16 [22780] DBG:core:check_ip_address: params 10.10.16.1, > >>> 10.10.16.1, 0 > >>> Jul 23 16:01:16 [22780] DBG:tm:set_timer: relative timeout is 500000 > >>> Jul 23 16:01:16 [22780] DBG:tm:insert_timer_unsafe: [4]: 0x7f81e1b41768 > >>> (15800000) > >>> Jul 23 16:01:16 [22780] DBG:tm:insert_timer_unsafe: [0]: > >>> 0x7f81e1b41798 (20) > >>> Jul 23 16:01:16 [22780] DBG:tm:t_relay_to: new transaction fwd'ed > >>> [Script Trace][/etc/opensips/opensips.cfg:341][me][core exit] -> (BYE > >>> from 10.10.16.1, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> Jul 23 16:01:16 [22780] DBG:tm:t_unref: UNREF_UNSAFE: [0x7f81e1b41548] > >>> after is 0 > >>> Jul 23 16:01:16 [22780] DBG:dialog:unref_dlg: unref dlg 0x7f81e1b3c2f8 > >>> with 1 -> 4 in entry 0x7f81e1b35838 > >>> Jul 23 16:01:16 [22780] DBG:core:destroy_avp_list: destroying list > >>> (nil) > >>> Jul 23 16:01:16 [22780] DBG:core:receive_msg: cleaning up > >>> Jul 23 16:01:16 [22780] DBG:core:parse_msg: SIP Request: > >>> Jul 23 16:01:16 [22780] DBG:core:parse_msg: method: <BYE> > >>> Jul 23 16:01:16 [22780] DBG:core:parse_msg: uri: > >>> <sip:10.10.16.2;did=dbf.d239f4f3> > >>> Jul 23 16:01:16 [22780] DBG:core:parse_msg: version: <SIP/2.0> > >>> Jul 23 16:01:16 [22780] DBG:core:parse_headers: flags=2 > >>> Jul 23 16:01:16 [22780] DBG:core:parse_via_param: found param type 232, > >>> <branch> = <z9hG4bK2ff9.7dfac551.0>; state=16 > >>> Jul 23 16:01:16 [22780] DBG:core:parse_via: end of header reached, > >>> state=5 > >>> Jul 23 16:01:16 [22780] DBG:core:parse_headers: via found, flags=2 > >>> Jul 23 16:01:16 [22780] DBG:core:parse_headers: this is the first via > >>> Jul 23 16:01:16 [22780] DBG:core:receive_msg: After parse_msg... > >>> Jul 23 16:01:16 [22780] DBG:core:receive_msg: preparing to run routing > >>> scripts... > >>> [Script Trace][/etc/opensips/opensips.cfg:176][me][core if] -> (BYE > >>> from > >>> 10.10.16.2, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> [Script Trace][/etc/opensips/opensips.cfg:171][me][module > >>> mf_process_maxfwd_header] -> (BYE from 10.10.16.2, > >>> ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> Jul 23 16:01:16 [22780] DBG:core:parse_headers: flags=100 > >>> Jul 23 16:01:16 [22780] DBG:core:parse_via_param: found param type 232, > >>> <branch> = <z9hG4bK53eneb00a89gqfc5m0o0.1>; state=16 > >>> Jul 23 16:01:16 [22780] DBG:core:parse_via: end of header reached, > >>> state=5 > >>> Jul 23 16:01:16 [22780] DBG:core:parse_headers: via found, flags=100 > >>> Jul 23 16:01:16 [22780] DBG:core:parse_headers: parse_headers: this is > >>> the second via > >>> Jul 23 16:01:16 [22780] DBG:core:parse_to_param: tag=6pou4pvn6xe2phuk.i > >>> Jul 23 16:01:16 [22780] DBG:core:parse_to: end of header reached, > >>> state=29 > >>> Jul 23 16:01:16 [22780] DBG:core:parse_to: display={}, > >>> ruri={sip:[email protected]:5060;user=phone} > >>> Jul 23 16:01:16 [22780] DBG:core:get_hdr_field: <To> [70]; > >>> uri=[sip:[email protected]:5060;user=phone] > >>> Jul 23 16:01:16 [22780] DBG:core:get_hdr_field: to body > >>> [<sip:[email protected]:5060;user=phone>] > >>> Jul 23 16:01:16 [22780] DBG:core:get_hdr_field: cseq <CSeq>: <2> <BYE> > >>> Jul 23 16:01:16 [22780] DBG:maxfwd:is_maxfwd_present: value = 66 > >>> [Script Trace][/etc/opensips/opensips.cfg:185][me][core if] -> (BYE > >>> from > >>> 10.10.16.2, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> [Script Trace][/etc/opensips/opensips.cfg:176][me][module > >>> check_source_address] -> (BYE from 10.10.16.2, > >>> ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> Jul 23 16:01:16 [22780] DBG:permissions:check_src_addr_3: Looking for : > >>> <1, 10.10.16.2, 5060, 1> in tables > >>> Jul 23 16:01:16 [22780] DBG:permissions:hash_match: no match in the > >>> hash > >>> table > >>> Jul 23 16:01:16 [22780] DBG:permissions:match_subnet_table: subnet > >>> table > >>> is empty > >>> [Script Trace][/etc/opensips/opensips.cfg:185][me][core if] -> (BYE > >>> from > >>> 10.10.16.2, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> [Script Trace][/etc/opensips/opensips.cfg:179][me][module > >>> is_from_gw] -> > >>> (BYE from 10.10.16.2, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> [Script Trace][/etc/opensips/opensips.cfg:183][me][core xlog] -> (BYE > >>> from 10.10.16.2, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> Jul 23 16:01:16 [22780] DBG:core:buf_init: initializing... > >>> Message is not from Trunk or GW 10.10.16.2[Script > >>> Trace][/etc/opensips/opensips.cfg:248][me][core if] -> (BYE from > >>> 10.10.16.2, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> [Script Trace][/etc/opensips/opensips.cfg:187][me][module has_totag] -> > >>> (BYE from 10.10.16.2, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> Jul 23 16:01:16 [22780] DBG:uri:has_totag: totag found > >>> [Script Trace][/etc/opensips/opensips.cfg:242][me][core if] -> (BYE > >>> from > >>> 10.10.16.2, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> [Script Trace][/etc/opensips/opensips.cfg:191][me][module > >>> topology_hiding_match] -> (BYE from 10.10.16.2, > >>> ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> Jul 23 16:01:16 [22780] DBG:core:parse_headers: flags=200 > >>> Jul 23 16:01:16 [22780] DBG:core:get_hdr_field: content_length=0 > >>> Jul 23 16:01:16 [22780] DBG:core:get_hdr_field: found end of header > >>> Jul 23 16:01:16 [22780] DBG:core:grep_sock_info: checking if host==us: > >>> 13==13 && [10.10.16.2] == [10.10.16.2] > >>> Jul 23 16:01:16 [22780] DBG:core:grep_sock_info: checking if port 5060 > >>> matches port 5060 > >>> Jul 23 16:01:16 [22780] DBG:dialog:w_match_dialog: We found DID > >>> param in > >>> R-URI with value of dbf.d239f4f3 > >>> Jul 23 16:01:16 [22780] DBG:dialog:dlg_onroute: route param is > >>> 'dbf.d239f4f3' (len=12) > >>> Jul 23 16:01:16 [22780] DBG:dialog:lookup_dlg: ref dlg 0x7f81e1b3c2f8 > >>> with 1 -> 5 > >>> Jul 23 16:01:16 [22780] DBG:dialog:lookup_dlg: dialog id=1062179629 > >>> found on entry 4029 > >>> Jul 23 16:01:16 [22780] DBG:core:parse_headers: flags=58 > >>> Jul 23 16:01:16 [22780] DBG:core:parse_to_param: > >>> tag=SDl3i7c02-55B0F3A1-1DDB4E1-0ADE2C1B > >>> Jul 23 16:01:16 [22780] DBG:core:parse_to: end of header reached, > >>> state=29 > >>> Jul 23 16:01:16 [22780] DBG:core:parse_to: display={}, > >>> ruri={sip:[email protected];user=phone} > >>> Jul 23 16:01:16 [22780] DBG:dialog:next_state_dlg: dialog > >>> 0x7f81e1b3c2f8 > >>> changed from state 2 to state 2, due event 7 > >>> [Script Trace][/etc/opensips/opensips.cfg:199][me][core if] -> (BYE > >>> from > >>> 10.10.16.2, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> Trevor > >>> [Script Trace][/etc/opensips/opensips.cfg:194][me][module > >>> validate_dialog] -> (BYE from 10.10.16.2, > >>> ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> Jul 23 16:01:16 [22780] DBG:dialog:dlg_validate_dialog: CSEQ validation > >>> passed > >>> [Script Trace][/etc/opensips/opensips.cfg:210][me][core if] -> (BYE > >>> from > >>> 10.10.16.2, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> [Script Trace][/etc/opensips/opensips.cfg:199][me][module is_method] -> > >>> (BYE from 10.10.16.2, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> [Script Trace][/etc/opensips/opensips.cfg:200][me][core setflag] -> > >>> (BYE > >>> from 10.10.16.2, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> [Script Trace][/etc/opensips/opensips.cfg:201][me][core setflag] -> > >>> (BYE > >>> from 10.10.16.2, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> [Script Trace][/etc/opensips/opensips.cfg:227][me][core if] -> (BYE > >>> from > >>> 10.10.16.2, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> [Script Trace][/etc/opensips/opensips.cfg:210][me][module has_body] -> > >>> (BYE from 10.10.16.2, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> Jul 23 16:01:16 [22780] DBG:sipmsgops:has_body_f: content length is > >>> zero > >>> [Script Trace][/etc/opensips/opensips.cfg:227][me][route RELAY] -> (BYE > >>> from 10.10.16.2, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> [Script Trace][/etc/opensips/opensips.cfg:340][me][core if] -> (BYE > >>> from > >>> 10.10.16.2, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> [Script Trace][/etc/opensips/opensips.cfg:338][me][module t_relay] -> > >>> (BYE from 10.10.16.2, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> Jul 23 16:01:16 [22780] DBG:tm:t_newtran: transaction on > >>> entrance=0xffffffffffffffff > >>> Jul 23 16:01:16 [22780] DBG:core:parse_headers: flags=ffffffffffffffff > >>> Jul 23 16:01:16 [22780] DBG:core:parse_headers: flags=78 > >>> Jul 23 16:01:16 [22780] DBG:tm:t_lookup_request: start searching: > >>> hash=40946, isACK=0 > >>> Jul 23 16:01:16 [22780] DBG:tm:matching_3261: RFC3261 transaction > >>> matching failed > >>> Jul 23 16:01:16 [22780] DBG:tm:t_lookup_request: no transaction found > >>> Jul 23 16:01:16 [22780] DBG:tm:run_reqin_callbacks: > >>> trans=0x7f81e1b446a0, callback type 1, id 1 entered > >>> Jul 23 16:01:16 [22780] DBG:core:parse_headers: flags=78 > >>> Jul 23 16:01:16 [22780] DBG:tm:run_reqin_callbacks: > >>> trans=0x7f81e1b446a0, callback type 1, id 0 entered > >>> Jul 23 16:01:16 [22780] DBG:dialog:ref_dlg: ref dlg 0x7f81e1b3c2f8 with > >>> 1 -> 6 > >>> Jul 23 16:01:16 [22780] DBG:core:mk_proxy: doing DNS lookup... > >>> Jul 23 16:01:16 [22780] DBG:core:check_ip_address: params 10.10.16.2, > >>> 10.10.16.2, 0 > >>> Jul 23 16:01:16 [22780] DBG:tm:set_timer: relative timeout is 500000 > >>> Jul 23 16:01:16 [22780] DBG:tm:insert_timer_unsafe: [4]: 0x7f81e1b448c0 > >>> (15800000) > >>> Jul 23 16:01:16 [22780] DBG:tm:insert_timer_unsafe: [0]: > >>> 0x7f81e1b448f0 (20) > >>> Jul 23 16:01:16 [22780] DBG:tm:t_relay_to: new transaction fwd'ed > >>> [Script Trace][/etc/opensips/opensips.cfg:341][me][core exit] -> (BYE > >>> from 10.10.16.2, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> Jul 23 16:01:16 [22780] DBG:tm:t_unref: UNREF_UNSAFE: [0x7f81e1b446a0] > >>> after is 0 > >>> Jul 23 16:01:16 [22780] DBG:dialog:unref_dlg: unref dlg 0x7f81e1b3c2f8 > >>> with 1 -> 5 in entry 0x7f81e1b35838 > >>> Jul 23 16:01:16 [22780] DBG:core:destroy_avp_list: destroying list > >>> (nil) > >>> Jul 23 16:01:16 [22780] DBG:core:receive_msg: cleaning up > >>> Jul 23 16:01:16 [22780] DBG:core:parse_msg: SIP Request: > >>> Jul 23 16:01:16 [22780] DBG:core:parse_msg: method: <BYE> > >>> Jul 23 16:01:16 [22780] DBG:core:parse_msg: uri: > >>> <sip:10.10.16.2;did=dbf.d239f4f3> > >>> Jul 23 16:01:16 [22780] DBG:core:parse_msg: version: <SIP/2.0> > >>> Jul 23 16:01:16 [22780] DBG:core:parse_headers: flags=2 > >>> Jul 23 16:01:16 [22780] DBG:core:parse_via_param: found param type 232, > >>> <branch> = <z9hG4bK2ff9.8dfac551.0>; state=16 > >>> Jul 23 16:01:16 [22780] DBG:core:parse_via: end of header reached, > >>> state=5 > >>> Jul 23 16:01:16 [22780] DBG:core:parse_headers: via found, flags=2 > >>> Jul 23 16:01:16 [22780] DBG:core:parse_headers: this is the first via > >>> Jul 23 16:01:16 [22780] DBG:core:receive_msg: After parse_msg... > >>> Jul 23 16:01:16 [22780] DBG:core:receive_msg: preparing to run routing > >>> scripts... > >>> [Script Trace][/etc/opensips/opensips.cfg:176][me][core if] -> (BYE > >>> from > >>> 10.10.16.2, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> [Script Trace][/etc/opensips/opensips.cfg:171][me][module > >>> mf_process_maxfwd_header] -> (BYE from 10.10.16.2, > >>> ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> Jul 23 16:01:16 [22780] DBG:core:parse_headers: flags=100 > >>> Jul 23 16:01:16 [22780] DBG:core:parse_via_param: found param type 232, > >>> <branch> = <z9hG4bK2ff9.7dfac551.0>; state=16 > >>> Jul 23 16:01:16 [22780] DBG:core:parse_via: end of header reached, > >>> state=5 > >>> Jul 23 16:01:16 [22780] DBG:core:parse_headers: via found, flags=100 > >>> Jul 23 16:01:16 [22780] DBG:core:parse_headers: parse_headers: this is > >>> the second via > >>> Jul 23 16:01:16 [22780] DBG:core:parse_via_param: found param type 232, > >>> <branch> = <z9hG4bK53eneb00a89gqfc5m0o0.1>; state=16 > >>> Jul 23 16:01:16 [22780] DBG:core:parse_via: end of header reached, > >>> state=5 > >>> Jul 23 16:01:16 [22780] DBG:core:parse_headers: via found, flags=100 > >>> Jul 23 16:01:16 [22780] DBG:core:parse_to_param: tag=6pou4pvn6xe2phuk.i > >>> Jul 23 16:01:16 [22780] DBG:core:parse_to: end of header reached, > >>> state=29 > >>> Jul 23 16:01:16 [22780] DBG:core:parse_to: display={}, > >>> ruri={sip:[email protected]:5060;user=phone} > >>> Jul 23 16:01:16 [22780] DBG:core:get_hdr_field: <To> [70]; > >>> uri=[sip:[email protected]:5060;user=phone] > >>> Jul 23 16:01:16 [22780] DBG:core:get_hdr_field: to body > >>> [<sip:[email protected]:5060;user=phone>] > >>> Jul 23 16:01:16 [22780] DBG:core:get_hdr_field: cseq <CSeq>: <2> <BYE> > >>> Jul 23 16:01:16 [22780] DBG:maxfwd:is_maxfwd_present: value = 65 > >>> [Script Trace][/etc/opensips/opensips.cfg:185][me][core if] -> (BYE > >>> from > >>> 10.10.16.2, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> [Script Trace][/etc/opensips/opensips.cfg:176][me][module > >>> check_source_address] -> (BYE from 10.10.16.2, > >>> ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> Jul 23 16:01:16 [22780] DBG:permissions:check_src_addr_3: Looking for : > >>> <1, 10.10.16.2, 5060, 1> in tables > >>> Jul 23 16:01:16 [22780] DBG:permissions:hash_match: no match in the > >>> hash > >>> table > >>> Jul 23 16:01:16 [22780] DBG:permissions:match_subnet_table: subnet > >>> table > >>> is empty > >>> [Script Trace][/etc/opensips/opensips.cfg:185][me][core if] -> (BYE > >>> from > >>> 10.10.16.2, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> [Script Trace][/etc/opensips/opensips.cfg:179][me][module > >>> is_from_gw] -> > >>> (BYE from 10.10.16.2, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> [Script Trace][/etc/opensips/opensips.cfg:183][me][core xlog] -> (BYE > >>> from 10.10.16.2, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> Message is not from Trunk or GW 10.10.16.2[Script > >>> Trace][/etc/opensips/opensips.cfg:248][me][core if] -> (BYE from > >>> 10.10.16.2, ruri=sip:10.10.16.2;did=dbf.d239f4f3) > >>> > >>> > >>> Regards > >>> Trevor Steyn > >>> > >> > >> _______________________________________________ > >> Devel mailing list > >> [email protected] > >> http://lists.opensips.org/cgi-bin/mailman/listinfo/devel > > > > > > _______________________________________________ > > Devel mailing list > > [email protected] > > http://lists.opensips.org/cgi-bin/mailman/listinfo/devel > > > _______________________________________________ > Devel mailing list > [email protected] > http://lists.opensips.org/cgi-bin/mailman/listinfo/devel >
_______________________________________________ Devel mailing list [email protected] http://lists.opensips.org/cgi-bin/mailman/listinfo/devel
