[asterisk-dev] Lockups in Asterisk 11

[Mark Murawski]

On 11/16/15 10:59, Matthew Jordan wrote:
>

> Things to investigate:
> (1) Get a gdb backtrace when this occurs, so you can find out exactly
> what the AstDB synchronization thread is doing that is blocking for a
> long period of time.
> (2) Find out *exactly* what is occurring on your system. If the AstDB
> synchronization thread is taking a noticeable amount of time to do work,
> you almost certainly have either a problem in your AstDB; have other I/O
> problems on the system; or have something occurring here that is outside
> the control of Asterisk.
>
> Either way, nothing above makes me think there is a bug in Asterisk.
>
> --
> Matthew Jordan
> Digium, Inc. | Director of Technology
> 445 Jan Davis Drive NW - Huntsville, AL 35806 - USA
> Check us out at: http://digium.com & http://asterisk.org
>
>

I'm working on getting a core dump when this happens again.

Something of note I saw this lockup just a few hours ago:

=== Thread ID: 0xb5191b70 (do_monitor           started at [29517] 
chan_sip.c restart_monitor())
=== ---> Lock #0 (chan_sip.c): MUTEX 28923 handle_request_do &netlock 
0xb621b460 (1)
	main/logger.c:1702 ast_bt_get_addresses() (0x813f4ae+19)
	main/lock.c:258 __ast_pthread_mutex_lock() (0x813870f+85)
	channels/chan_sip.c:28926 handle_request_do()
	channels/chan_sip.c:28885 sipsock_read()
	main/io.c:292 ast_io_wait() (0x8132e10+175)
	channels/chan_sip.c:29484 do_monitor()
	main/utils.c:1223 dummy_start()
	:0 start_thread()
	libc.so.6 clone() (0xb76690d0+5E)
=== ---> Lock #1 (chan_sip.c): MUTEX 8959 sip_pvt_lock_full pvt 
0xb3200018 (1)
	main/logger.c:1702 ast_bt_get_addresses() (0x813f4ae+19)
	main/lock.c:258 __ast_pthread_mutex_lock() (0x813870f+85)
	main/astobj2.c:198 __ao2_lock() (0x80906ad+7C)
	channels/chan_sip.c:8960 sip_pvt_lock_full()
	channels/chan_sip.c:28939 handle_request_do()
	channels/chan_sip.c:28885 sipsock_read()
	main/io.c:292 ast_io_wait() (0x8132e10+175)
	channels/chan_sip.c:29484 do_monitor()
	main/utils.c:1223 dummy_start()
	:0 start_thread()
	libc.so.6 clone() (0xb76690d0+5E)
=== -------------------------------------------------------------------
===
=== Thread ID: 0xb3e87b70 (handle_tcptls_connection started at [  745] 
tcptls.c ast_tcptls_server_root())
=== ---> Waiting for Lock #0 (chan_sip.c): MUTEX 28923 handle_request_do 
&netlock 0xb621b460 (1)
	main/logger.c:1702 ast_bt_get_addresses() (0x813f4ae+19)
	main/lock.c:258 __ast_pthread_mutex_lock() (0x813870f+85)
	channels/chan_sip.c:28926 handle_request_do()
	channels/chan_sip.c:3045 _sip_tcp_helper_thread()
	channels/chan_sip.c:2572 sip_tcp_worker_fn()
	main/tcptls.c:694 handle_tcptls_connection()
	main/utils.c:1223 dummy_start()
	:0 start_thread()
	libc.so.6 clone() (0xb76690d0+5E)
=== --- ---> Locked Here: chan_sip.c line 28923 (handle_request_do)
=== -------------------------------------------------------------------
===
=======================================================================

core show locks was this same output over an 8 minute period until 
asterisk was restarted.  All sip traffic stopped processing at this 
point.  I don't have the core file on this, I wish I did, but for some
reason it didn't dump when it was restarted.