[OpenSIPS-Users] miss BYE

Nick nick_chang at ezmobo.com
Wed Dec 14 08:23:28 CET 2011


Hello

It's my debug log for opensips.

I don't know why. I missed bye for callee or caller.
If everyone can give me a suggest.
Thanks

Nick

Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26661]: 
DBG:core:db_allocate_rows: allocate 28 bytes for result rows and values 
at 0x8217740
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26661]: 
DBG:db_mysql:db_mysql_str2val: converting STRING [123]
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26661]: 
DBG:auth_db:get_ha1: HA1 string calculated: 84244f5976b13e70f7ed2b1afd98d546
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26661]: 
DBG:auth:check_response: our result = 'e96c0139c71a35be0e792c4b1d34f747'
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26661]: 
DBG:auth:check_response: authorization is OK
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26661]: 
DBG:auth:post_auth: nonce index= 17
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26661]: 
DBG:core:db_free_columns: freeing result columns at 0x8213bcc
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26661]: 
DBG:core:db_free_rows: freeing 1 rows
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26661]: 
DBG:core:db_free_row: freeing row values at 0x8217748
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26661]: 
DBG:core:db_free_rows: freeing rows at 0x8217740
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26661]: 
DBG:core:db_free_result: freeing result set at 0x821776c
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26661]: 
DBG:uri:check_username: Digest username and URI username match
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26661]: 
DBG:core:parse_headers: flags=ffffffffffffffff
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26661]: 
DBG:core:parse_params: Parsing params 
for:[expires=3200;+g.oma.sip-im;language="en,fr";+g.3gpp.smsip;+g.oma.sip-im.large-message;audio;+g.3gpp.icsi-ref="urn%3Aurn-7%3A3gpp-application.ims.iari.gsma-vs";+g.3gpp.cs-voice]
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26661]: 
DBG:core:parse_headers: flags=8000000
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26661]: 
DBG:core:parse_headers: flags=ffffffffffffffff
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26661]: 
DBG:core:parse_methods: methods 0x1D6F
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26661]: 
DBG:registrar:build_contact: created Contact HF: Contact: 
<sip:2 at 192.168.20.126:57191;transport=udp>;expires=2383;received="sip:220.130.6.180:57191", 
<sip:2 at 192.168.20.126:55541;transport=udp>;expires=3200;received="sip:220.130.6.180:55541"^M
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26661]: 
DBG:core:parse_headers: flags=ffffffffffffffff
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26661]: 
DBG:sl:run_sl_callbacks: callback id 0 entered
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26661]: 
DBG:siptrace:trace_sl_onreply_out: nothing to trace...
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26661]: 
DBG:core:destroy_avp_list: destroying list 0xb60dba34
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26661]: 
DBG:core:receive_msg: cleaning up
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:parse_msg: SIP Request:
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:parse_msg:  method: <BYE>
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:parse_msg:  uri: <sip:5 at 220.130.6.180:56382;transport=udp;nat=yes>
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:parse_msg:  version: <SIP/2.0>
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:parse_headers: flags=2
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:parse_via_param: found param type 232, <branch> = 
<z9hG4bK-d8754z-f8142f691a5bab3f-1---d8754z->; state=6
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:parse_via_param: found param type 235, <rport> = <n/a>; state=17
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:parse_via: end of header reached, state=5
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:parse_headers: via found, flags=2
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:parse_headers: this is the first via
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:receive_msg: After parse_msg...
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:receive_msg: preparing to run routing scripts...
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:parse_headers: flags=10
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:parse_to_param: tag=711628967
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:parse_to: end of header reached, state=29
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:parse_to: display={"5"}, ruri={sip:5 at 220.130.6.180}
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:get_hdr_field: <To> [40]; uri=[sip:5 at 220.130.6.180]
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:get_hdr_field: to body ["5"<sip:5 at 220.130.6.180>]
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:parse_to_param: tag=842eca09
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:parse_to: end of header reached, state=29
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:parse_to: display={"test"}, ruri={sip:999 at 220.130.6.180}
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: ROUTE BEGIN 
sip:999 at 220.130.6.180
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:maxfwd:is_maxfwd_present: value = 70
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:check_ip_address: params 192.168.20.138, 192.168.20.138, 0
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:parse_headers: flags=ffffffffffffffff
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:get_hdr_field: cseq <CSeq>: <3> <BYE>
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:get_hdr_field: content_length=0
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:get_hdr_field: found end of header
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:uri:has_totag: totag found
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:parse_headers: flags=200
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:rr:is_preloaded: is_preloaded: No
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:grep_sock_info: checking if host==us: 13==9 &&  [220.130.6.180] 
== [127.0.0.1]
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:grep_sock_info: checking if port 5060 matches port 56382
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:grep_sock_info: checking if host==us: 13==14 &&  
[220.130.6.180] == [192.168.20.118]
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:grep_sock_info: checking if port 5060 matches port 56382
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:grep_sock_info: checking if host==us: 13==9 &&  [220.130.6.180] 
== [127.0.0.1]
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:grep_sock_info: checking if port 5060 matches port 56382
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:grep_sock_info: checking if host==us: 13==14 &&  
[220.130.6.180] == [192.168.20.118]
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:grep_sock_info: checking if port 5060 matches port 56382
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:rr:after_strict: Next hop: 'sip:192.168.20.118;lr;did=2bb.5ff88246' 
is loose router
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:parse_headers: flags=ffffffffffffffff
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:rr:after_strict: The last route URI: 
'sip:192.168.20.118;lr;did=2bb.5ff88246'
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:rr:run_rr_callbacks: callback id 1 entered with <transport=udp;nat=yes>
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:dialog:dlg_onroute: Route param 'did' not found
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:parse_headers: flags=58
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:dialog:get_dlg: input 
ci=<YjUyMTY5NzY4MTA3MTU3NWUxOWJiODkyYTdlNzM4MDQ.>(44), tt=<842eca09>(8), 
ft=<711628967>(9)
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:dialog:get_dlg: no dialog 
callid='YjUyMTY5NzY4MTA3MTU3NWUxOWJiODkyYTdlNzM4MDQ.' found
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:dialog:dlg_onroute: Callid 
'YjUyMTY5NzY4MTA3MTU3NWUxOWJiODkyYTdlNzM4MDQ.' not found
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: ROUTE 1 
sip:999 at 220.130.6.180
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:subst_run: running. r=1
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:subst_str: no match
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:tm:t_newtran: transaction on entrance=0xffffffff
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:parse_headers: flags=ffffffffffffffff
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:parse_headers: flags=78
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:tm:t_lookup_request: start searching: hash=19431, isACK=0
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:tm:matching_3261: RFC3261 transaction matching failed
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:tm:t_lookup_request: no transaction found
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:tm:run_reqin_callbacks: trans=0xb60e1a24, callback type 1, id 2 entered
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:siptrace:trace_onreq_in: nothing to trace...
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:tm:run_reqin_callbacks: trans=0xb60e1a24, callback type 1, id 1 entered
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:tm:run_reqin_callbacks: trans=0xb60e1a24, callback type 1, id 0 entered
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:parse_headers: flags=78
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:_shm_resize: resize(0) called
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:mk_proxy: doing DNS lookup...
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:tm:set_timer: relative timeout is 500000
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:core:parse_msg: SIP Request:
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:tm:insert_timer_unsafe: [4]: 0xb60e1b70 (923900000)
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:core:parse_msg:  method: <BYE>
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:tm:set_timer: relative timeout is 5
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:core:parse_msg:  uri: <sip:192.168.20.118;lr;did=2bb.5ff88246>
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:tm:insert_timer_unsafe: [0]: 0xb60e1b8c (928)
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:core:parse_msg:  version: <SIP/2.0>
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:tm:t_relay_to: new transaction fwd'ed
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:core:parse_headers: flags=2
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:tm:t_unref: UNREF_UNSAFE: [0xb60e1a24] after is 0
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:core:parse_via_param: found param type 232, <branch> = 
<z9hG4bK7eb4.65002b42.0>; state=16
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:destroy_avp_list: destroying list (nil)
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:core:parse_via: end of header reached, state=5
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26663]: 
DBG:core:receive_msg: cleaning up
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:core:parse_headers: via found, flags=2
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:core:parse_headers: this is the first via
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:core:receive_msg: After parse_msg...
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:core:receive_msg: preparing to run routing scripts...
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:core:parse_headers: flags=10
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:core:parse_via_param: found param type 234, <received> = 
<192.168.20.138>; state=6
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:core:parse_via_param: found param type 232, <branch> = 
<z9hG4bK-d8754z-f8142f691a5bab3f-1---d8754z->; state=6
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:core:parse_via_param: found param type 235, <rport> = <35866>; state=16
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:core:parse_via: end of header reached, state=5
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:core:parse_headers: via found, flags=10
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:core:parse_headers: parse_headers: this is the second via
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:core:parse_to_param: tag=711628967
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:core:parse_to: end of header reached, state=29
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:core:parse_to: display={"5"}, ruri={sip:5 at 220.130.6.180}
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:core:get_hdr_field: <To> [40]; uri=[sip:5 at 220.130.6.180]
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:core:get_hdr_field: to body ["5"<sip:5 at 220.130.6.180>]
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:core:parse_to_param: tag=842eca09
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:core:parse_to: end of header reached, state=29
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:core:parse_to: display={"test"}, ruri={sip:999 at 220.130.6.180}
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: ROUTE BEGIN 
sip:999 at 220.130.6.180
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:maxfwd:is_maxfwd_present: value = 69
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:core:check_ip_address: params 192.168.20.118, 192.168.20.118, 0
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:core:parse_headers: flags=ffffffffffffffff
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:core:get_hdr_field: cseq <CSeq>: <3> <BYE>
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:core:get_hdr_field: content_length=0
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:core:get_hdr_field: found end of header
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:uri:has_totag: totag found
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:core:parse_headers: flags=200
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:rr:find_first_route: No Route headers found
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:rr:loose_route: There is no Route HF
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:core:parse_headers: flags=ffffffffffffffff
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:sl:run_sl_callbacks: callback id 0 entered
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:siptrace:trace_sl_onreply_out: nothing to trace...
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:core:destroy_avp_list: destroying list 0xb60dd2cc
Dec 14 14:48:16 sfs-staging /usr/local/sbin/opensips[26665]: 
DBG:core:parse_msg: SIP Reply  (status):
Dec 14 14:48:17 sfs-staging /usr/local/sbin/opensips[26660]: 
DBG:core:receive_msg: cleaning up
Dec 14 14:48:17 sfs-staging /usr/local/sbin/opensips[26665]: 
DBG:core:parse_msg:  version: <SIP/2.0>
Dec 14 14:48:17 sfs-staging /usr/local/sbin/opensips[26665]: 
DBG:core:parse_msg:  status: <404>
Dec 14 14:48:17 sfs-staging /usr/local/sbin/opensips[26665]: 
DBG:core:parse_msg:  reason: <Not here>
Dec 14 14:48:17 sfs-staging /usr/local/sbin/opensips[26665]: 
DBG:core:parse_headers: flags=2
Dec 14 14:48:17 sfs-staging /usr/local/sbin/opensips[26665]: 
DBG:core:parse_via_param: found param type 234, <received> = 
<192.168.20.118>; state=6
Dec 14 14:48:17 sfs-staging /usr/local/sbin/opensips[26665]: 
DBG:core:parse_via_param: found param type 235, <rport> = <5060>; state=6
Dec 14 14:48:17 sfs-staging /usr/local/sbin/opensips[26665]: 
DBG:core:parse_via_param: found param type 232, <branch> = 
<z9hG4bK7eb4.65002b42.0>; state=16
Dec 14 14:48:17 sfs-staging /usr/local/sbin/opensips[26665]: 
DBG:core:parse_via: end of header reached, state=5
Dec 14 14:48:17 sfs-staging /usr/local/sbin/opensips[26665]: 
DBG:core:parse_headers: via found, flags=2


On 2011?12?13? 17:33, Vlad Paiu wrote:
> Hello,
>
> It seems that OpenSIPS sees itself responsible for the R-URI domain ( 
> 220.130.6.180 ) and for the Route Header URI domain as well ( 
> 192.168.20.118 ) so something goes wrong with the loose routing. 
> Actually OpenSIPS will try to do Strict Routing for that BYE, as it 
> sees itself in the R-URI, and then it would try to forward it again to 
> itself, but this time without any Route Headers, which will make 
> loose_route() exit the second time with an error.
>
> Can you please post a full debug OpenSIPS log while processing this BYE ?
>
> Regards,
> Vlad Paiu
> OpenSIPS Developer
>
> On 12/13/2011 09:46 AM, Nick wrote:
>> Hello
>>
>> Yes.
>> It's my config.
>> Thanks for your support.
>>
>> Nick
>>
>> On 2011?12?13? 14:35, Schneur Rosenberg wrote:
>>>
>>> Did u do record_route() on initial invite?
>>>
>>> On Dec 13, 2011 8:02 AM, "Nick" <nick_chang at ezmobo.com 
>>> <mailto:nick_chang at ezmobo.com>> wrote:
>>>
>>>     Hello
>>>
>>>     I used ngrep .
>>>     U 220.130.6.180:55260 <http://220.130.6.180:55260> ->
>>>     192.168.20.118:5060 <http://192.168.20.118:5060>
>>>     BYE sip:81 at 220.130.6.180:17882
>>>     <http://sip:81@220.130.6.180:17882> SIP/2.0.
>>>     Via: SIP/2.0/UDP
>>>     192.168.20.153:55260;branch=z9hG4bK1489712528;rport.
>>>     From: <sip:118 at 220.130.6.180
>>>     <mailto:sip%3A118 at 220.130.6.180>>;tag=1735203887.
>>>     To: "Tony-opensips"<sip:81 at 220.130.6.180
>>>     <mailto:sip%3A81 at 220.130.6.180>>;tag=2e7b1572.
>>>     Call-ID: ZDgzYzY5NjcxY2UzYmU0YzkwMWUzZWFiODA4NzlmY2I..
>>>     CSeq: 859463759 BYE.
>>>     Content-Length: 0.
>>>     Max-Forwards: 70.
>>>     Accept-Contact: *;+g.oma.sip-im.
>>>     Accept-Contact: *;language="en,fr".
>>>     Accept-Contact:
>>>     *;+g.3gpp.icsi-ref="urn%3Aurn-7%3A3gpp-service.ims.icsi.mmtel".
>>>     Route: <sip:192.168.20.118;lr;did=827.ee7aaf17>.
>>>     Accept-Contact:
>>>     *;+g.3gpp.icsi-ref="urn%3Aurn-7%3A3gpp-service.ims.icsi.mmtel".
>>>     P-Preferred-Service: urn:urn-7:3gpp-service.ims.icsi.mmtel.
>>>     Allow: INVITE, ACK, CANCEL, BYE, MESSAGE, OPTIONS, NOTIFY,
>>>     PRACK, UPDATE, REFER.
>>>     Privacy: none.
>>>     P-Access-Network-Info: ADSL;utran-cell-id-3gpp=00000000.
>>>     User-Agent: IM-client/OMA1.0 ios-ngn-stack/v00 (doubango r000).
>>>     P-Preferred-Identity: <sip:118 at 220.130.6.180
>>>     <mailto:sip%3A118 at 220.130.6.180>>.
>>>     .
>>>
>>>
>>>     U 192.168.20.118:5060 <http://192.168.20.118:5060> ->
>>>     220.130.6.180:55260 <http://220.130.6.180:55260>
>>>     SIP/2.0 404 Not here.
>>>     Via: SIP/2.0/UDP
>>>     192.168.20.153:55260;received=220.130.6.180;branch=z9hG4bK1489712528;rport=55260.
>>>     From: <sip:118 at 220.130.6.180
>>>     <mailto:sip%3A118 at 220.130.6.180>>;tag=1735203887.
>>>     To: "Tony-opensips"<sip:81 at 220.130.6.180
>>>     <mailto:sip%3A81 at 220.130.6.180>>;tag=2e7b1572.
>>>     Call-ID: ZDgzYzY5NjcxY2UzYmU0YzkwMWUzZWFiODA4NzlmY2I..
>>>     CSeq: 859463759 BYE.
>>>     Server: OpenSIPS (1.7.0-tls (i386/linux)).
>>>     Content-Length: 0.
>>>
>>>
>>>     When 118 send BYE to Server.
>>>     But Server tell 118 " Not Here".
>>>
>>>     It's my config for BYE
>>>
>>>            if (has_totag()) {
>>>                    # sequential request withing a dialog should
>>>                    # take the path determined by record-routing
>>>                    if (loose_route()) {
>>>                            if (is_method("BYE")) {
>>>                                    setflag(1); # do accounting ...
>>>                                    setflag(3); # ... 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();
>>>                            }
>>>                            # route it out to whatever destination
>>>     was set by loose_route()
>>>                            # in $du (destination URI).
>>>                            route(1);
>>>                    } else {
>>>                            /* uncomment the following lines if you
>>>     want to enable presence */
>>>                            if (is_method("SUBSCRIBE") && $rd ==
>>>     "192.168.20.118") {
>>>                                    # in-dialog subscribe requests
>>>                                    route(presence_handling);
>>>                                    exit;
>>>                            }
>>>                            if ( is_method("ACK") ) {
>>>                                    if ( t_check_trans() ) {
>>>                                            # non loose-route, but
>>>     stateful ACK; must be an ACK after
>>>                                            # a 487 or e.g. 404 from
>>>     upstream server
>>>                                            t_relay();
>>>                                            exit;
>>>                                    } else {
>>>                                            # ACK without matching
>>>     transaction ->
>>>                                            # ignore and discard
>>>                                            exit;
>>>                                    }
>>>                            }
>>>                            sl_send_reply("404","Not here");
>>>                    }
>>>                    exit;
>>>            }
>>>
>>>     Why is Not here??
>>>     Can everyone help me? Thanks
>>>     Nick
>>>
>>>     _______________________________________________
>>>     Users mailing list
>>>     Users at lists.opensips.org <mailto:Users at lists.opensips.org>
>>>     http://lists.opensips.org/cgi-bin/mailman/listinfo/users
>>>
>>>
>>> _______________________________________________
>>> Users mailing list
>>> Users at lists.opensips.org
>>> http://lists.opensips.org/cgi-bin/mailman/listinfo/users
>>
>>
>> _______________________________________________
>> Users mailing list
>> Users at lists.opensips.org
>> http://lists.opensips.org/cgi-bin/mailman/listinfo/users
>
>
> _______________________________________________
> Users mailing list
> Users at lists.opensips.org
> http://lists.opensips.org/cgi-bin/mailman/listinfo/users
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.opensips.org/pipermail/users/attachments/20111214/12888ea3/attachment-0001.htm>


More information about the Users mailing list