[Home]

Summary:ASTERISK-05644: lots of these: chan_sip.c:11253 do_monitor: chan_sip: ast_sched_runq ran 70 all at once
Reporter:Matt Ranney (mjrmjr2)Labels:
Date Opened:2005-11-18 20:24:03.000-0600Date Closed:2008-01-15 15:57:07.000-0600
Priority:MinorRegression?No
Status:Closed/CompleteComponents:Core/General
Versions:Frequency of
Occurrence
Related
Issues:
Environment:Attachments:
Description:I have a lightly loaded office asterisk server with 94 SIP phones, all are Cisco 7940's.  After upgrading this server to 1.2.0, I get lots of messages like this:

Nov 18 21:19:58 WARNING[1801]: chan_sip.c:11253 do_monitor: chan_sip: ast_sched_runq ran 70 all at once
Nov 18 21:20:58 WARNING[1801]: chan_sip.c:11253 do_monitor: chan_sip: ast_sched_runq ran 66 all at once
Nov 18 21:21:58 WARNING[1801]: chan_sip.c:11253 do_monitor: chan_sip: ast_sched_runq ran 65 all at once

There are no calls on the server at the time.  All SIP peers are defined like this:

[703673XXXX]
type=friend
secret=XXXX
host=dynamic
mailbox=703673XXXX
qualify=yes
canreinvite=no

If I set qualify=no, then this does not happen.  In my basic testing, the system seems to be working correctly.  The warning message is a little troubling though.
Comments:By: Matt Ranney (mjrmjr2) 2005-11-18 20:25:11.000-0600

I forgot to add that there is nothing else going on with this machine outside of the asterisk process.
By: Matt Ranney (mjrmjr2) 2005-11-18 20:35:40.000-0600

With CVS HEAD as of a few moments ago, I actually get two messages every minute like this:

Nov 18 21:33:10 WARNING[8277]: chan_sip.c:11253 do_monitor: chan_sip: ast_sched_runq ran 44 all at once
Nov 18 21:33:10 WARNING[8277]: chan_sip.c:11253 do_monitor: chan_sip: ast_sched_runq ran 28 all at once
Nov 18 21:34:10 WARNING[8277]: chan_sip.c:11253 do_monitor: chan_sip: ast_sched_runq ran 40 all at once
Nov 18 21:34:10 WARNING[8277]: chan_sip.c:11253 do_monitor: chan_sip: ast_sched_runq ran 28 all at once
By: Serge Vecher (serge-v) 2005-11-19 22:29:59.000-0600

what happens if you set qualify to a numeric value, like qualify=200?
By: twisted (twisted) 2005-11-20 00:15:56.000-0600

looks to me like there are a lot of registrations that could be happening at the same time, thus the qualify messages will get queued and sent at the same time..  could you verify if this is the case?
By: Olle Johansson (oej) 2005-11-20 08:56:58.000-0600

How many peers and registrations do you have in sip.conf?
By: Russell Bryant (russell) 2005-11-20 20:07:32.000-0600

These should really be DEBUG messages instead of WARNING messages, since they are not meant to have any meaning to the end user.  They were put in by a developer working on profiling some Asterisk code.  I have changed them in both cvs head and 1.2.
By: Digium Subversion (svnbot) 2008-01-15 15:57:05.000-0600

Repository: asterisk
Revision: 7156

U   trunk/ChangeLog
U   trunk/channels/chan_iax2.c
U   trunk/channels/chan_sip.c

------------------------------------------------------------------------
r7156 | russell | 2008-01-15 15:57:05 -0600 (Tue, 15 Jan 2008) | 2 lines

issue ASTERISK-5644

------------------------------------------------------------------------

http://svn.digium.com/view/asterisk?view=rev&revision=7156
By: Digium Subversion (svnbot) 2008-01-15 15:57:07.000-0600

Repository: asterisk
Revision: 7157

U   branches/v1-2/ChangeLog
U   branches/v1-2/channels/chan_iax2.c
U   branches/v1-2/channels/chan_sip.c

------------------------------------------------------------------------
r7157 | russell | 2008-01-15 15:57:06 -0600 (Tue, 15 Jan 2008) | 2 lines

issue ASTERISK-5644

------------------------------------------------------------------------

http://svn.digium.com/view/asterisk?view=rev&revision=7157