Re: [OpenSIPS-Users] Opensips3: segfaults

2019-05-06 Thread Abdoul Osséni
Hi Bogdan-Andrei,

Thank you for your email.

There was a new crash. I pull opensis from github.

Syslog:

May  4 00:10:00 sd-131841 /usr/local/sbin/opensips[20910]:
INFO:core:handle_sigs: child process 20937 exited by a signal 11
May  4 00:10:00 sd-131841 /usr/local/sbin/opensips[20910]:
INFO:core:handle_sigs: core was generated
May  4 00:10:00 sd-131841 /usr/local/sbin/opensips[20910]:
INFO:core:handle_sigs: terminating due to SIGCHLD
May  4 00:10:00 sd-131841 /usr/local/sbin/opensips[20912]:
INFO:core:sig_usr: signal 15 received
May  4 00:10:00 sd-131841 /usr/local/sbin/opensips[20913]:
INFO:core:sig_usr: signal 15 received
May  4 00:10:00 sd-131841 /usr/local/sbin/opensips[20911]:
INFO:core:sig_usr: signal 15 received

Core file:

[Thread debugging using libthread_db enabled]
Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1".
Core was generated by `/usr/local/sbin/opensips -P
/var/run/opensips/opensips.pid -m 1024 -M 1024 -u o'.
Program terminated with signal SIGSEGV, Segmentation fault.
#0  strlen () at ../sysdeps/x86_64/strlen.S:106
106../sysdeps/x86_64/strlen.S: No such file or directory.
(gdb) bt full
#0  strlen () at ../sysdeps/x86_64/strlen.S:106
No locals.
#1  0x7fcd22563da8 in _IO_vfprintf_internal (s=s@entry=0x55b002428cb0,
format=,
format@entry=0x55b0005b16a8 "CRITICAL:core:%s: freeing already freed %s
pointer (%p), first free: %s: %s(%ld) - aborting!\n",
ap=ap@entry=0x7fff50594d08)
at vfprintf.c:1637
len = 
string_malloced = 0
string = 0x30343a656d697470 
width = 0
is_short = 
spec = 
step0_jumps = {0, -2199, -2392, -2299, -778, -685, 966, 644, 1362,
1166, 1273, -1287, 547, 639, -2145, -2098, -1198, -1093, -1081, -1069,
-2725, -577, 304, 393, 485, -3452, 63, -3541, -3541, 1073}
base = 
pad = 
step1_jumps = {0, 0, 0, 0, 0, 0, 0, 0, 0, 1166, 1273, -1287, 547,
639, -2145, -2098, -1198, -1093, -1081, -1069, -2725, -577, 304, 393, 485,
-3452, 63, -3541, -3541, 0}
is_negative = 
number = 
use_outdigits = 0
step2_jumps = {0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 1273, -1287, 547, 639,
-2145, -2098, -1198, -1093, -1081, -1069, -2725, -577, 304, 393, 485,
-3452, 63, -3541, -3541, 0}
alt = 0
left = 0
showsign = 
group = 0
is_char = 
step3a_jumps = {0, 0, 0, 0, 0, 0, 0, 0, 0, 0, -1383, 0, 0, 0,
-2145, -2098, -1198, -1093, -1081, 0, 0, 0, 0, 393, 0, 0, 0, 0, 0, 0}
the_arg = {pa_wchar = 1348029555 L'\x50594c73', pa_int =
1348029555, pa_long_int = 140734541417587, pa_long_long_int =
140734541417587, pa_u_int = 1348029555, pa_u_long_int = 140734541417587,
  pa_u_long_long_int = 140734541417587, pa_double =
6.9532102097651782e-310, pa_long_double = , pa_string
= 0x7fff50594c73 "20937\373\037",
  pa_wstring = 0x7fff50594c73 L"\x33393032\x1ffb37", pa_pointer =
0x7fff50594c73, pa_user = 0x7fff50594c73}
space = 
is_long_double = 
is_long = 
step3b_jumps = {0 , 547, 0, 0, -2145, -2098,
-1198, -1093, -1081, -1069, -2725, -577, 304, 393, 485, -3452, 63, 0, 0, 0}
step4_jumps = {0 , -2145, -2098, -1198, -1093,
-1081, -1069, -2725, -577, 304, 393, 485, -3452, 63, 0, 0, 0}
prec = -1
_buffer = {__routine = 0x7fff, __arg = 0x50594c20,
__canceltype = 5, __prev = 0x7fff0001}
_avail = 
thousands_sep = 0x0
grouping = 0x 
done = 
f = 0x55b0005b16ee "s: %s(%ld) - aborting!\n"
lead_str_end = 0x55b0005b16b6 "%s: freeing already freed %s pointer
(%p), first free: %s: %s(%ld) - aborting!\n"
end_of_spec = 
work_buffer =
"\220HYP\377\177\000\000\b\000\000\000\000\000\000\000h\r\000\000\000\000\000\000\260\214B\002\260U\000\000\220MYP\377\177\000\000x\200\300\236\314\177\000\000\230NYP\377\177\000\000\000\000\000\000\000\000\000\000\254\200\300\236\314\177\000\000\271$V\"\315\177\000\000h\r\000\000\000\000\000\000\036\000\000\000D\000\000\000XMYP\377\177\000\000\a\000\000\000\000\000\000\000\370HYP\377\177\000\000\001\000\000\000\000\000\000\000WMYP\377\177\000\000\260\214B\002\260U\000\000\000NYP\377\177\000\000\225\347g\"\315\177\000\000\030NYP\377\177\000\000\000\000\000\000\000\000\000\000\230\347g\"\315\177\000\000\271$V\"\315\177\000\000\000\000\000\000\314\177\000\000"...
workstart = 0x0
workend = 
ap_save = {{gp_offset = 16, fp_offset = 48, overflow_arg_area =
0x7fff50594de0, reg_save_area = 0x7fff50594d20}}
nspecs_done = 
save_errno = 115
readonly_format = 0
__PRETTY_FUNCTION__ = "_IO_vfprintf_internal"
#2  0x7fcd225ff160 in __GI___vsyslog_chk (pri=,
flag=flag@entry=-1, fmt=0x55b0005b16a8 "CRITICAL:core:%s: freeing already
freed %s pointer (%p), first free: %s: %s(%ld) - aborting!\n",
ap=ap@entry=0x7fff50594d08) at ../misc/syslog.c:220
now_tm = {tm_sec = 50, tm_min = 9, tm_hour = 0, tm_mday = 4, tm_mon

Re: [OpenSIPS-Users] Opensips3: segfaults

2019-05-06 Thread Abdoul Osséni
Hi,

New crash on opensips3.

Syslog:

May  4 00:10:00 sd-131841 /usr/local/sbin/opensips[20910]:
INFO:core:handle_sigs: child process 20937 exited by a signal 11
May  4 00:10:00 sd-131841 /usr/local/sbin/opensips[20910]:
INFO:core:handle_sigs: core was generated
May  4 00:10:00 sd-131841 /usr/local/sbin/opensips[20910]:
INFO:core:handle_sigs: terminating due to SIGCHLD
May  4 00:10:00 sd-131841 /usr/local/sbin/opensips[20912]:
INFO:core:sig_usr: signal 15 received

Crashdump:

Please find attached.

Thanks.

Abdoul OSSENI
Ingénieur DevOps chez Néo-Soft
Co-Fondateur de ON SERVICES
Tél : +33 601 135 167


Le mar. 23 avr. 2019 à 17:40, Abdoul Osséni  a
écrit :

> Hello,
>
> I am testing Opensips3 (last commit from github) and I encounter an issue:
>
> dmesg:
> [Tue Apr 23 17:03:27 2019] traps: opensips[16387] general protection
> ip:7f86ed1a2676 sp:7ffef01c70b8 error:0
>
> below is the log of opensips
> Apr 23 17:04:11 sd-152273 /usr/local/sbin/opensips[16387]:
> CRITICAL:core:sig_usr: segfault in process pid: 16387, id: 28
> Apr 23 17:04:11 sd-152273 /usr/local/sbin/opensips[16359]:
> INFO:core:handle_sigs: child process 16387 exited by a signal 11
> Apr 23 17:04:11 sd-152273 /usr/local/sbin/opensips[16359]:
> INFO:core:handle_sigs: core was not generated
> Apr 23 17:04:11 sd-152273 /usr/local/sbin/opensips[16359]:
> INFO:core:handle_sigs: terminating due to SIGCHLD
> Apr 23 17:04:11 sd-152273 /usr/local/sbin/opensips[16360]:
> INFO:core:sig_usr: signal 15 received
> Apr 23 17:04:11 sd-152273 /usr/local/sbin/opensips[16359]:
> INFO:core:shutdown_opensips: process 7(16366) [SIP receiver
> udp:x.x.x.x:5060] terminated, still waiting for 27 more
> Apr 23 17:04:11 sd-152273 /usr/local/sbin/opensips[16362]:
> INFO:core:sig_usr: signal 15 received
> Apr 23 17:04:11 sd-152273 /usr/local/sbin/opensips[16359]:
> INFO:core:shutdown_opensips: process 3(16362) [timer] terminated, still
> waiting for 26 more
> Apr 23 17:04:11 sd-152273 /usr/local/sbin/opensips[16359]:
> INFO:core:shutdown_opensips: process 5(16364) [SIP receiver
> udp:x.x.x.x:5060] terminated, still waiting for 25 more
> Apr 23 17:04:11 sd-152273 /usr/local/sbin/opensips[16359]:
> INFO:core:shutdown_opensips: process 6(16365) [SIP receiver
> udp:x.x.x.x:5060] terminated, still waiting for 24 more
> Apr 23 17:04:11 sd-152273 /usr/local/sbin/opensips[16359]:
> INFO:core:shutdown_opensips: process 12(16371) [SIP receiver
> hep_udp:x.x.x.x:6060] terminated, still waiting for 23 more
> Apr 23 17:04:11 sd-152273 /usr/local/sbin/opensips[16359]:
> INFO:core:shutdown_opensips: process 14(16373) [SIP receiver
> hep_udp:x.x.x.x:6060] terminated, still waiting for 22 more
> Apr 23 17:04:11 sd-152273 /usr/local/sbin/opensips[16359]:
> INFO:core:shutdown_opensips: process 15(16374) [SIP receiver
> hep_udp:x.x.x.x:6060] terminated, still waiting for 21 more
> Apr 23 17:04:11 sd-152273 /usr/local/sbin/opensips[16359]:
> INFO:core:shutdown_opensips: process 17(16376) [SIP receiver
> hep_udp:x.x.x.x:6060] terminated, still waiting for 20 more
> Apr 23 17:04:11 sd-152273 /usr/local/sbin/opensips[16359]:
> INFO:core:shutdown_opensips: process 18(16377) [SIP receiver
> hep_udp:x.x.x.x:6060] terminated, still waiting for 19 more
> Apr 23 17:04:11 sd-152273 /usr/local/sbin/opensips[16359]:
> INFO:core:shutdown_opensips: process 19(16378) [SIP receiver
> hep_udp:x.x.x.x:6060] terminated, still waiting for 18 more
> Apr 23 17:04:11 sd-152273 /usr/local/sbin/opensips[16361]:
> INFO:core:sig_usr: signal 15 received
> Apr 23 17:04:11 sd-152273 /usr/local/sbin/opensips[16359]:
> INFO:core:shutdown_opensips: process 2(16361) [time_keeper] terminated,
> still waiting for 17 more
> Apr 23 17:04:11 sd-152273 /usr/local/sbin/opensips[16359]:
> INFO:core:shutdown_opensips: process 20(16379) [TCP receiver] terminated,
> still waiting for 16 more
> Apr 23 17:04:11 sd-152273 /usr/local/sbin/opensips[16359]:
> INFO:core:shutdown_opensips: process 21(16380) [TCP receiver] terminated,
> still waiting for 15 more
> Apr 23 17:04:11 sd-152273 /usr/local/sbin/opensips[16359]:
> INFO:core:shutdown_opensips: process 22(16381) [TCP receiver] terminated,
> still waiting for 14 more
> Apr 23 17:04:11 sd-152273 /usr/local/sbin/opensips[16359]:
> INFO:core:shutdown_opensips: process 23(16382) [TCP receiver] terminated,
> still waiting for 13 more
> Apr 23 17:04:11 sd-152273 /usr/local/sbin/opensips[16359]:
> INFO:core:shutdown_opensips: process 24(16383) [TCP receiver] terminated,
> still waiting for 12 more
> Apr 23 17:04:11 sd-152273 /usr/local/sbin/opensips[16359]:
> INFO:core:shutdown_opensips: process 25(16384) [TCP receiver] terminated,
> still waiting for 11 more
> Apr 23 17:04:11 sd-152273 /usr/local/sbin/opensips[16359]:
> INFO:core:shutdown_opensips: process 26(16385) [TCP receiver] terminated,
> still waiting for 10 more
> Apr 23 17:04:11 sd-152273 /usr/local/sbin/opensips[16359]:
> INFO:core:shutdown_opensips: process 27(16386) [TCP receiver] terminated,
> still waiting for 9 more
> Apr 23 1