Bugs item #3522861, was opened at 2012-05-01 14:11
Message generated for change (Tracker Item Submitted) made by
You can respond by visiting:
https://sourceforge.net/tracker/?func=detail&atid=1086410&aid=3522861&group_id=232389
Please note that this message will contain a full copy of the comment thread,
including the initial issue submission, for this request,
not just the latest update.
Category: core
Group: None
Status: Open
Resolution: None
Priority: 5
Private: No
Submitted By: mammal ()
Assigned to: Nobody/Anonymous (nobody)
Summary: opensips crashes on SSL connection
Initial Comment:
I'm experiencing random crashes with 1.8.0-beta-tls. I managed to recompile
with debug support and the core backtrace is following:
Core was generated by `/usr/local/sbin/opensips'.
Program terminated with signal 11, Segmentation fault.
#0 0x00007f538ccd3bd5 in sk_pop_free () from /usr/lib/libcrypto.so.0.9.8
(gdb) bt
#0 0x00007f538ccd3bd5 in sk_pop_free () from /usr/lib/libcrypto.so.0.9.8
#1 0x00007f538ccdddbe in EVP_PKEY_free () from /usr/lib/libcrypto.so.0.9.8
#2 0x00007f538cd045e5 in X509_get_pubkey_parameters ()
from /usr/lib/libcrypto.so.0.9.8
#3 0x00007f538cd05443 in X509_verify_cert () from /usr/lib/libcrypto.so.0.9.8
#4 0x00007f538cfc3d47 in ssl3_output_cert_chain () from
/usr/lib/libssl.so.0.9.8
#5 0x00007f538cfb6c15 in ssl3_send_server_certificate ()
from /usr/lib/libssl.so.0.9.8
#6 0x00007f538cfba5d8 in ssl3_accept () from /usr/lib/libssl.so.0.9.8
#7 0x000000000050a0d0 in tls_accept (c=0x7f53871eedc8, poll_events=0x0)
at tls/tls_server.c:235
#8 0x000000000050cc46 in tls_fix_read_conn (c=0x7f53871eedc8)
at tls/tls_server.c:888
#9 0x0000000000488883 in tcp_read_req (con=0x7f53871eedc8,
bytes_read=0x7fff2ff6f030) at tcp_read.c:452
#10 0x0000000000489ea0 in handle_io (fm=0x7f538c4bb510, idx=-1) at
tcp_read.c:817
#11 0x0000000000486e95 in io_wait_loop_epoll (h=0x78ea80, t=2, repeat=0)
at io_wait.h:728
#12 0x000000000048a581 in tcp_receive_loop (unix_sock=29) at tcp_read.c:937
#13 0x0000000000484b2e in tcp_init_children (chd_rank=0x783aa8) at
tcp_main.c:1819
#14 0x000000000042dd6a in main_loop () at main.c:941
#15 0x0000000000430395 in main (argc=1, argv=0x7fff2ff6f368) at main.c:1520
last relevant lines in sipis log (debug level 6) are:
May 1 20:38:22 eu /usr/local/sbin/opensips[25375]: DBG:core:parse_uri: parsed
uri:#01
2 type=1 user=<>(0)#012 passwd=<>(0)#012 host=<131.227.7.41>(12)#012
port=<33711>(5):
33711#012 params=<transport=TLS>(13)#012 headers=<>(0)
May 1 20:38:22 eu /usr/local/sbin/opensips[25375]: DBG:core:parse_uri: uri
params:#0
12 transport=<transport=TLS>, val=<TLS>, proto=3
May 1 20:38:22 eu /usr/local/sbin/opensips[25375]: DBG:core:parse_uri:
user-param=
<>, val=<>
May 1 20:38:22 eu /usr/local/sbin/opensips[25375]: DBG:core:parse_uri:
method=<>,
val=<>
May 1 20:38:22 eu /usr/local/sbin/opensips[25375]: DBG:core:parse_uri:
ttl=<>, val
=<>
May 1 20:38:22 eu /usr/local/sbin/opensips[25375]: DBG:core:parse_uri:
maddr=<>, v
al=<>
May 1 20:38:22 eu /usr/local/sbin/opensips[25375]: DBG:core:parse_uri:
lr=<>, val=
<>
May 1 20:38:22 eu /usr/local/sbin/opensips[25375]: DBG:core:parse_uri:
r2=<>, val=
<>
May 1 20:38:23 eu /usr/local/sbin/opensips[25415]:
DBG:core:probe_max_sock_buff: gets
ockopt: snd is initially 262142
May 1 20:38:23 eu /usr/local/sbin/opensips[25415]:
INFO:core:probe_max_sock_buff: usi
ng snd buffer of 255 kb
May 1 20:38:23 eu /usr/local/sbin/opensips[25415]:
INFO:core:init_sock_keepalive: --
TCP keepalive enabled on socket
May 1 20:38:23 eu /usr/local/sbin/opensips[25415]: DBG:core:print_ip:
tcpconn_new: ne
w tcp connection to: 2.49.164.26
May 1 20:38:23 eu /usr/local/sbin/opensips[25415]: DBG:core:tcpconn_new: on
port 4935
1, type 3
May 1 20:38:23 eu /usr/local/sbin/opensips[25415]: DBG:core:tls_tcpconn_init:
entered
: Creating a whole new ssl connection
May 1 20:38:23 eu /usr/local/sbin/opensips[25415]: DBG:core:tls_tcpconn_init:
looking
up socket based TLS server domain [85.17.87.148:7071]
May 1 20:38:23 eu /usr/local/sbin/opensips[25415]:
DBG:core:tls_find_server_domain: v
irtual TLS server domain not found, Using default TLS server domain settings
May 1 20:38:23 eu /usr/local/sbin/opensips[25415]: DBG:core:tls_tcpconn_init:
found s
ocket based TLS server domain [0.0.0.0:0]
May 1 20:38:23 eu /usr/local/sbin/opensips[25415]: DBG:core:tls_tcpconn_init:
Setting
in ACCEPT mode (server)
May 1 20:38:23 eu /usr/local/sbin/opensips[25415]: DBG:core:tcpconn_add:
hashes: 453,
272
May 1 20:38:23 eu /usr/local/sbin/opensips[25415]:
DBG:core:handle_new_connect: new c
onnection: 0x7f53871eedc8 71 flags: 0002
May 1 20:38:23 eu /usr/local/sbin/opensips[25415]: DBG:core:send2child: to tcp
child
0 0(25376), 0x7f53871eedc8
May 1 20:38:23 eu /usr/local/sbin/opensips[25376]: DBG:core:handle_io:
received n=8 c
on=0x7f53871eedc8, fd=32
May 1 20:38:23 eu /usr/local/sbin/opensips[25376]: DBG:core:io_watch_add:
io_watch_ad
d(0x78ea80, 32, 2, 0x7f53871eedc8), fd_no=1
May 1 20:38:23 eu /usr/local/sbin/opensips[25376]: DBG:core:tls_update_fd: New
fd is
32
May 1 20:38:23 eu /usr/local/sbin/opensips[25415]: DBG:core:handle_tcp_child:
dead tc
p child 0 (pid 25376, no 0) (shutting down?)
May 1 20:38:23 eu /usr/local/sbin/opensips[25415]: DBG:core:io_watch_del:
io_watch_de
l (0x78e920, 28, -1, 0x0) fd_no=60 called
May 1 20:38:23 eu /usr/local/sbin/opensips[25415]: CRITICAL:core:receive_fd:
EOF on 30
May 1 20:38:23 eu /usr/local/sbin/opensips[25415]: DBG:core:handle_ser_child:
dead child 15, pid 25376 (shutting down?)
May 1 20:38:23 eu /usr/local/sbin/opensips[25361]: DBG:core:handle_sigs:
status = 139
May 1 20:38:23 eu /usr/local/sbin/opensips[25415]: DBG:core:io_watch_del:
io_watch_del (0x78e920, 30, -1, 0x0) fd_no=59 called
May 1 20:38:23 eu /usr/local/sbin/opensips[25361]: INFO:core:handle_sigs:
child process 25376 exited by a signal 11
May 1 20:38:23 eu /usr/local/sbin/opensips[25361]: INFO:core:handle_sigs: core
was generated
May 1 20:38:23 eu /usr/local/sbin/opensips[25361]: INFO:core:handle_sigs:
terminating due to SIGCHLD
May 1 20:38:23 eu /usr/local/sbin/opensips[25380]: INFO:core:sig_usr: signal
15 received
May 1 20:38:23 eu /usr/local/sbin/opensips[25410]: INFO:core:sig_usr: signal
15 received
May 1 20:38:23 eu /usr/local/sbin/opensips[25401]: INFO:core:sig_usr: signal
15 received
May 1 20:38:23 eu /usr/local/sbin/opensips[25378]: INFO:core:sig_usr: signal
15 received
May 1 20:38:23 eu /usr/local/sbin/opensips[25371]: INFO:core:sig_usr: signal
15 received
May 1 20:38:23 eu /usr/local/sbin/opensips[25399]: INFO:core:sig_usr: signal
15 received
----------------------------------------------------------------------
You can respond by visiting:
https://sourceforge.net/tracker/?func=detail&atid=1086410&aid=3522861&group_id=232389
_______________________________________________
Devel mailing list
Devel@lists.opensips.org
http://lists.opensips.org/cgi-bin/mailman/listinfo/devel
