[OpenSIPS-Devel] Crash [presence]

[Iñaki Baz Castillo]

El Lunes, 15 de Diciembre de 2008, Iñaki Baz Castillo escribió:
> > Are you sure you have not corrupted the database? Can you please start
> > fresh: stop the server, empty database tables, start the server again.
>
> Now I've separed the presence server in other host (the same in fact, but
> other OpenSIPS listening in different address).
>
> I've emptied presence related tables and started a client who performs some
> SUBSCRIBE's and PULBISH's. In that moment the presence server has crashed.
>
> I'm trying to reproduce it and capture the logs.

I attach a gdb output of the coredump in teh above scenario:
- OpenSips starts as presence server (no more).
- Presence tables were emptied.
- A client sends variosPUBLISH/SUBSCRIBE's.
- OpenSIPS crashes.

I'll try to capture the debug (level 4).



-- 
Iñaki Baz Castillo
-------------- next part --------------
(gdb) bt
#0  0x00002b77859475b0 in strlen () from /lib/libc.so.6
#1  0x00002b778744dada in get_db_subs_auth (subs=0x7fff258c86d0, found=<value optimized out>) at subscribe.c:1952
#2  0x00002b778744f2f4 in handle_subscribe (msg=0x642d20, str1=<value optimized out>, str2=<value optimized out>) at subscribe.c:611
#3  0x000000000040f309 in do_action (a=0x63a190, msg=0x642d20) at action.c:830
#4  0x0000000000411053 in run_action_list (a=<value optimized out>, msg=0x642d20) at action.c:138
#5  0x0000000000410a06 in do_action (a=0x63be30, msg=0x642d20) at action.c:702
#6  0x0000000000411053 in run_action_list (a=<value optimized out>, msg=0x642d20) at action.c:138
#7  0x000000000040fd7b in do_action (a=0x6395b8, msg=0x642d20) at action.c:118
#8  0x0000000000411053 in run_action_list (a=<value optimized out>, msg=0x642d20) at action.c:138
#9  0x0000000000410a06 in do_action (a=0x639758, msg=0x642d20) at action.c:702
#10 0x0000000000411053 in run_action_list (a=<value optimized out>, msg=0x642d20) at action.c:138
#11 0x00000000004113e0 in run_top_route (a=0x637b10, msg=0x642d20) at action.c:118
#12 0x000000000043ffcc in receive_msg (
    buf=0x60ac20 "SUBSCRIBE sip:bego at aaaaa.net SIP/2.0\r\nRecord-Route: <sip:99.122.79.216;r2=on;lr=on>\r\nRecord-Route: <sip:99.122.79.216:5062;transport=tcp;r2=on;lr=on>\r\nVia: SIP/2.0/UDP 99.122.79.216;branch=z9hG4bK4bfa"..., len=645, rcv_info=0x7fff258c9750) at receive.c:165
#13 0x0000000000470aa0 in udp_rcv_loop () at udp_server.c:449
#14 0x00000000004228cc in main (argc=<value optimized out>, argv=0x7fff258c9948) at main.c:776


(gdb) bt full
#0  0x00002b77859475b0 in strlen () from /lib/libc.so.6
No symbol table info available.
#1  0x00002b778744dada in get_db_subs_auth (subs=0x7fff258c86d0, found=<value optimized out>) at subscribe.c:1952
        db_keys = {0x2b7787557f20, 0x2b7787557e00, 0x2b7787557e10, 0x2b7787557e30, 0x0}
        db_vals = {{type = DB_STR, nul = 0, free = 0, val = {int_val = 6570040, double_val = 3.2460310558028234e-317, time_val = 6570040,
      string_val = 0x644038 "sip:bego at aaaaa.net", str_val = {s = 0x644038 "sip:bego at aaaaa.net", len = 18}, blob_val = {s = 0x644038 "sip:bego at aaaaa.net",
        len = 18}, bitmap_val = 6570040}}, {type = DB_STR, nul = 0, free = 0, val = {int_val = 6335896, double_val = 3.1303485492229706e-317,
      time_val = 6335896,
      string_val = 0x60ad98 "ibc at aaaaa.net>;tag=oyjwd\r\nCall-ID: lwcxkunzzhyazed at portatil-aaaaa.homeip.net\r\nCSeq: 251 SUBSCRIBE\r\nContact: <sip:ibc_aaaaa_net at 87.218.217.85:43125;transport=tcp>\r\nAccept: application/pidf+xml\r\nEvent: "..., str_val = {
        s = 0x60ad98 "ibc at aaaaa.net>;tag=oyjwd\r\nCall-ID: lwcxkunzzhyazed at portatil-aaaaa.homeip.net\r\nCSeq: 251 SUBSCRIBE\r\nContact: <sip:ibc_aaaaa_net at 87.218.217.85:43125;transport=tcp>\r\nAccept: application/pidf+xml\r\nEvent: "..., len = 3}, blob_val = {
        s = 0x60ad98 "ibc at aaaaa.net>;tag=oyjwd\r\nCall-ID: lwcxkunzzhyazed at portatil-aaaaa.homeip.net\r\nCSeq: 251 SUBSCRIBE\r\nContact: <sip:ibc_aaaaa_net at 87.218.217.85:43125;transport=tcp>\r\nAccept: application/pidf+xml\r\nEvent: "..., len = 3}, bitmap_val = 6335896}}, {type = DB_STR, nul = 0, free = 0,
    val = {int_val = 6335900, double_val = 3.130350525485554e-317, time_val = 6335900,
      string_val = 0x60ad9c "aaaaa.net>;tag=oyjwd\r\nCall-ID: lwcxkunzzhyazed at portatil-aaaaa.homeip.net\r\nCSeq: 251 SUBSCRIBE\r\nContact: <sip:ibc_aaaaa_net at 87.218.217.85:43125;transport=tcp>\r\nAccept: application/pidf+xml\r\nEvent: pres"..., str_val = {
        s = 0x60ad9c "aaaaa.net>;tag=oyjwd\r\nCall-ID: lwcxkunzzhyazed at portatil-aaaaa.homeip.net\r\nCSeq: 251 SUBSCRIBE\r\nContact: <sip:ibc_aaaaa_net at 87.218.217.85:43125;transport=tcp>\r\nAccept: application/pidf+xml\r\nEvent: pres"..., len = 9}, blob_val = {
        s = 0x60ad9c "aaaaa.net>;tag=oyjwd\r\nCall-ID: lwcxkunzzhyazed at portatil-aaaaa.homeip.net\r\nCSeq: 251 SUBSCRIBE\r\nContact: <sip:ibc_aaaaa_net at 87.218.217.85:43125;transport=tcp>\r\nAccept: application/pidf+xml\r\nEvent: pres"..., len = 9}, bitmap_val = 6335900}}, {type = DB_STR, nul = 0, free = 0,
    val = {int_val = -2001059224, double_val = 2.3612580507243678e-310, time_val = 47792395010664, string_val = 0x2b7788ba4268 "presence ", str_val = {
        s = 0x2b7788ba4268 "presence ", len = 8}, blob_val = {s = 0x2b7788ba4268 "presence ", len = 8}, bitmap_val = 2293908072}}, {type = DB_INT, nul = 0,
    free = 0, val = {int_val = 0, double_val = 0, time_val = 0, string_val = 0x0, str_val = {s = 0x0, len = 0}, blob_val = {s = 0x0, len = 0},
      bitmap_val = 0}}}
        result_cols = {0x2b7787557ed0, 0x2b7787557ee0, 0x642d20}
        result = (db_res_t *) 0x644060
        row_vals = (db_val_t *) 0x6441d8
        __FUNCTION__ = "get_db_subs_auth"
#2  0x00002b778744f2f4 in handle_subscribe (msg=0x642d20, str1=<value optimized out>, str2=<value optimized out>) at subscribe.c:611
        init_req = 1
        subs = {pres_uri = {s = 0x644038 "sip:bego at aaaaa.net", len = 18}, to_user = {