[Home]

Summary:ASTERISK-11140: show channels concise fails
Reporter:Private Name (falves11)Labels:
Date Opened:2008-01-02 12:51:29.000-0600Date Closed:2008-04-14 12:37:51
Priority:MajorRegression?No
Status:Closed/CompleteComponents:Core/Channels
Versions:Frequency of
Occurrence
Related
Issues:
Environment:Attachments:( 0) 11667-trunk.txt
( 1) 11677.txt
Description:As you can see below, I run two command from the command line. The first command "core show channels concise" shows me only a few channels, but then I send the command "core show channels count", I really have over 300 active channels.

It is a killer issue because I was relying on executing the "concise" version to make sure that the calls on the database where exactly the same ones as in Asterisk, every 10 minutes. It happens when there is a substancial amount of calls. It might be that if it takes time to pull the answer, the command "asterisk -rx" returns too fast, omitting information. I don't know. But I also found also a reference from http://readlist.com/lists/lists.digium.com/asterisk-users/11/56073.html, where the author writes: "Asterisk intermittently fails to report call and channel statistics when the CPU idle is low". So the problem is not new.

[root@Sipserver agi-bin]# asterisk -rx "core show channels concise"
SIP/67.110.179.253-b37f3650!default!16024376674*66*28*147*130*!12!Ring!(None)!!6169802925!!3!0!(None)!S208-1199299095.9024
SIP/67.110.179.253-b37ef6b8!default!14804882132*66*28*147*130*!12!Ring!(None)!!6169802925!!3!0!(None)!S208-1199299095.9023
SIP/66.28.190.221-08444e98!default!14805455050*66*28*147*130*!1!Down!AppDial!(Outgoing Line)!14805455050*66*28*147*130*!!3!0!(None)!S208-1199299095.9022
SIP/67.110.179.253-b37eb720!default!14805455050*66*28*147*130*!16!Ring!Dial!SIP/14805455050@66.28.190.221,45,L(3600000)!6169802925!!3!0!(None)!S208-1199299095.9021
SIP/66.28.190.221-089ae7b0!default!14807263344*66*28*147*130*!1!Down!AppDial!(Outgoing Line)!14807263344*66*28*147*130*!!3!0!(None)!S208-1199299095.9020
SIP/66.28.190.221-085a7600!default!15056534180!1!Down!AppDial!(Outgoing Line)!15056534180!!3!0!(None)!S208-1199299095.9019
SIP/66.28.190.221-08aa3020!default!16025950099*66*28*147*130*!1!Down!AppDial!(Outgoing Line)!16025950099*66*28*147*130*!!3!0!(None)!S208-1199299095.9018
SIP/67.110.179.253-b3ba9f48!default!16022755203*66*28*147*130*!16!Ring!Dial!SIP/16022755203@66.28.190.221,45,L(3600000)!6169802925!!3!0!(None)!S208-1199299095.9017
SIP/67.110.179.253-b3ba5fb0!default!14807263344*66*28*147*130*!16!Ring!Dial!SIP/14807263344@66.28.190.221,45,L(3600000)!6169802925!!3!0!(None)!S208-1199299095.9015
SIP/67.110.179.253-b3725618!default!16025950099*66*28*147*130*!16!Ring!Dial!SIP/16025950099@66.28.190.221,45,L(3600000)!6169802925!!3!0!(None)!S208-1199299095.9014
SIP/66.28.190.221-0820b230!default!14808397553*66*28*147*130*!1!Down!AppDial!(Outgoing Line)!14808397553*66*28*147*130*!!3!0!(None)!S208-1199299095.9013
[root@Sipserver agi-bin]# asterisk -rx "core show channels count"
302 active channels
151 active calls
4423 calls processed


****** ADDITIONAL INFORMATION ******

Current Trunk version from today 1-2-2008
Comments:By: Tilghman Lesher (tilghman) 2008-01-02 14:02:09.000-0600

Is the output the same if you don't use "asterisk -rx" and just query from the Asterisk command line?  Or if you use the manager interface to query the list of channels?  Specifically, in AMI, you should be using the CoreShowChannels command.


By: Private Name (falves11) 2008-01-02 14:11:20.000-0600

Yes, the problem also happens from inside Asterisk. Please look at the discrepancy between the command "core show channels count" and the inmediate "core show channels concise". Additionally, "core show channels" has the same problem. I think the command times out, because it has to gather much more information.

Sipserver*CLI> core show channels count
241 active channels
123 active calls
17506 calls processed
Sipserver*CLI> core show channels concise
H323/84.233.149.172-5758!default!011441333424671*38*102*64*25*!1!Down!AppDial!(Outgoing Line)!011441333424671*38*102*64*25*!!3!0!(None)!S208-1199304358.36006
SIP/67.110.179.253-b3de7f18!default!011441333424671*38*102*64*25*!16!Ring!Dial!H323/64129441333424671@84.233.149.172,45,L(3600000)!9083453815!!3!0!(None)!S208-1199304358.36005
SIP/66.28.190.221-08bcfa08!default!16022410447*66*28*147*130*!1!Down!AppDial!(Outgoing Line)!16022410447*66*28*147*130*!!3!0!(None)!S208-1199304358.36004
SIP/63.110.11.95-089ddca8!default!12037774731*66*28*147*130*!1!Down!AppDial!(Outgoing Line)!12037774731*66*28*147*130*!!3!0!(None)!S208-1199304358.36003
SIP/66.235.234.153-087c7258!default!13362340331*207*2*123*180*!1!Down!AppDial!(Outgoing Line)!13362340331*207*2*123*180*!!3!0!(None)!S208-1199304358.36002
SIP/67.110.179.253-b042c9c8!default!13362340331*207*2*123*180*!16!Ring!Dial!SIP/13362340331@66.235.234.153,45,L(3600000)!3369651042!!3!0!(None)!S208-1199304358.36001
SIP/63.110.11.95-0896c358!default!17704799749!1!Down!AppDial!(Outgoing Line)!17704799749!!3!0!(None)!S208-1199304357.36000
SIP/64.1.29.96-087cc458!default!17316601994*66*28*147*130*!1!Down!AppDial!(Outgoing Line)!17316601994*66*28*147*130*!!3!0!(None)!S208-1199304357.35999
H323/84.233.149.172-5757!default!011441217797542*38*102*64*25*!1!Down!AppDial!(Outgoing Line)!011441217797542*38*102*64*25*!!3!0!(None)!S208-1199304357.35998
SIP/67.110.179.253-b3d30e78!default!011441217797542*38*102*64*25*!16!Ring!Dial!H323/64129441217797542@84.233.149.172,45,L(3600000)!9083453812!!3!0!(None)!S208-1199304357.35997
SIP/66.28.147.100-b32f1cd0!default!17704799749!16!Ring!Dial!SIP/1021117704799749@63.110.11.95,45,L(3600000)!8005315363!!3!0!(None)!S208-1199304357.35996


By: Private Name (falves11) 2008-01-02 14:30:20.000-0600

Please look at this, inside Asterisk. The first time I run "core show channels" it brings 3 and at the bottom it shows 3 active channels and 101 active calls. 3 seconds later, the picture is correct, 208 active channels and 105 active calls. Mabye both times is wrong. So it might not be a timeout, but something deeper.

Sipserver*CLI> core show channels
Channel              Location             State   Application(Data)
SIP/66.235.234.153-0 12083827199*207*2*12 Down    AppDial((Outgoing Line))
SIP/67.110.179.253-b 12083827199*207*2*12 Ring    Dial(SIP/12083827199@66.235.23
SIP/66.235.234.153-0 16065981804@default: Down    AppDial((Outgoing Line))
3 active channels
101 active calls
19739 calls processed
Sipserver*CLI> core show channels count
208 active channels
105 active calls
19786 calls processed
By: Private Name (falves11) 2008-01-11 11:14:48.000-0600

if a bug marshar could tell tell me how to understand what happens, it would be great. The problem happens al the time after a certain load.
By: Russell Bryant (russell) 2008-01-11 15:59:52.000-0600

Is Asterisk modified in any way?  Also, what H323 driver are you using?
By: Private Name (falves11) 2008-01-11 16:12:37.000-0600

I am using chan_h323, installed by Shido, who knows the subject. No modifications to Asterisk whatsoever. It works fine.
By: Russell Bryant (russell) 2008-01-31 15:22:20.000-0600

I'm curious if this patch helps the situation ... give it a try
By: Private Name (falves11) 2008-02-06 19:42:19.000-0600

I think the patch works fine. I have 200 open calls and
I can not reproduce the original issue. Please commit it.
However I had to go back to version 99082 because after
that version the SIP contact field is flawed and Asterisk
can not talk to many end points (there is an open issue about it)
so please make sure, if possible, that this patch gets applied
to 99082
By: jmls (jmls) 2008-02-17 14:34:54.000-0600

russell, can we get the patch merged with trunk ? Does it affect 1.4 as well ?
By: Digium Subversion (svnbot) 2008-04-14 12:36:19

Repository: asterisk
Revision: 114117

U   branches/1.4/main/channel.c

------------------------------------------------------------------------
r114117 | mmichelson | 2008-04-14 12:36:13 -0500 (Mon, 14 Apr 2008) | 11 lines

Increase the retry count when attempting to show channels. This apparently
cleared an issue someone was seeing when attempting to show channels when
the load was high.

(closes issue ASTERISK-11140)
Reported by: falves11
Patches:
     11677.txt uploaded by russell (license 2)
Tested by: falves11


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

http://svn.digium.com/view/asterisk?view=rev&revision=114117
By: Digium Subversion (svnbot) 2008-04-14 12:37:13

Repository: asterisk
Revision: 114118

_U  trunk/
U   trunk/main/channel.c

------------------------------------------------------------------------
r114118 | mmichelson | 2008-04-14 12:37:12 -0500 (Mon, 14 Apr 2008) | 19 lines

Merged revisions 114117 via svnmerge from
https://origsvn.digium.com/svn/asterisk/branches/1.4

........
r114117 | mmichelson | 2008-04-14 12:41:03 -0500 (Mon, 14 Apr 2008) | 11 lines

Increase the retry count when attempting to show channels. This apparently
cleared an issue someone was seeing when attempting to show channels when
the load was high.

(closes issue ASTERISK-11140)
Reported by: falves11
Patches:
     11677.txt uploaded by russell (license 2)
Tested by: falves11


........

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

http://svn.digium.com/view/asterisk?view=rev&revision=114118
By: Digium Subversion (svnbot) 2008-04-14 12:37:51

Repository: asterisk
Revision: 114119

_U  branches/1.6.0/
U   branches/1.6.0/main/channel.c

------------------------------------------------------------------------
r114119 | mmichelson | 2008-04-14 12:37:50 -0500 (Mon, 14 Apr 2008) | 27 lines

Merged revisions 114118 via svnmerge from
https://origsvn.digium.com/svn/asterisk/trunk

................
r114118 | mmichelson | 2008-04-14 12:42:20 -0500 (Mon, 14 Apr 2008) | 19 lines

Merged revisions 114117 via svnmerge from
https://origsvn.digium.com/svn/asterisk/branches/1.4

........
r114117 | mmichelson | 2008-04-14 12:41:03 -0500 (Mon, 14 Apr 2008) | 11 lines

Increase the retry count when attempting to show channels. This apparently
cleared an issue someone was seeing when attempting to show channels when
the load was high.

(closes issue ASTERISK-11140)
Reported by: falves11
Patches:
     11677.txt uploaded by russell (license 2)
Tested by: falves11


........

................

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

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