[OpenSIPS-Users] opensips crash

Bogdan-Andrei Iancu bogdan at voice-system.ro
Sat Mar 27 14:20:27 CET 2010


Hi Daniel,

The crash shows an internal timeout (internal 408), triggering a failure 
route; there a new branch is added and branch route is triggered (for 
the new branch). While trying to run the branch route , there is this 
crash. If you still have the core file, in frame 0, please print 
request->dst_uri.s and request->dst_uri.len

Thanks and regards,
Bogdan


Daniel Ribeiro wrote:
> (gdb) file /usr/local/sbin/opensips
> (gdb) core-file /var/core/opensips.sig-11.pid-14612.time-1269526223
> warning: Can't read pathname for load map: Input/output error.
> Core was generated by `/usr/local/sbin/opensips -P /var/run/opensips.pid'.
> Program terminated with signal 11, Segmentation fault.
> [New process 14612]
> #0  0xb7573031 in pre_print_uac_request (t=0xb56156c0, branch=1, 
> request=0xb75a10a0) at t_fwd.c:132
>     in t_fwd.c
> (gdb) bt full
> #0  0xb7573031 in pre_print_uac_request (t=0xb56156c0, branch=1, 
> request=0xb75a10a0) at t_fwd.c:132
>     backup_route_type = <value optimized out>
>     backup_list = <value optimized out>
>     p = 0x81ce3c8 ""
>     __FUNCTION__ = "pre_print_uac_request"
> #1  0xb75735bf in add_uac (t=0xb56156c0, request=0x3fffffff, 
> uri=0xbfafc61c, next_hop=0xbfafc624, path=0xb75a13bc, proxy=0x0) at 
> t_fwd.c:400
>     branch = <value optimized out>
>     do_free_proxy = <value optimized out>
>     ret = 1
>     __FUNCTION__ = "add_uac"
> #2  0xb75751c6 in t_forward_nonack (t=0xb56156c0, p_msg=0xb75a10a0, 
> proxy=0x0) at t_fwd.c:625
>     backup_dst = {s = 0x0, len = -1}
>     branch_ret = <value optimized out>
>     lowest_ret = <value optimized out>
>     current_uri = {s = 0x81ce470 "sip:13 at 192.168.1.200 
> <mailto:sip%3A13 at 192.168.1.200>", len = 20}
>     added_branches = <value optimized out>
>     i = <value optimized out>
>     q = 384
>     t_invite = <value optimized out>
>     success_branch = <value optimized out>
>     dst_uri = {s = 0xb561692e 
> "192.168.1.2;branch=z9hG4bK+016f8dbee9d2fef04db473d1e2e2a27d1+192.168.1.2+1\r\nRequire: 
> 100rel\r\nMax-Forwards: 69\r\nCall-ID: DB817055 at 192.168.1.2 
> <mailto:DB817055 at 192.168.1.2>\r\nFrom: <sip:12 at 192.168.1.200 
> <mailto:sip%3A12 at 192.168.1.200>>;tag=192.168.1.2+1+1060000+317"..., 
> len = 11}
>     bk_sock = (struct socket_info *) 0x81c9848
>     br_flags = <value optimized out>
>     bk_br_flags = 0
>     idx = <value optimized out>
>     path = {s = 0xffffffff <Address 0xffffffff out of bounds>, len = 77}
>     __FUNCTION__ = "t_forward_nonack"
> #3  0xb758294d in w_t_relay (p_msg=0xb75a10a0, proxy=0x0, flags=<value 
> optimized out>) at tm.c:1101
>     t = (struct cell *) 0xffffffff
>     ret = <value optimized out>
>     __FUNCTION__ = "w_t_relay"
> #4  0x08056094 in do_action (a=0x81c9590, msg=0xb75a10a0) at action.c:962
>     val_s = {s = 0xb76fdff4 "\234­\024", len = 0}
>     aux = {s = 0x3 <Address 0x3 out of bounds>, len = 3}
>     ret = <value optimized out>
>     v = <value optimized out>
>     to = <value optimized out>
>     p = <value optimized out>
>     tmp = <value optimized out>
>     new_uri = <value optimized out>
>     end = <value optimized out>
>     crt = <value optimized out>
>     len = <value optimized out>
>     user = <value optimized out>
>     uri = {user = {s = 0x0, len = -1217400480}, passwd = {s = 
> 0xbfafc8a0 "\210\212\034\b \020Z·", len = -1218310995}, host = {s = 
> 0x81c8ab0 "\001", len = -1218834272}, port = {s = 0x4 <Address 0x4 out 
> of bounds>, len = -1078998616}, params = {s = 0x80b09dc 
> "\211Æë \213\025$½\027\b\203:þ}\a¾ÿÿÿÿë\216¡(½\027\b\205À\017\204\231\a", 
> len = 136088200}, headers = {s = 0xb75a10a0 "\005", len = 0}, port_no 
> = 15836, proto = 2092, type = 3077566864, transport = {s = 0xb76fdff4 
> "\234­\024", len = 137102144}, ttl = {s = 0x82c3dcd "", len = 
> -1078998808}, user_param = {s = 0xb7639eed "\213\213¼3", len = 
> -1218327157}, maddr = {s = 0xb76fdff4 "\234­\024", len = 137117344}, 
> method = {s = 0x17160 <Address 0x17160 out of bounds>, len = 
> -1078998704}, lr = {s = 0xb761e88e 
> "é\026ýÿÿ\003}´\211Á\213U¬\211ø\203È\001\211B\004\211Q0éåüÿÿ\213E¸\211D$\b\203æ\002\215\203\021:þÿ\211D$\004\2114$èÉ\200ÿÿé\235ûÿÿ\215\203ä\"þÿ\203ç\002\211D$\b\215\203\021:þÿ\211<$\211÷\211D$\004è£\200ÿÿéÎýÿÿ\215\203ä\"þÿ\211D$\b\215\203\021:þÿ\211D$\004\203eÀ\002\213UÀ\211\024$è{\200ÿÿ\211u¬é\023üÿÿ\215\203ä\"þÿ\203æ\002\211D$\b\215\203\021:þÿ\211D$\004\2114$èT\200ÿÿé\210þÿÿ\213\203\234\021", 
> len = -1217523652}, r2 = {s = 0x33323dcd <Address 0x33323dcd out of 
> bounds>, len = -1217404940}, transport_val = {s = 0x82c3dd4 "", len = 
> -1217407968}, ttl_val = {s = 0xbfafca38 "ìʯ¿?ch·È=,\bÈ=,\b\001", len 
> = -1218182914}, user_param_val = {s = 0x82c3ea0 "", len = 1}, 
> maddr_val = {s = 0x15238 <Address 0x15238 out of bounds>, len = 
> -1217514240}, method_val = {s = 0x0, len = 0}, lr_val = {s = 
> 0xb7640df2 "\213}¸\213E¨\2154\aéwíÿÿ\213E¸\211t$\bÇD$\0040", len = 
> 137117146}, r2_val = {s = 0xbfafca46 ",\b\001", len = 137117136}}
>         next_hop = {user = {s = 0x82c3e1b "", len = -1218864023}, 
> passwd = {s = 0x1e <Address 0x1e out of bounds>, len = -1218863989}, 
> host = {s = 0xb7599c8b "", len = 137117251}, port = {s = 0xb76fdff4 
> "\234­\024", len = 8180}, params = {s = 0x2 <Address 0x2 out of 
> bounds>, len = -1078997480}, headers = {s = 0xb75f17cf 
> "9Ç\017\205­ýÿÿ\213µ|úÿÿ\001½xúÿÿ\200>", len = 137116752}, port_no = 
> 40073, proto = 46937, type = SIPS_URI_T, transport = {s = 0x0, len = 
> 2}, ttl = {s = 0xb761e3e1 "\201Ã\023ü\r", len = -1218498561}, 
> user_param = {s = 0x802 <Address 0x802 out of bounds>, len = 0}, maddr 
> = {s = 0x0, len = 942243}, method = {s = 0xb76fcfe0 "\205\006n·", len 
> = 11}, lr = {s = 0x82c0388 "BRT", len = 8}, r2 = {s = 0xb76df233 "", 
> len = 0}, transport_val = {s = 0x0, len = 2}, ttl_val = {s = 0x0, len 
> = 4096}, user_param_val = {s = 0xffffffff <Address 0xffffffff out of 
> bounds>, len = 0}, maddr_val = {s = 0x0, len = 0}, method_val = {s = 
> 0x4b98d43d <Address 0x4b98d43d out of bounds>, len = 0}, lr_val = {s = 
> 0x4b98d43d <Address 0x4b98d43d out of bounds>, len = 0}, r2_val = {s = 
> 0xe60a3 <Address 0xe60a3 out of bounds>, len = 0}}
>     u = <value optimized out>
>     port = <value optimized out>
>     cmatch = <value optimized out>
>     aitem = <value optimized out>
>     adefault = <value optimized out>
>     spec = <value optimized out>
>     model = <value optimized out>
>     val = {rs = {s = 0xb76fdff4 "\234­\024", len = -1078998548}, ri = 
> -1217950493, flags = -1217404940}
>     name_s = {s = 0x2009 <Address 0x2009 out of bounds>, len = 
> -1078998620}
>     __FUNCTION__ = "do_action"
> #5  0x08054a60 in run_action_list (a=0x81c8be8, msg=0xb75a10a0) at 
> action.c:139
>     ret = 1
>     t = (struct action *) 0x81c9590
>     __FUNCTION__ = "run_action_list"
> #6  0x080581b5 in do_action (a=0x81c9660, msg=0xb75a10a0) at action.c:706
>     val_s = {s = 0x83 <Address 0x83 out of bounds>, len = 137117128}
>     aux = {s = 0x82c3dc8 "", len = 0}
>     ret = <value optimized out>
>     v = 1
>     to = <value optimized out>
>     p = <value optimized out>
>     tmp = <value optimized out>
>     new_uri = <value optimized out>
>     end = <value optimized out>
>     crt = <value optimized out>
>     len = <value optimized out>
>     user = <value optimized out>
>     uri = {user = {s = 0x82c3dc8 "", len = 21}, passwd = {s = 
> 0x82c3c50 "\002", len = 6}, host = {s = 0x30 <Address 0x30 out of 
> bounds>, len = -1219590740}, port = {s = 0x0, len = 0}, params = {s = 
> 0xb76fdff4 "\234­\024", len = 21}, headers = {s = 0x82c3c50 "\002", 
> len = -1078997940}, port_no = 33164, proto = 46926, type = 3075375696, 
> transport = {s = 0xb74f9ca0 "\230\001", len = -1078997912}, ttl = {s = 
> 0xb74e526a "\2136\213M¤\213\201", len = -1218834272}, user_param = {s 
> = 0xffffffff <Address 0xffffffff out of bounds>, len = -1217400480}, 
> maddr = {s = 0x15 <Address 0x15 out of bounds>, len = 0}, method = {s 
> = 0x17 <Address 0x17 out of bounds>, len = 10}, lr = {s = 0xb <Address 
> 0xb out of bounds>, len = 25}, r2 = {s = 0x2 <Address 0x2 out of 
> bounds>, len = 110}, transport_val = {s = 0x4 <Address 0x4 out of 
> bounds>, len = 83}, ttl_val = {s = 0x0, len = -10800}, user_param_val 
> = {s = 0x82c0388 "BRT", len = 137116752}, maddr_val = {s = 0x0, len = 
> 0}, method_val = {s = 0xb76fdff4 "\234­\024", len = 21}, lr_val = {s = 
> 0x82c3c50 "\002", len = -1078997828}, r2_val = {s = 0xb75a10a0 "\005", 
> len = -1}}
>         next_hop = {user = {s = 0xb761ed91 "\201Ãcò\r", len = 
> -1218182914}, passwd = {s = 0x82c3dc8 "", len = 0}, host = {s = 0xd8 
> <Address 0xd8 out of bounds>, len = 137117128}, port = {s = 0x4bab6ecf 
> <Address 0x4bab6ecf out of bounds>, len = -1219591796}, params = {s = 
> 0x85 <Address 0x85 out of bounds>, len = 18}, headers = {s = 
> 0xbfafcb08 "¨Ë¯¿µ\035N·\205", len = -1217894694}, port_no = 133, proto 
> = 0, type = 4294967295, transport = {s = 0xb74e6d94 
> "%.*stimestamp=%lu%s", len = -1078998248}, ttl = {s = 0xbfafcb18 
> "\022", len = -1078998104}, user_param = {s = 0xb74e1db5 
> "éÕüÿÿ\215»´\003", len = 133}, maddr = {s = 0xb74e6d94 
> "%.*stimestamp=%lu%s", len = 18}, method = {s = 0xb74e75db "ACC: call 
> missed: ", len = 1269526223}, lr = {s = 0xb74e8540 
> ";method=INVITE;from_tag=192.168.1.2+1+1060000+3177bc97;to_tag=;call_id=DB817055 at 192.168.1.2 
> <mailto:DB817055 at 192.168.1.2>;code=408;reason=Request Timeout\n", len 
> = 137116752}, r2 = {s = 0xbfafcb44 "@\210O·`ño·P<,\b", len = 
> -1218335013}, transport_val = {s = 0xb74f8580 "øhaµ\006", len = 
> -1217400480}, ttl_val = {s = 0x82c3c50 "\002", len = 6}, 
> user_param_val = {s = 0xb74f8840 "ÀlN·\006", len = -1217400480}, 
> maddr_val = {s = 0x82c3c50 "\002", len = 0}, method_val = {s = 0x0, 
> len = -1219590747}, lr_val = {s = 0x82c3dc8 "", len = -1078998120}, 
> r2_val = {s = 0xb76224f0 "e\203=\f", len = -1217400480}}
>     u = <value optimized out>
>     port = <value optimized out>
>     cmatch = <value optimized out>
>     aitem = <value optimized out>
>     adefault = <value optimized out>
>     spec = <value optimized out>
>     model = <value optimized out>
>     val = {rs = {s = 0x198 <Address 0x198 out of bounds>, len = 17}, 
> ri = 16384, flags = -1217407968}
>     name_s = {s = 0x12 <Address 0x12 out of bounds>, len = 136110864}
>     __FUNCTION__ = "do_action"
> #7  0x08054a60 in run_action_list (a=0x81c7af0, msg=0xb75a10a0) at 
> action.c:139
>     ret = 1
>     t = (struct action *) 0x81c9660
>     __FUNCTION__ = "run_action_list"
> #8  0x0805958e in run_top_route (a=0x81c7af0, msg=0xb75a10a0) at 
> action.c:119
>     bk_action_flags = 0
>     bk_rec_lev = 0
> #9  0xb758fc6b in t_should_relay_response (Trans=0xb56156c0, 
> new_code=408, branch=0, should_store=0xbfafce84, 
> should_relay=0xbfafce88, cancel_bitmap=0xbfafced8, reply=0xffffffff) 
> at t_reply.c:612
>     branch_cnt = 1
>     picked_code = 800
>     inv_through = <value optimized out>
>     do_cancel = 0
>     __FUNCTION__ = "t_should_relay_response"
> #10 0xb7591b3a in relay_reply (t=0xb56156c0, p_msg=0xffffffff, 
> branch=0, msg_status=408, cancel_bitmap=0xbfafced8) at t_reply.c:1124
>     relay = <value optimized out>
>     save_clone = <value optimized out>
>     buf = <value optimized out>
>     res_len = 0
>     relayed_code = 408
>     relayed_msg = <value optimized out>
>     bm = {to_tag_val = {s = 0x0, len = 1}}
>     totag_retr = <value optimized out>
>     reply_status = 3077559328
>     uas_rb = <value optimized out>
>     cb_s = {s = 0x82c0388 "BRT", len = -1217407968}
>     text = {s = 0x0, len = -10800}
>     __FUNCTION__ = "relay_reply"
> #11 0xb757729b in fake_reply (t=0xb56156c0, branch=0, code=408) at 
> timer.c:259
>     cancel_bitmap = 1
>     do_cancel_branch = 1
>     reply_status = <value optimized out>
> #12 0xb757a66c in timer_routine (ticks=128, attr=0x0) at timer.c:365
>     tl = (struct timer_link *) 0xb5610074
>     tmp_tl = (struct timer_link *) 0x0
>     id = 1
>     __FUNCTION__ = "timer_routine"
> #13 0x080da26c in start_timer_processes () at timer.c:325
>     tpl = (struct sr_timer_process *) 0x81c9e28
>     pid = <value optimized out>
>     __FUNCTION__ = "start_timer_processes"
> #14 0x08072366 in main (argc=3, argv=0xbfafd164) at main.c:867
>     cfg_log_stderr = 0
>     cfg_stream = (FILE *) 0x82ba008
>     c = <value optimized out>
>     r = <value optimized out>
>     tmp = 0x817b0f8 
> "\024°\027\bhÖt·pLt·PLa·B=\005\b@\231\\·b=\005\br=\005\b\220\032^·P\232g·¢=\005\b²=\005\b°ih·"
>     tmp_len = <value optimized out>
>     port = <value optimized out>
>     proto = <value optimized out>
>     ret = <value optimized out>
>     seed = 2328917369
>     rfd = 4
>     __FUNCTION__ = "main"
> (gdb)
>
> On Thu, Mar 25, 2010 at 10:13 AM, Anca Vamanu <anca at opensips.org 
> <mailto:anca at opensips.org>> wrote:
>
>     Hi Daniel,
>
>     Please investigate the core file with gdb. Print in an email the
>     output
>     for 'bt full'.
>
>     Regards,
>
>     --
>     Anca Vamanu
>     www.voice-system.ro <http://www.voice-system.ro>
>
>
>     Daniel Ribeiro wrote:
>     > Hi guys,
>     >
>     > Trying to do call forward no answer with early media enabled crash
>     > opensips. Did you know where I can found teh core dump file
>     generated?
>     > Thanks,
>     >
>     >
>     > Mar 25 09:25:14 danielribeiro /usr/local/sbin/opensips[13515]:
>     > forwarded to: sip:13 at 192.168.1.200
>     <mailto:sip%3A13 at 192.168.1.200> <mailto:sip%3A13 at 192.168.1.200
>     <mailto:sip%253A13 at 192.168.1.200>>
>     > Mar 25 09:25:14 danielribeiro /usr/local/sbin/opensips[13515]:
>     > DBG:core:parse_headers: flags=ffffffffffffffff
>     > Mar 25 09:25:14 danielribeiro /usr/local/sbin/opensips[13515]:
>     > DBG:core:check_ip_address: params 192.168.1.2, 192.168.1.2, 0
>     > Mar 25 09:25:14 danielribeiro /usr/local/sbin/opensips[13515]:
>     > DBG:tm:_reply_light: reply sent out. buf=0x81ce520: SIP/2.0 1...,
>     > shmem=0xb56a70c8: SIP/2.0 1
>     > Mar 25 09:25:14 danielribeiro /usr/local/sbin/opensips[13515]:
>     > DBG:tm:_reply_light: finished
>     > *Mar 25 09:25:14 danielribeiro kernel: [261741.899815]
>     > opensips[13515]: segfault at 00000000 eip b7601031 esp bff31010
>     error 4*
>     > Mar 25 09:25:14 danielribeiro /usr/local/sbin/opensips[13509]:
>     > INFO:core:handle_sigs: child process 13515 exited by a signal 11
>     > *Mar 25 09:25:14 danielribeiro /usr/local/sbin/opensips[13509]:
>     > INFO:core:handle_sigs: core was generated *
>     > Mar 25 09:25:14 danielribeiro /usr/local/sbin/opensips[13509]:
>     > INFO:core:handle_sigs: terminating due to SIGCHLD
>     > Mar 25 09:25:14 danielribeiro /usr/local/sbin/opensips[13516]:
>     > INFO:core:sig_usr: signal 15 received
>     > Mar 25 09:25:14 danielribeiro /usr/local/sbin/opensips[13517]:
>     > INFO:core:sig_usr: signal 15 received
>     > Mar 25 09:25:14 danielribeiro /usr/local/sbin/opensips[13514]:
>     > INFO:core:sig_usr: signal 15 received
>     > Mar 25 09:25:14 danielribeiro /usr/local/sbin/opensips[13513]:
>     > INFO:core:sig_usr: signal 15 received
>     > Mar 25 09:25:14 danielribeiro /usr/local/sbin/opensips[13512]:
>     > INFO:core:sig_usr: signal 15 received
>     > Mar 25 09:25:14 danielribeiro /usr/local/sbin/opensips[13511]:
>     > INFO:core:sig_usr: signal 15 received
>     > Mar 25 09:25:14 danielribeiro /usr/local/sbin/opensips[13518]:
>     > INFO:core:sig_usr: signal 15 received
>     > Mar 25 09:25:14 danielribeiro /usr/local/sbin/opensips[13509]:
>     > DBG:db_text:destroy: destroy ...
>     > Mar 25 09:25:14 danielribeiro /usr/local/sbin/opensips[13509]:
>     > DBG:xlog:destroy: destroy module...
>     > Mar 25 09:25:14 danielribeiro /usr/local/sbin/opensips[13509]:
>     > DBG:tm:tm_shutdown: tm_shutdown : start
>     > Mar 25 09:25:14 danielribeiro /usr/local/sbin/opensips[13509]:
>     > DBG:tm:unlink_timer_lists: emptying DELETE list
>     > Mar 25 09:25:14 danielribeiro /usr/local/sbin/opensips[13509]:
>     > DBG:tm:tm_shutdown: emptying hash table
>     > Mar 25 09:25:14 danielribeiro /usr/local/sbin/opensips[13509]:
>     > DBG:tm:tm_shutdown: releasing timers
>     > Mar 25 09:25:14 danielribeiro /usr/local/sbin/opensips[13509]:
>     > DBG:tm:tm_shutdown: removing semaphores
>     > Mar 25 09:25:14 danielribeiro /usr/local/sbin/opensips[13509]:
>     > DBG:tm:tm_shutdown: destroying callback lists
>     > Mar 25 09:25:14 danielribeiro /usr/local/sbin/opensips[13509]:
>     > DBG:tm:tm_shutdown: tm_shutdown : done
>     > Mar 25 09:25:14 danielribeiro /usr/local/sbin/opensips[13509]:
>     > DBG:core:shm_mem_destroy:
>     > Mar 25 09:25:14 danielribeiro /usr/local/sbin/opensips[13509]:
>     > DBG:core:shm_mem_destroy: destroying the shared memory lock
>     > Mar 25 09:25:14 danielribeiro /usr/local/sbin/opensips[13509]:
>     > DBG:core:handle_sigs: terminating due to SIGCHLD
>     >
>     >
>     > --
>     > Daniel Ribeiro
>     >
>     ------------------------------------------------------------------------
>     >
>     > _______________________________________________
>     > 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 <mailto:Users at lists.opensips.org>
>     http://lists.opensips.org/cgi-bin/mailman/listinfo/users
>
>
>
>
> -- 
> Daniel Ribeiro
> ------------------------------------------------------------------------
>
> _______________________________________________
> Users mailing list
> Users at lists.opensips.org
> http://lists.opensips.org/cgi-bin/mailman/listinfo/users
>   


-- 
Bogdan-Andrei Iancu
www.voice-system.ro




More information about the Users mailing list