[OpenSIPS-Users] Opensips 2.2.3 crash on async.

qasimakhan at gmail.com qasimakhan at gmail.com
Thu Apr 13 05:56:31 EDT 2017


Hi Bogdan,

PFA required logs. Also fund below some more info on the setup i am using.

*OS:*
Distributor ID: SUSE LINUX
Description:    openSUSE Leap 42.1 (x86_64)
Release:        42.1

*Opensips:*
version: opensips 2.2.3 (x86_64/linux)
flags: STATS: On, DISABLE_NAGLE, USE_MCAST, SHM_MMAP, PKG_MALLOC, F_MALLOC,
FAST_LOCK-ADAPTIVE_WAIT
ADAPTIVE_WAIT_LOOPS=1024, MAX_RECV_BUFFER_SIZE 262144, MAX_LISTEN 16,
MAX_URI_SIZE 1024, BUF_SIZE 65535
poll method support: poll, epoll_lt, epoll_et, sigio_rt, select.
git revision: 815a81abb
main.c compiled on 13:56:49 Apr 12 2017 with gcc 4.8

Please also note that i have tried compiling it from git but the problem
persists.

Regards,
Qasim



On Thu, Apr 13, 2017 at 2:26 PM, Bogdan-Andrei Iancu <bogdan at opensips.org>
wrote:

> Hi Qasim,
>
> Thank you for your report. Could you please run a "bt full" in gdb a post
> the output ?
>
> Best regards,
>
> Bogdan-Andrei Iancu
>   OpenSIPS Founder and Developer
>   http://www.opensips-solutions.com
>
> OpenSIPS Summit May 2017 Amsterdam
>   http://www.opensips.org/events/Summit-2017Amsterdam.html
>
> On 04/13/2017 12:09 PM, qasimakhan at gmail.com wrote:
>
> Hi,
>
> I have upgraded my script from 1.11 to 2.2.3 which works fine until i put
> async function on a single rest_get query. When the async line is executed
> i get following errors:
>
> 2017-04-13T14:03:45.320300+05:00 sip01 kernel: [31710929.448312]
>> opensips[11475]: segfault at 10 ip 0000000000427260 sp 00007ffe8c29f6e8
>> error 6 in opensips[400000+228000]
>> 2017-04-13T14:03:45.908172+05:00 sip01 ./sbin/opensips[10993]:
>> WARNING:core:utimer_ticker: utimer task <tm-utimer> already scheduled for
>> 19470 ms (now 19570 ms), it may overlap..
>> 2017-04-13T14:03:46.008338+05:00 sip01 ./sbin/opensips[10993]:
>> WARNING:core:utimer_ticker: utimer task <tm-utimer> already scheduled for
>> 19470 ms (now 19670 ms), it may overlap..
>>
>
> I also have a core dump available, after opening in gdb i get the
> following info:
>
> [Thread debugging using libthread_db enabled]
>> Using host libthread_db library "/lib64/libthread_db.so.1".
>> Core was generated by `./sbin/opensips -P /var/run/opensips.pid'.
>> Program terminated with signal SIGSEGV, Segmentation fault.
>> #0  0x0000000000427260 in context_put_int (type=CONTEXT_GLOBAL, ctx=0x0,
>> pos=4, data=1) at context.c:173
>> 173             ((int *)ctx)[pos] = data;
>>
>
> Please note i will keep core dumps if you guys need some more info on it.
>
> Regards,
> Qasim
>
>
> _______________________________________________
> Users mailing listUsers at lists.opensips.orghttp://lists.opensips.org/cgi-bin/mailman/listinfo/users
>
>
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.opensips.org/pipermail/users/attachments/20170413/3297a2db/attachment-0001.html>
-------------- next part --------------
#0  0x0000000000427260 in context_put_int (type=CONTEXT_GLOBAL, ctx=0x0, pos=4, data=1) at context.c:173
No locals.
#1  0x00007f808e4d27ec in dlg_onreply (t=0x7f80916b9498, type=<optimized out>, param=<optimized out>) at dlg_handlers.c:490
        rpl = 0x7f80d13dbb08
        req = 0x7f80916baef0
        dlg = 0x7f80916b8598
        new_state = 1
        old_state = -1855224504
        unref = 487
        event = 4
        mangled_from = {s = 0x0, len = 0}
        mangled_to = {s = 0x0, len = 0}
        req_out_buff = <optimized out>
#2  0x00007f8090d5d4c9 in run_trans_callbacks (type=type at entry=64, trans=trans at entry=0x7f80916b9498, req=req at entry=0x7f80916baef0, rpl=<optimized out>, code=<optimized out>)
    at t_hooks.c:209
        params = {req = 0x7f80916baef0, rpl = 0x7f80d13dbb08, code = 487, param = 0x7f80916b9120, extra1 = 0x7ffc399fe790, extra2 = 0x7f80916b95b0}
        cbp = 0x7f80916b9110
        backup = 0x847678 <global_avps>
        trans_backup = 0xffffffffffffffff
        __FUNCTION__ = "run_trans_callbacks"
#3  0x00007f8090d5d822 in run_trans_callbacks_locked (type=type at entry=64, trans=trans at entry=0x7f80916b9498, req=0x7f80916baef0, rpl=rpl at entry=0x7f80d13dbb08, code=code at entry=487)
    at t_hooks.c:262
No locals.
#4  0x00007f8090d1523c in relay_reply (t=<optimized out>, p_msg=<optimized out>, branch=<optimized out>, msg_status=<optimized out>, cancel_bitmap=<optimized out>) at t_reply.c:1244
        relay = <optimized out>
        save_clone = <optimized out>
        buf = 0x7f80d14014e0 "SIP/2.0 487 Request Terminated\r\nVia: SIP/2.0/UDP x.x.x.x:5060;branch=z9hG4bK029e.5080a3a5.0\r\nRecord-Route: <sip:z.z.z.z:5060;transport=udp;lr>,<sip:y.y.y.y;lr;did=9e8.ed8a3677>,<sip:"...
        res_len = 503
        relayed_code = 487
        relayed_msg = <optimized out>
        bm = {to_tag_val = {s = 0x7f80d13af6c8 "\b", len = 112}}
        totag_retr = 0
        uas_rb = <optimized out>
        cb_s = {
          s = 0x7f80d14014e0 "SIP/2.0 487 Request Terminated\r\nVia: SIP/2.0/UDP x.x.x.x:5060;branch=z9hG4bK029e.5080a3a5.0\r\nRecord-Route: <sip:z.z.z.z:5060;transport=udp;lr>,<sip:y.y.y.y;lr;did=9e8.ed8a3677>,<sip:"..., len = 503}
        text = {s = 0x82c440 <protos> "", len = -784575864}
        __FUNCTION__ = "relay_reply"
#5  0x00007f8090d1b6a6 in reply_received (p_msg=0x7f80d13dbb08) at t_reply.c:1505
        msg_status = 487
        last_uac_status = 180
        branch = 0
        reply_status = <optimized out>
        timer = 140190162580653
        cancel_bitmap = 0
        uac = 0x7f80916b9670
        t = 0x7f80916b9498
        backup_list = <optimized out>
        has_reply_route = <optimized out>
        __FUNCTION__ = "reply_received"
#6  0x000000000045705d in forward_reply (msg=msg at entry=0x7f80d13dbb08) at forward.c:495
        new_buf = 0x0
        to = 0x0
        new_len = 0
        mod = 0x7f80d13afb88
        proto = <optimized out>
        id = 0
        send_sock = <optimized out>
        s = <optimized out>
        len = <optimized out>
        __FUNCTION__ = "forward_reply"
#7  0x000000000043d376 in receive_msg (
    buf=0x85abc0 <buf> "SIP/2.0 487 Request Terminated\r\nVia: SIP/2.0/UDP x.x.x.x:5060;branch=z9hG4bK029e.6080a3a5.0,SIP/2.0/UDP x.x.x.x:5060;branch=z9hG4bK029e.5080a3a5.0\r\nRecord-Route: <sip:z.z.z.z:5060;tra"..., len=<optimized out>, rcv_info=rcv_info at entry=0x7ffc399fea10, existing_context=existing_context at entry=0x0) at receive.c:257
        ctx = 0x7f80d13dc6d0
        msg = 0x7f80d13dbb08
        start = {tv_sec = 835, tv_usec = 5060}
        rc = 3
        in_buff = {
          s = 0x85abc0 <buf> "SIP/2.0 487 Request Terminated\r\nVia: SIP/2.0/UDP x.x.x.x:5060;branch=z9hG4bK029e.6080a3a5.0,SIP/2.0/UDP x.x.x.x:5060;branch=z9hG4bK029e.5080a3a5.0\r\nRecord-Route: <sip:z.z.z.z:5060;tra"..., len = 563}
        __FUNCTION__ = "receive_msg"
#8  0x00000000005b2923 in udp_read_req (si=<optimized out>, bytes_read=<optimized out>) at net/proto_udp/proto_udp.c:192
        ri = {src_ip = {af = 2, len = 4, u = {addrl = {175825418, 279491920}, addr32 = {175825418, 0, 279491920, 0}, addr16 = {57866, 2682, 0, 0, 46416, 4264, 0, 0},
              addr = "\n\342z\n\000\000\000\000P\265\250\020\000\000\000"}}, dst_ip = {af = 2, len = 4, u = {addrl = {41607690, 0}, addr32 = {41607690, 0, 0, 0}, addr16 = {57866, 634, 0,
                0, 0, 0, 0, 0}, addr = "\n\342z\002", '\000' <repeats 11 times>}}, src_port = 5060, dst_port = 5060, proto = 1, proto_reserved1 = 0, proto_reserved2 = 0, src_su = {s = {
              sa_family = 2, sa_data = "\023\304\n\342z\n\000\000\000\000\000\000\000"}, sin = {sin_family = 2, sin_port = 50195, sin_addr = {s_addr = 175825418},
              sin_zero = "\000\000\000\000\000\000\000"}, sin6 = {sin6_family = 2, sin6_port = 50195, sin6_flowinfo = 175825418, sin6_addr = {__in6_u = {
                  __u6_addr8 = "\000\000\000\000\000\000\000\000\001\000\000\000\000\000\000", __u6_addr16 = {0, 0, 0, 0, 1, 0, 0, 0}, __u6_addr32 = {0, 0, 1, 0}}},
              sin6_scope_id = 4881455}}, bind_address = 0x7f80d13af6c8}
        len = <optimized out>
        buf = "SIP/2.0 487 Request Terminated\r\nVia: SIP/2.0/UDP x.x.x.x:5060;branch=z9hG4bK029e.6080a3a5.0,SIP/2.0/UDP x.x.x.x:5060;branch=z9hG4bK029e.5080a3a5.0\r\nRecord-Route: <sip:z.z.z.z:5060;tra"...
        fromlen = 16
        p = <optimized out>
        msg = {
          s = 0x85abc0 <buf> "SIP/2.0 487 Request Terminated\r\nVia: SIP/2.0/UDP x.x.x.x:5060;branch=z9hG4bK029e.6080a3a5.0,SIP/2.0/UDP x.x.x.x:5060;branch=z9hG4bK029e.5080a3a5.0\r\nRecord-Route: <sip:z.z.z.z:5060;tra"..., len = 563}
        __FUNCTION__ = "udp_read_req"
#9  0x000000000059c220 in handle_io (idx=<optimized out>, event_type=<optimized out>, fm=<optimized out>) at net/net_udp.c:259
        read = 8681456
        fm = <optimized out>
#10 io_wait_loop_epoll (h=<optimized out>, t=<optimized out>, repeat=<optimized out>) at net/../io_wait_loop.h:225
        ret = <optimized out>
        e = <optimized out>
        n = 1
        r = 0
#11 udp_rcv_loop (si=si at entry=0x7f80d13af6c8) at net/net_udp.c:308
        __FUNCTION__ = "udp_rcv_loop"
#12 0x000000000059d748 in udp_start_processes (chd_rank=chd_rank at entry=0x8477f0 <chd_rank>, startup_done=startup_done at entry=0x0) at net/net_udp.c:372
        si = 0x7f80d13af6c8
        load_p = 0x7f80916ae718
        pid = <optimized out>
        i = <optimized out>
        __FUNCTION__ = "udp_start_processes"
#13 0x000000000041c2b0 in main_loop () at main.c:671
        startup_done = 0x0
        chd_rank = 141
#14 main (argc=<optimized out>, argv=<optimized out>) at main.c:1261
        cfg_stream = <optimized out>
        c = <optimized out>
        r = <optimized out>
        tmp = 0x1 <error: Cannot access memory at address 0x1>
        tmp_len = <optimized out>
        port = <optimized out>
        proto = <optimized out>
        protos_no = <optimized out>
        options = 0x5e2490 "f:cCm:M:b:l:n:N:rRvdDFETSVhw:t:u:g:P:G:W:o:"
        ret = -1
        seed = 2324734914
        rfd = <optimized out>
        __FUNCTION__ = "main"


More information about the Users mailing list