[OpenSER-Users] Re: [Users] Many crashes on Openser system

Bogdan-Andrei Iancu bogdan at voice-system.ro
Fri Jun 22 19:06:33 CEST 2007


Hi Antonio,

it looks like the crash happens in the acc module, when building the acc 
db_extra values (from AVPs)....

I'll need to investigate it more.....

regards,
bogdan

Antonio Higuera wrote:
> Klaus,
>  
> Not sure what modules uses callback function. I am using the following 
> modules:
>  
> loadmodule "mysql.so"
> loadmodule "sl.so"
> loadmodule "tm.so"
> loadmodule "rr.so"
> loadmodule "maxfwd.so"
> loadmodule "usrloc.so"
> loadmodule " registrar.so"
> loadmodule "auth.so"
> loadmodule "auth_db.so"
> loadmodule "uri.so"
> loadmodule "uri_db.so"
> loadmodule "domain.so"
> loadmodule "textops.so "
> loadmodule "avpops.so"
> loadmodule "permissions.so"
> loadmodule "enum.so"
> loadmodule "acc.so"
> loadmodule "dialog.so"
> loadmodule "mi_fifo.so"
> loadmodule "snmpstats.so"
> loadmodule "xlog.so"
> loadmodule "lcr.so"
> loadmodule "pdt.so"
>  
> none of the above is written by us. 
>  
> Thanks very much.
>
>  
> 2007/6/21, Klaus Darilion <klaus.mailinglists at pernau.at 
> <mailto:klaus.mailinglists at pernau.at>>:
>
>     looks like (not sure) process 1546 received a reply, does the tm
>     matching, and then forwards the reply. The last entry
>
>     Jun  7 10:42:04 marge openser[1546]: DBG: trans=0xb577a938, callback
>     type 128, id 0 entered
>
>     references a callback. Maybe the tm module calls a registered callback
>     function and this function crashes.
>
>     Do you use any self-written modules?
>     Which modules are you using which uses callbacks (e.g. acc, dialog
>     ...)?
>     Try to disable these modules.
>
>     regards
>     klaus
>
>     Antonio Higuera wrote:
>     > Thanks for your reply.
>     >
>     > You have attached a file with the logs. Be aware that the coredump
>     > backtrace
>     > i sent in my previous mail maybe is not the same crash you can
>     see in the
>     > log.
>     >
>     > Thanks again for your help.
>     >
>     >
>     > Jun 7 10:42:04 marge openser[1546]: SIP Reply (status):
>     >
>     > Jun 7 10:42:04 marge openser[1546]: version: <SIP/2.0>
>     >
>     > Jun 7 10:42:04 marge openser[1546]: status: <407>
>     >
>     > Jun 7 10:42:04 marge openser[1546]: reason: <Proxy
>     Authentication Required>
>     >
>     > Jun 7 10:42:04 marge openser[1546]: parse_headers: flags=2
>     >
>     > Jun 7 10:42:04 marge openser[1546]: Found param type 232,
>     <branch> = <
>     > z9hG4bK6202.244bec76.0>; state=6
>     >
>     > Jun 7 10:42:04 marge openser[1546]: Found param type 234,
>     <received> = <
>     > 192.168.1.129 <http://192.168.1.129>>; state=16
>     >
>     > Jun 7 10:42:04 marge openser[1546]: end of header reached, state=5
>     >
>     > Jun 7 10:42:04 marge openser[1546]: parse_headers: Via found,
>     flags=2
>     >
>     > Jun 7 10:42:04 marge openser[1546]: parse_headers: this is the
>     first via
>     >
>     > Jun 7 10:42:04 marge openser[1546]: After parse_msg...
>     >
>     > Jun 7 10:42:04 marge openser[1546]: DEBUG:forward_reply: found
>     module tm,
>     > passing reply to it
>     >
>     > Jun 7 10:42:04 marge openser[1546]: DEBUG: t_check:
>     start=0xffffffff
>     >
>     > Jun 7 10:42:04 marge openser[1546]: parse_headers: flags=22
>     >
>     > Jun 7 10:42:04 marge openser[1546]: Found param type 232, <branch> =
>     > <z9hG4bKcc503ea3c48d6b766>; state=16
>     >
>     > Jun 7 10:42:04 marge openser[1546]: end of header reached, state=5
>     >
>     > Jun 7 10:42:04 marge openser[1546]: parse_headers: Via found,
>     flags=22
>     >
>     > Jun 7 10:42:04 marge openser[1546]: parse_headers: this is the
>     second via
>     >
>     > Jun 7 10:42:04 marge openser[1546]: DEBUG: add_param: tag=as4b55784e
>     >
>     > Jun 7 10:42:04 marge openser[1546]: DEBUG:parse_to:end of header
>     reached,
>     > state=29
>     >
>     > Jun 7 10:42:04 marge openser[1546]: DBUG:parse_to:
>     display={21104}, ruri={
>     > sip:21104 at barik.com <mailto:sip:21104 at barik.com>}
>     >
>     > Jun 7 10:42:04 marge openser[1546]: DEBUG: get_hdr_field: <To>
>     [44]; uri=[
>     > sip:21104 at barik.com <mailto:sip:21104 at barik.com>]
>     >
>     > Jun 7 10:42:04 marge openser[1546]: DEBUG: to body [21104 <
>     > sip:21104 at barik.com <mailto:sip:21104 at barik.com>>]
>     >
>     > Jun 7 10:42:04 marge openser[1546]: get_hdr_field: cseq <CSeq>:
>     <30425>
>     > <INVITE>
>     >
>     > Jun 7 10:42:04 marge openser[1546]: parse_headers: flags=8
>     >
>     > Jun 7 10:42:04 marge openser[1546]: DEBUG: t_reply_matching:
>     hash 8230
>     > label
>     > 1741599810 branch 0
>     >
>     > Jun 7 10:42:04 marge openser[1546]: DEBUG:tm:REF_UNSAFE: after is 1
>     >
>     > Jun 7 10:42:04 marge openser[1546]: DEBUG: t_reply_matching:
>     reply matched
>     > (T=0xb577a938)!
>     >
>     > Jun 7 10:42:04 marge openser[1546]: DBG: trans=0xb577a938,
>     callback type 2,
>     > id 0 entered
>     >
>     > Jun 7 10:42:04 marge openser[1546]: parse_headers: flags=8
>     >
>     > Jun 7 10:42:04 marge openser[1546]: DEBUG: t_check: end=0xb577a938
>     >
>     > Jun 7 10:42:04 marge openser[1546]: DEBUG:tm:reply_received:
>     org. status
>     > uas=100, uac[0]=0 local=0 is_invite=1)
>     >
>     > Jun 7 10:42:04 marge openser[1546]: parse_headers: flags=8
>     >
>     > Jun 7 10:42:04 marge openser[1546]: DEBUG:tm:build_local: using
>     FROM=<From:
>     > Arturo <sip:104 at barik.com
>     <mailto:sip:104 at barik.com>>;tag=73529158ed >, TO=<To: 21104 <
>     > sip:21104 at barik.com <mailto:sip:21104 at barik.com>>;tag=as4b55784e
>     >, CSEQ_N=<CSeq: 30425>
>     >
>     > Jun 7 10:42:04 marge openser[1546]:
>     DEBUG:tm:t_should_relay_response:
>     > T_code=100, new_code=407
>     >
>     > Jun 7 10:42:04 marge openser[1546]: DEBUG:tm:t_pick_branch: picked
>     > branch 0,
>     > code 407
>     >
>     > Jun 7 10:42:04 marge openser[1546]:
>     DEBUG:tm:t_should_relay_response:
>     > dns-failover test: branch=0, last_recv=407, flags=2
>     >
>     > Jun 7 10:42:04 marge openser[1546]: DEBUG:tm:relay_reply:
>     branch=0, save=0,
>     > relay=0
>     >
>     > Jun 7 10:42:04 marge openser[1546]: old size: 533, new size: 448
>     >
>     > Jun 7 10:42:04 marge openser[1546]: build_res_from_sip_res:
>     copied size:
>     > orig:128, new: 43, rest: 405 msg= SIP/2.0 407 Proxy
>     Authentication Required
>     > Via: SIP/2.0/UDP 192.168.1.64:5060
>     <http://192.168.1.64:5060>;branch=z9hG4bKcc503ea3c48d6b766 From:
>     > Arturo <sip:104 at barik.com
>     <mailto:sip:104 at barik.com>>;tag=73529158ed To: 21104
>     > <sip:21104 at barik.com <mailto:sip:21104 at barik.com>>;tag=as4b55784e
>     > Call-ID: f35b076f65bee9c5 CSeq: 30425 INVITE User-Agent:
>     Asterisk PBX
>     > Allow:
>     > INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
>     > Proxy-Authenticate: Digest algorithm=MD5, realm="asterisk",
>     > nonce="6f707e3f"
>     > Content-Length: 0
>     >
>     > Jun 7 10:42:04 marge openser[1546]: DEBUG:tm:set_timer: relative
>     timeout is
>     > 500000
>     >
>     > Jun 7 10:42:04 marge openser[1546]: DEBUG: add_to_tail_of_timer[4]:
>     > 0xb577aa00 (52180600000)
>     >
>     > Jun 7 10:42:04 marge openser[1546]: DEBUG:tm:set_timer: relative
>     timeout is
>     > 10
>     >
>     > Jun 7 10:42:04 marge openser[1546]: DEBUG: add_to_tail_of_timer[0]:
>     > 0xb577aa1c (52190)
>     >
>     > Jun 7 10:42:04 marge openser[1546]: DEBUG:tm:relay_reply: sent
>     > buf=0x819cce8: SIP/2.0 4..., shmem=0xb5778158: SIP/2.0 4
>     >
>     > Jun 7 10:42:04 marge openser[1546]: DBG: trans=0xb577a938,
>     callback type
>     > 128, id 0 entered
>     >
>     >
>     >
>     > 2007/6/20, Klaus Darilion < klaus.mailinglists at pernau.at
>     <mailto:klaus.mailinglists at pernau.at>>:
>     >>
>     >> > The following lines are the log generated:
>     >> >
>     >> > Jun 7 10:42:04 marge openser[1545]: receive_msg: cleaning up
>     >> >
>     >> > Jun 7 10:42:04 marge openser[1565]: ERROR: receive_fd: EOF on 8
>     >> >
>     >> > Jun 7 10:42:04 marge openser[1565]: DBG: handle_ser_child: dead
>     >> child 2,
>     >> > pid
>     >> > 1546 (shutting down?)
>     >> >
>     >> > Jun 7 10:42:04 marge openser[1565]: DBG: io_watch_del
>     (0x812d720, 8,
>     >> -1,
>     >> > 0x0) fd_no=23 called
>     >> >
>     >> > Jun 7 10:42:04 marge openser[1544]: child process 1546 exited
>     by a
>     >> > signal 11
>     >>
>     >> Could you also post the last log lines of process 1546 ?
>     >>
>     >>
>     >> regards
>     >> klaus
>     >>
>
>
> ------------------------------------------------------------------------
>
> _______________________________________________
> Users mailing list
> Users at openser.org
> http://openser.org/cgi-bin/mailman/listinfo/users
>   





More information about the Users mailing list