[Home]

Summary:ASTERISK-19556: Asteriskt thread use 99% cpu
Reporter:Alexey (al.gusev)Labels:
Date Opened:2012-03-18 13:03:11Date Closed:2012-03-19 08:47:22
Priority:MajorRegression?
Status:Closed/CompleteComponents:General
Versions:1.8.10.0 Frequency of
Occurrence
Related
Issues:
Environment:Supermicro server Intel Xenon E5620 , 8GB RAM , CentOS 5.8 x64Attachments:
Description:Sometimes one of Asterisk's thread take ~100% cpu. It happens once a day and overloading system. How can i fix it ?

# ps -LlFm -p 21993
F S UID        PID  PPID   LWP  C NLWP PRI  NI ADDR SZ WCHAN    RSS PSR STIME TTY          TIME CMD
4 - asterisk 21993 21990     - 27   82   -   - - 209507 -     92096   - 13:35 pts/2    01:09:06 /usr/sbin/asterisk -f -U asterisk -G asterisk -vvvg -c
4 S asterisk     -     - 21993  0    -  76   0 -     - 32767      -   6 13:35 -        00:00:00 -
5 S asterisk     -     - 21994  0    -  75   0 -     - inotif     -   3 13:35 -        00:00:00 -
1 S asterisk     -     - 21995  0    -  75   0 -     - futex_     -   2 13:35 -        00:00:00 -
1 S asterisk     -     - 21996  0    -  75   0 -     - -          -   7 13:35 -        00:00:00 -
1 S asterisk     -     - 21997  0    -  75   0 -     - futex_     -   7 13:35 -        00:00:00 -
1 S asterisk     -     - 21998  0    -  75   0 -     - 295803     -   0 13:35 -        00:00:00 -
1 S asterisk     -     - 21999  0    -  80   0 -     - 171798     -   3 13:35 -        00:00:06 -
1 S asterisk     -     - 22000  0    -  75   0 -     - -          -   4 13:35 -        00:00:03 -
1 S asterisk     -     - 22001  0    -  75   0 -     - futex_     -   3 13:35 -        00:00:00 -
1 S asterisk     -     - 22002  0    -  75   0 -     - futex_     -   1 13:35 -        00:00:00 -
1 S asterisk     -     - 22003  0    -  75   0 -     - -          -   2 13:35 -        00:00:00 -
1 S asterisk     -     - 22004  0    -  76   0 -     - futex_     -   7 13:35 -        00:00:00 -
1 S asterisk     -     - 22005  0    -  75   0 -     - futex_     -   7 13:35 -        00:00:00 -
1 S asterisk     -     - 22006  0    -  75   0 -     - futex_     -   3 13:35 -        00:00:00 -
1 S asterisk     -     - 22007  0    -  75   0 -     - futex_     -   4 13:35 -        00:00:00 -
1 S asterisk     -     - 22020  0    -  75   0 -     - futex_     -   2 13:35 -        00:00:25 -
1 S asterisk     -     - 22021  0    -  75   0 -     - -          -   7 13:35 -        00:00:00 -
1 S asterisk     -     - 22022  0    -  75   0 -     - -          -   1 13:35 -        00:00:00 -
1 S asterisk     -     - 22023  2    -  75   0 -     - -          -   0 13:35 -        00:05:55 -
1 S asterisk     -     - 22024  0    -  75   0 -     - futex_     -   7 13:35 -        00:00:00 -
1 S asterisk     -     - 22025  0    -  75   0 -     - futex_     -   0 13:35 -        00:00:00 -
1 S asterisk     -     - 22026  0    -  75   0 -     - futex_     -   0 13:35 -        00:00:00 -
1 S asterisk     -     - 22027  0    -  75   0 -     - futex_     -   0 13:35 -        00:00:00 -
1 S asterisk     -     - 22028  0    -  75   0 -     - futex_     -   0 13:35 -        00:00:00 -
1 S asterisk     -     - 22029  0    -  75   0 -     - futex_     -   0 13:35 -        00:00:00 -
1 S asterisk     -     - 22030  0    -  75   0 -     - futex_     -   0 13:35 -        00:00:00 -
1 S asterisk     -     - 22031  0    -  75   0 -     - futex_     -   0 13:35 -        00:00:00 -
1 S asterisk     -     - 22032  0    -  75   0 -     - futex_     -   0 13:35 -        00:00:00 -
1 S asterisk     -     - 22033  0    -  75   0 -     - futex_     -   0 13:35 -        00:00:00 -
1 S asterisk     -     - 22034  0    -  75   0 -     - futex_     -   2 13:35 -        00:00:00 -
1 S asterisk     -     - 22035  0    -  75   0 -     - futex_     -   1 13:35 -        00:00:00 -
1 S asterisk     -     - 22036  0    -  75   0 -     - 429493     -   7 13:35 -        00:00:02 -
1 S asterisk     -     - 22037  0    -  75   0 -     - -          -   4 13:35 -        00:00:00 -
1 S asterisk     -     - 22038  0    -  75   0 -     - 414742     -   0 13:35 -        00:00:00 -
1 S asterisk     -     - 22039  0    -  75   0 -     - futex_     -   0 13:35 -        00:00:00 -
1 S asterisk     -     - 22040  0    -  75   0 -     - -          -   7 13:35 -        00:00:00 -
1 S asterisk     -     - 22041  0    -  75   0 -     - -          -   2 13:35 -        00:00:00 -
1 S asterisk     -     - 22042  0    -  75   0 -     - -          -   2 13:35 -        00:00:00 -
1 S asterisk     -     - 22043  0    -  75   0 -     - 320443     -   7 13:35 -        00:00:00 -
1 S asterisk     -     - 22044  0    -  75   0 -     - 328430     -   7 13:35 -        00:00:00 -
1 S asterisk     -     - 22045  0    -  75   0 -     - 177028     -   7 13:35 -        00:00:00 -
1 S asterisk     -     - 22046  0    -  75   0 -     - 169019     -   0 13:35 -        00:00:00 -
1 S asterisk     -     - 22047  2    -  76   0 -     - futex_     -   5 13:35 -        00:06:58 -
1 S asterisk     -     - 22048  0    -  75   0 -     - pipe_w     -   0 13:35 -        00:00:00 -
1 S asterisk     -     - 10489  0    -  75   0 -     - futex_     -   0 13:36 -        00:00:00 -
1 S asterisk     -     -  9788  0    -  75   0 -     - -          -   1 13:39 -        00:00:05 -
1 S asterisk     -     - 11429  0    -  75   0 -     - -          -   1 16:08 -        00:00:00 -

1 R asterisk     -     - 29856 52    -  78   0 -     - -          -   3 17:22 -        00:14:17 -

1 S asterisk     -     - 13852  0    -  75   0 -     - futex_     -   4 17:29 -        00:00:00 -
1 S asterisk     -     -  9462  0    -  75   0 -     - 147171     -   4 17:32 -        00:00:02 -
1 S asterisk     -     -  5834  0    -  75   0 -     - -          -   0 17:35 -        00:00:01 -
1 S asterisk     -     - 25838  0    -  75   0 -     - futex_     -   7 17:36 -        00:00:00 -
1 S asterisk     -     -  1621  0    -  75   0 -     - 215550     -   0 17:38 -        00:00:01 -
1 S asterisk     -     -  9848  0    -  75   0 -     - 215473     -   0 17:40 -        00:00:01 -
1 S asterisk     -     - 17461  0    -  75   0 -     - 147178     -   0 17:42 -        00:00:02 -
1 S asterisk     -     -  5411  0    -  75   0 -     - futex_     -   1 17:43 -        00:00:00 -
1 S asterisk     -     -  5594  0    -  75   0 -     - 147155     -   0 17:43 -        00:00:01 -
1 S asterisk     -     -  5595  0    -  75   0 -     - 215162     -   0 17:43 -        00:00:01 -
1 S asterisk     -     - 25636  0    -  75   0 -     - 215886     -   0 17:44 -        00:00:01 -
1 S asterisk     -     -  4140  0    -  75   0 -     - 351886     -   0 17:45 -        00:00:00 -
1 S asterisk     -     - 13574  0    -  75   0 -     - 351886     -   4 17:45 -        00:00:00 -
1 S asterisk     -     - 13650  0    -  75   0 -     - 351886     -   0 17:45 -        00:00:00 -
1 S asterisk     -     - 13652  0    -  75   0 -     - -          -   6 17:45 -        00:00:00 -
1 S asterisk     -     - 13681  0    -  75   0 -     - 351886     -   0 17:45 -        00:00:00 -
1 S asterisk     -     - 13909  0    -  75   0 -     - 351886     -   0 17:45 -        00:00:00 -
1 S asterisk     -     -   976  0    -  75   0 -     - 351886     -   0 17:46 -        00:00:00 -
1 S asterisk     -     -  1088  0    -  75   0 -     - -          -   0 17:46 -        00:00:00 -
1 S asterisk     -     -  1233  0    -  75   0 -     - futex_     -   2 17:46 -        00:00:00 -
1 S asterisk     -     -  1427  0    -  75   0 -     - 351886     -   0 17:46 -        00:00:00 -
1 S asterisk     -     -  1428  0    -  75   0 -     - futex_     -   7 17:46 -        00:00:00 -
1 S asterisk     -     - 21045  0    -  75   0 -     - futex_     -   4 17:47 -        00:00:00 -
1 S asterisk     -     - 21124  0    -  75   0 -     - 351886     -   0 17:47 -        00:00:00 -
1 S asterisk     -     - 21325  0    -  75   0 -     - 351886     -   4 17:47 -        00:00:00 -
1 S asterisk     -     - 21389  0    -  75   0 -     - -          -   4 17:47 -        00:00:00 -
1 S asterisk     -     - 21442  0    -  75   0 -     - futex_     -   7 17:47 -        00:00:00 -
1 S asterisk     -     -  1217  0    -  75   0 -     - 351886     -   0 17:48 -        00:00:00 -
1 S asterisk     -     -  7836  0    -  75   0 -     - -          -   4 17:48 -        00:00:00 -
1 S asterisk     -     -  7879  0    -  75   0 -     - -          -   0 17:48 -        00:00:00 -
1 S asterisk     -     -  8043  0    -  75   0 -     - -          -   3 17:48 -        00:00:00 -
1 S asterisk     -     -  8169  0    -  75   0 -     - -          -   0 17:48 -        00:00:00 -
1 S asterisk     -     -  8206  0    -  75   0 -     - futex_     -   4 17:48 -        00:00:00 -
1 S asterisk     -     - 16471  3    -  75   0 -     - -          -   0 17:49 -        00:00:00 -
[root@cs bin]# pstack 29856 > /tmp/asterisk.29856

Thread 1 (process 29856):
#0  0x00000000004408b5 in internal_ao2_callback ()
#1  0x0000000000440ffc in __ao2_find ()
#2  0x00002aaab9130c7f in pthread_timer_set_rate () from /usr/lib/asterisk/modules/res_timing_pthread.so
#3  0x0000000000473e62 in __ast_read ()
#4  0x00000000004745d4 in ast_generic_bridge ()
#5  0x00000000004759c7 in ast_channel_bridge ()
#6  0x00000000004a4ad9 in ast_bridge_call ()
#7  0x00002aaab70acca2 in try_calling () from /usr/lib/asterisk/modules/app_queue.so
#8  0x00002aaab70af6b8 in queue_exec () from /usr/lib/asterisk/modules/app_queue.so
#9  0x00000000004ec54f in pbx_exec ()
#10 0x00000000004fb8db in pbx_extension_helper ()
#11 0x00000000004fe7eb in __ast_pbx_run ()
#12 0x0000000000500c0b in pbx_thread ()
#13 0x000000000053732c in dummy_start ()
#14 0x0000003cc560677d in start_thread () from /lib64/libpthread.so.0
#15 0x0000003cc4ed49ad in clone () from /lib64/libc.so.6
Comments:By: Matt Jordan (mjordan) 2012-03-19 08:46:37.283-0500

Thanks for your comments. This does not appear to be a bug report and we are closing it. We appreciate the difficulties you are facing, but it would make more sense to raise your question in the support tracker, http://www.asterisk.org/support.  Alternatively, you can look for help on the Asterisk users mailing list (asterisk-users@lists.digium.com), or on the #asterisk IRC channel.



By: Paul Belanger (pabelanger) 2012-03-19 08:51:44.278-0500

You should be using res_timing_dahdi or res_timing_timerfd.