[OpenSER-Users] Re: [Users] Many crashes on Openser system
Bogdan-Andrei Iancu
bogdan at voice-system.ro
Fri Jul 6 15:28:14 CEST 2007
Hi,
just for the list info, the bug was found and fixed on trunk version. if
the tests are ok, the fix will be backported to 1.2 .
Thanks again to Antonio.
Regards,
bogdan
Bogdan-Andrei Iancu wrote:
> Hi Antonio,
>
> let us try first with this patch - please send me the output.
>
> regards,
> Bogdan
>
> Antonio Higuera wrote:
>> Hi Bogdan,
>>
>> Yes, I can reproduce the crash. Do you need more information apart of
>> what I sent in my previous mais?.
>> As soon as you send me the patch I will apply it.
>>
>> Thanks,
>> Antonio.
>>
>> 2007/6/28, Bogdan-Andrei Iancu <bogdan at voice-system.ro
>> <mailto:bogdan at voice-system.ro>>:
>>
>> Hi Antonio,
>>
>> it is quite trick - I was not able to get to something so far, so
>> I will
>> need your help. Can you reproduce the crash? if yes, can you apply a
>> patch that I will send you?
>>
>> thanks and regards,
>> bogdan
>>
>> Antonio Higuera wrote:
>> > Thanks bogdan,
>> >
>> > Is there any new about this? Can we do any test to help to fix
>> this
>> > problem?
>> >
>> > Thanks again,
>> > Antonio.
>> >
>> >
>> > 2007/6/22, Bogdan-Andrei Iancu <bogdan at voice-system.ro
>> <mailto:bogdan at voice-system.ro>
>> > <mailto:bogdan at voice-system.ro <mailto:bogdan at voice-system.ro>>>:
>> >
>> > 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>
>> > <mailto: klaus.mailinglists at pernau.at
>> <mailto:klaus.mailinglists at pernau.at>>
>> > > <mailto:klaus.mailinglists at pernau.at
>> <mailto:klaus.mailinglists at pernau.at>
>> > <mailto: 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> <
>> http://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>
>> <mailto:sip <mailto:sip>:21104 at barik.com <mailto:21104 at barik.com>>
>> > <mailto: sip <mailto:sip> <mailto:sip
>> <mailto:sip>>:21104 at barik.com <mailto:21104 at barik.com>
>> <mailto:21104 at barik.com <mailto: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>
>> <mailto:sip <mailto:sip>:21104 at barik.com <mailto:21104 at barik.com>>
>> > <mailto:sip <mailto:sip> <mailto:sip
>> <mailto:sip>>:21104 at barik.com <mailto:21104 at barik.com>
>> <mailto:21104 at barik.com <mailto: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>
>> <mailto: sip <mailto:sip>:21104 at barik.com <mailto:21104 at barik.com>>
>> > <mailto:sip <mailto:sip> <mailto:sip
>> <mailto:sip>>:21104 at barik.com <mailto:21104 at barik.com> <mailto:
>> 21104 at barik.com <mailto: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>
>> <mailto:sip <mailto:sip>:104 at barik.com <mailto:104 at barik.com>>
>> > > <mailto:sip <mailto:sip> <mailto:sip <mailto:sip>>:
>> 104 at barik.com <mailto:104 at barik.com>
>> > <mailto:104 at barik.com
>> <mailto:104 at barik.com>>>>;tag=73529158ed >, TO=<To: 21104 <
>> > > > sip:21104 at barik.com <mailto:sip:21104 at barik.com>
>> <mailto:sip <mailto:sip>:21104 at barik.com <mailto:21104 at barik.com>>
>> > <mailto:sip <mailto:sip> <mailto:sip <mailto:sip>>:
>> 21104 at barik.com <mailto:21104 at barik.com>
>> > <mailto:21104 at barik.com
>> <mailto: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> <http://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> <mailto:sip <mailto:sip>:104 at barik.com
>> <mailto:104 at barik.com>>
>> > > <mailto:sip <mailto:sip> <mailto:sip <mailto:sip>>:
>> 104 at barik.com <mailto:104 at barik.com>
>> > <mailto:104 at barik.com
>> <mailto:104 at barik.com>>>>;tag=73529158ed To: 21104
>> > > > < sip:21104 at barik.com <mailto:sip:21104 at barik.com>
>> <mailto: sip <mailto:sip>:21104 at barik.com <mailto:21104 at barik.com>>
>> > <mailto:sip <mailto:sip> <mailto:sip
>> <mailto:sip>>:21104 at barik.com <mailto:21104 at barik.com>
>> > <mailto:21104 at barik.com
>> <mailto: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>
>> > <mailto:klaus.mailinglists at pernau.at
>> <mailto:klaus.mailinglists at pernau.at>>
>> > > <mailto:klaus.mailinglists at pernau.at
>> <mailto:klaus.mailinglists at pernau.at>
>> > <mailto: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
>> > > >>
>>
>>
>
> ------------------------------------------------------------------------
More information about the Users
mailing list