[Freeswitch-users] FreeSwitch Utilizes 100% of CPU Sometimes When User Quits Conference
Mathieu Rene
mrene_lists at avgs.ca
Wed Aug 31 18:55:35 MSD 2011
Hi,
Can you try the latest version to see if this is fixed?
Thanks,
Mathieu Rene
Avant-Garde Solutions Inc
Office: + 1 (514) 664-1044 x100
Cell: +1 (514) 664-1044 x200
mrene at avgs.ca
On 2011-08-25, at 11:14 AM, Erwin Merioles wrote:
> Thanks for the reply!
>
> I think I've found the problem. When our "host" ends the meeting, it sends a
> disconnect event to all participants. The SWITCH_POLLOUT event happens when
> the participants tries to end the meeting simultaneously with the host.
>
> I think it is the server's way of doing a "cleanup" and tries to send any
> remaining data to whoever is left in the conference -- which in our case is
> none. This results to an infinite loop of tries.
>
> The problem was fixed on our end by delaying the disconnection of the
> participants a bit.
>
> Regards,
>
> Erwin D. Merioles
>
> -----Original Message-----
> From: freeswitch-users-bounces at lists.freeswitch.org
> [mailto:freeswitch-users-bounces at lists.freeswitch.org] On Behalf Of Anthony
> Minessale
> Sent: Thursday, August 25, 2011 12:01 AM
> To: FreeSWITCH Users Help
> Subject: Re: [Freeswitch-users] FreeSwitch Utilizes 100% of CPU Sometimes
> When User Quits Conference
>
> Really you should be reporting bugs to http://jira.freeswitch.org Are you
> only having this problem with mod_rtmp (its only 2 months old) Most likely
> you have created a new condition that the author has not taken into account.
> Ideally you should file it on jira under mod_rtmp and attach a back trace
> from a core dump produced by gcore.
>
>
>
> On Wed, Aug 24, 2011 at 7:31 AM, Erwin Merioles <erwin at merioles.net> wrote:
>> Hey guys,
>>
>>
>>
>> I’ve been having trouble with FreeSwitch for quite some time. We’re
>> trying to use mod_rtmp to add sound to one of our applications,
> www.321meet.com.
>> Unfortunately, FreeSwitch’s CPU usage spikes when the host ( the first
>> one to join the conference ), quits or closes the browser window. I’ve
>> checked and this always happen when the following line is called –
>>
>>
>>
>> 2011-08-24 12:24:28.057200 [NOTICE] rtmp_tcp.c:73 Pollout: true
>>
>>
>>
>> FS Console Log follows :
>>
>>
>>
>> 2011-08-24 12:22:59.177294 [NOTICE] mod_rtmp.c:743 New RTMP session
>> [4a97320c-e50d-4ed3-a59c-4aef799d379d]
>>
>> 2011-08-24 12:22:59.477278 [NOTICE] rtmp_sig.c:121 Sent connect reply
>>
>> 2011-08-24 12:23:15.597196 [INFO] rtmp_sig.c:136 Replied to
>> createStream (1)
>>
>> 2011-08-24 12:23:16.237201 [INFO] rtmp_sig.c:274 Got publish on stream 1.
>>
>> 2011-08-24 12:23:17.177293 [INFO] rtmp_sig.c:136 Replied to
>> createStream (2)
>>
>> 2011-08-24 12:23:17.177293 [WARNING] rtmp.c:99 [amfnumber=2] Unhandled
>> control packet (type=0x3)
>>
>> 2011-08-24 12:23:17.457195 [WARNING] sofia.c:4403 Ping succeeded
>> voip9.telsome.com with code 404 - count -1/1/1, state UP
>>
>> 2011-08-24 12:23:17.457195 [INFO] rtmp_sig.c:136 Replied to
>> createStream (3)
>>
>> 2011-08-24 12:23:17.457195 [NOTICE] switch_channel.c:897 New Channel
>> rtmp/default/3213533 [8e7ccce8-172c-4b91-9183-1ad9d2f0e6dd]
>>
>> 2011-08-24 12:23:17.457195 [ERR] rtmp_sig.c:305 Couldn't create call.
>>
>> 2011-08-24 12:23:17.457195 [WARNING] sofia.c:4403 Ping succeeded
>> testin with code 404 - count -1/1/1, state UP
>>
>> 2011-08-24 12:23:17.497199 [INFO] mod_dialplan_xml.c:336 Processing
>> <0000000000>->3213533 in context default
>>
>> 2011-08-24 12:23:17.497199 [NOTICE] mod_rtmp.c:497 Channel
>> [rtmp/default/3213533] has been answered
>>
>> 2011-08-24 12:23:17.497199 [INFO] mod_conference.c:6644 using channel
>> sound
>> prefix: /usr/local/freeswitch/sounds/en/us/callie
>>
>> 2011-08-24 12:23:17.597289 [INFO] mod_conference.c:7007
>> rtmp/default/3213533 binding '0' to 'mute'
>>
>> 2011-08-24 12:23:17.597289 [INFO] switch_ivr_async.c:164 Digit parser
>> mod_conference: Setting realm to conf
>>
>> 2011-08-24 12:23:17.597289 [INFO] mod_conference.c:7007
>> rtmp/default/3213533 binding '*' to 'deaf mute'
>>
>> 2011-08-24 12:23:17.597289 [INFO] mod_conference.c:7007
>> rtmp/default/3213533 binding '9' to 'energy up'
>>
>> 2011-08-24 12:23:17.597289 [INFO] mod_conference.c:7007
>> rtmp/default/3213533 binding '8' to 'energy equ'
>>
>> 2011-08-24 12:23:17.597289 [INFO] mod_conference.c:7007
>> rtmp/default/3213533 binding '7' to 'energy dn'
>>
>> 2011-08-24 12:23:17.597289 [INFO] mod_conference.c:7007
>> rtmp/default/3213533 binding '3' to 'vol talk up'
>>
>> 2011-08-24 12:23:17.597289 [INFO] mod_conference.c:7007
>> rtmp/default/3213533 binding '2' to 'vol talk zero'
>>
>> 2011-08-24 12:23:17.597289 [INFO] mod_conference.c:7007
>> rtmp/default/3213533 binding '1' to 'vol talk dn'
>>
>> 2011-08-24 12:23:17.597289 [INFO] mod_conference.c:7007
>> rtmp/default/3213533 binding '6' to 'vol listen up'
>>
>> 2011-08-24 12:23:17.597289 [INFO] mod_conference.c:7007
>> rtmp/default/3213533 binding '5' to 'vol listen zero'
>>
>> 2011-08-24 12:23:17.597289 [INFO] mod_conference.c:7007
>> rtmp/default/3213533 binding '4' to 'vol listen dn'
>>
>> 2011-08-24 12:23:17.597289 [INFO] mod_conference.c:7007
>> rtmp/default/3213533 binding '#' to 'hangup'
>>
>> 2011-08-24 12:23:17.797195 [INFO] rtmp_sig.c:159 Sending audio
>>
>> 2011-08-24 12:23:17.797195 [WARNING] rtmp.c:99 [amfnumber=2] Unhandled
>> control packet (type=0x3)
>>
>> 2011-08-24 12:23:18.117290 [INFO] rtmp_sig.c:274 Got publish on stream 3.
>>
>> 2011-08-24 12:23:36.697195 [ERR] rtmp.c:678 Read error
>>
>> 2011-08-24 12:23:36.697195 [NOTICE] mod_rtmp.c:788 RTMP session ended
>> [4a97320c-e50d-4ed3-a59c-4aef799d379d]
>>
>> 2011-08-24 12:23:36.697195 [NOTICE] mod_rtmp.c:803 Hangup
>> rtmp/default/3213533 [CS_EXECUTE] [DESTINATION_OUT_OF_ORDER]
>>
>> 2011-08-24 12:23:36.777294 [NOTICE] switch_core_session.c:1347 Session
>> 1
>> (rtmp/default/3213533) Ended
>>
>> 2011-08-24 12:23:36.777294 [NOTICE] switch_core_session.c:1349 Close
>> Channel
>> rtmp/default/3213533 [CS_DESTROY]
>>
>> 2011-08-24 12:23:48.237202 [NOTICE] mod_rtmp.c:743 New RTMP session
>> [3ff4786f-7cae-4653-879a-ae95a9d50742]
>>
>> 2011-08-24 12:23:48.557204 [NOTICE] rtmp_sig.c:121 Sent connect reply
>>
>> 2011-08-24 12:23:55.357293 [NOTICE] mod_rtmp.c:743 New RTMP session
>> [af763930-9054-4c76-a0eb-9c351e75949d]
>>
>> 2011-08-24 12:23:55.757290 [NOTICE] rtmp_sig.c:121 Sent connect reply
>>
>> 2011-08-24 12:23:58.957195 [INFO] rtmp_sig.c:136 Replied to
>> createStream (1)
>>
>> 2011-08-24 12:23:59.517204 [INFO] rtmp_sig.c:274 Got publish on stream 1.
>>
>> 2011-08-24 12:24:00.557201 [INFO] rtmp_sig.c:136 Replied to
>> createStream (2)
>>
>> 2011-08-24 12:24:00.557201 [WARNING] rtmp.c:99 [amfnumber=2] Unhandled
>> control packet (type=0x3)
>>
>> 2011-08-24 12:24:00.557201 [INFO] rtmp_sig.c:136 Replied to
>> createStream (3)
>>
>> 2011-08-24 12:24:00.857222 [NOTICE] switch_channel.c:897 New Channel
>> rtmp/default/3213533 [5de55413-5cb9-4c18-8b65-9c438833449f]
>>
>> 2011-08-24 12:24:00.857222 [ERR] rtmp_sig.c:305 Couldn't create call.
>>
>> 2011-08-24 12:24:00.857222 [INFO] mod_dialplan_xml.c:336 Processing
>> <0000000000>->3213533 in context default
>>
>> 2011-08-24 12:24:00.857222 [NOTICE] mod_rtmp.c:497 Channel
>> [rtmp/default/3213533] has been answered
>>
>> 2011-08-24 12:24:00.857222 [INFO] mod_conference.c:6644 using channel
>> sound
>> prefix: /usr/local/freeswitch/sounds/en/us/callie
>>
>> 2011-08-24 12:24:00.857222 [INFO] mod_conference.c:7007
>> rtmp/default/3213533 binding '0' to 'mute'
>>
>> 2011-08-24 12:24:00.857222 [INFO] switch_ivr_async.c:164 Digit parser
>> mod_conference: Setting realm to conf
>>
>> 2011-08-24 12:24:00.857222 [INFO] mod_conference.c:7007
>> rtmp/default/3213533 binding '*' to 'deaf mute'
>>
>> 2011-08-24 12:24:00.857222 [INFO] mod_conference.c:7007
>> rtmp/default/3213533 binding '9' to 'energy up'
>>
>> 2011-08-24 12:24:00.857222 [INFO] mod_conference.c:7007
>> rtmp/default/3213533 binding '8' to 'energy equ'
>>
>> 2011-08-24 12:24:00.857222 [INFO] mod_conference.c:7007
>> rtmp/default/3213533 binding '7' to 'energy dn'
>>
>> 2011-08-24 12:24:00.857222 [INFO] mod_conference.c:7007
>> rtmp/default/3213533 binding '3' to 'vol talk up'
>>
>> 2011-08-24 12:24:00.857222 [INFO] mod_conference.c:7007
>> rtmp/default/3213533 binding '2' to 'vol talk zero'
>>
>> 2011-08-24 12:24:00.857222 [INFO] mod_conference.c:7007
>> rtmp/default/3213533 binding '1' to 'vol talk dn'
>>
>> 2011-08-24 12:24:00.857222 [INFO] mod_conference.c:7007
>> rtmp/default/3213533 binding '6' to 'vol listen up'
>>
>> 2011-08-24 12:24:00.857222 [INFO] mod_conference.c:7007
>> rtmp/default/3213533 binding '5' to 'vol listen zero'
>>
>> 2011-08-24 12:24:00.857222 [INFO] mod_conference.c:7007
>> rtmp/default/3213533 binding '4' to 'vol listen dn'
>>
>> 2011-08-24 12:24:00.857222 [INFO] mod_conference.c:7007
>> rtmp/default/3213533 binding '#' to 'hangup'
>>
>> 2011-08-24 12:24:01.197247 [WARNING] rtmp.c:99 [amfnumber=2] Unhandled
>> control packet (type=0x3)
>>
>> 2011-08-24 12:24:01.197247 [INFO] rtmp_sig.c:274 Got publish on stream 3.
>>
>> 2011-08-24 12:24:01.197247 [INFO] rtmp_sig.c:159 Sending audio
>>
>> 2011-08-24 12:24:13.637291 [INFO] rtmp_sig.c:136 Replied to
>> createStream (1)
>>
>> 2011-08-24 12:24:14.157289 [INFO] rtmp_sig.c:274 Got publish on stream 1.
>>
>> 2011-08-24 12:24:17.057195 [INFO] rtmp_sig.c:136 Replied to
>> createStream (2)
>>
>> 2011-08-24 12:24:17.057195 [WARNING] rtmp.c:99 [amfnumber=2] Unhandled
>> control packet (type=0x3)
>>
>> 2011-08-24 12:24:17.057195 [INFO] rtmp_sig.c:136 Replied to
>> createStream (3)
>>
>> 2011-08-24 12:24:17.057195 [NOTICE] switch_channel.c:897 New Channel
>> rtmp/default/3213533 [4e6c35ce-ec56-4ef1-816a-b94704efbfbd]
>>
>> 2011-08-24 12:24:17.057195 [ERR] rtmp_sig.c:305 Couldn't create call.
>>
>> 2011-08-24 12:24:17.057195 [INFO] mod_dialplan_xml.c:336 Processing
>> <0000000000>->3213533 in context default
>>
>> 2011-08-24 12:24:17.057195 [NOTICE] mod_rtmp.c:497 Channel
>> [rtmp/default/3213533] has been answered
>>
>> 2011-08-24 12:24:17.057195 [INFO] mod_conference.c:7007
>> rtmp/default/3213533 binding '0' to 'mute'
>>
>> 2011-08-24 12:24:17.057195 [INFO] switch_ivr_async.c:164 Digit parser
>> mod_conference: Setting realm to conf
>>
>> 2011-08-24 12:24:17.057195 [INFO] mod_conference.c:7007
>> rtmp/default/3213533 binding '*' to 'deaf mute'
>>
>> 2011-08-24 12:24:17.057195 [INFO] mod_conference.c:7007
>> rtmp/default/3213533 binding '9' to 'energy up'
>>
>> 2011-08-24 12:24:17.057195 [INFO] mod_conference.c:7007
>> rtmp/default/3213533 binding '8' to 'energy equ'
>>
>> 2011-08-24 12:24:17.057195 [INFO] mod_conference.c:7007
>> rtmp/default/3213533 binding '7' to 'energy dn'
>>
>> 2011-08-24 12:24:17.057195 [INFO] mod_conference.c:7007
>> rtmp/default/3213533 binding '3' to 'vol talk up'
>>
>> 2011-08-24 12:24:17.057195 [INFO] mod_conference.c:7007
>> rtmp/default/3213533 binding '2' to 'vol talk zero'
>>
>> 2011-08-24 12:24:17.057195 [INFO] mod_conference.c:7007
>> rtmp/default/3213533 binding '1' to 'vol talk dn'
>>
>> 2011-08-24 12:24:17.057195 [INFO] mod_conference.c:7007
>> rtmp/default/3213533 binding '6' to 'vol listen up'
>>
>> 2011-08-24 12:24:17.057195 [INFO] mod_conference.c:7007
>> rtmp/default/3213533 binding '5' to 'vol listen zero'
>>
>> 2011-08-24 12:24:17.057195 [INFO] mod_conference.c:7007
>> rtmp/default/3213533 binding '4' to 'vol listen dn'
>>
>> 2011-08-24 12:24:17.057195 [INFO] mod_conference.c:7007
>> rtmp/default/3213533 binding '#' to 'hangup'
>>
>> 2011-08-24 12:24:17.497196 [WARNING] rtmp.c:99 [amfnumber=2] Unhandled
>> control packet (type=0x3)
>>
>> 2011-08-24 12:24:17.497196 [INFO] rtmp_sig.c:274 Got publish on stream 3.
>>
>> 2011-08-24 12:24:17.497196 [INFO] rtmp_sig.c:159 Sending audio
>>
>> 2011-08-24 12:24:27.657196 [ERR] rtmp.c:678 Read error
>>
>> 2011-08-24 12:24:27.657196 [NOTICE] mod_rtmp.c:788 RTMP session ended
>> [3ff4786f-7cae-4653-879a-ae95a9d50742]
>>
>> 2011-08-24 12:24:27.657196 [NOTICE] mod_rtmp.c:803 Hangup
>> rtmp/default/3213533 [CS_EXECUTE] [DESTINATION_OUT_OF_ORDER]
>>
>> 2011-08-24 12:24:27.677201 [NOTICE] switch_core_session.c:1347 Session
>> 2
>> (rtmp/default/3213533) Ended
>>
>> 2011-08-24 12:24:27.677201 [NOTICE] switch_core_session.c:1349 Close
>> Channel
>> rtmp/default/3213533 [CS_DESTROY]
>>
>> 2011-08-24 12:24:28.057200 [NOTICE] rtmp_tcp.c:73 Pollout: true
>>
>>
>>
>> Which results to :
>>
>>
>>
>> PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND
>>
>> 1608 root -2 -10 191m 20m 6588 R 94.3 3.5 5:39.50 fs
>>
>>
>>
>> Any ideas? Help is VERY much appreciated. TIA!
>>
>>
>>
>> Regards,
>>
>>
>>
>> Erwin D. Merioles
>>
>>
>>
>> merioles.net
>>
>> +63 922 837 9466 | +63 917 501 1010 | +1 760 670 3241
>>
>> aY!M : erwin_merioles | Skype : erwin.merioles
>>
>> This message (including any attachments) contains information that may
>> be confidential. Unless you are the intended recipient (or is
>> authorized to receive for the intended recipient), you may not read,
>> print, retain, use, copy, distribute, or disclose to anyone, any
>> information contained here. If you have received this in error, please
>> advise the sender by reply e-mail, and delete all copies of the original
> message (including attachments).
>>
>>
>>
>> FreeSWITCH-users mailing list
>> FreeSWITCH-users at lists.freeswitch.org
>> http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
>> UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-use
>> rs
>> http://www.freeswitch.org
>>
>>
>
>
>
> --
> Anthony Minessale II
>
> FreeSWITCH http://www.freeswitch.org/
> ClueCon http://www.cluecon.com/
> Twitter: http://twitter.com/FreeSWITCH_wire
>
> AIM: anthm
> MSN:anthony_minessale at hotmail.com
> GTALK/JABBER/PAYPAL:anthony.minessale at gmail.com
> IRC: irc.freenode.net #freeswitch
>
> FreeSWITCH Developer Conference
> sip:888 at conference.freeswitch.org
> googletalk:conf+888 at conference.freeswitch.org
> pstn:+19193869900
>
>
> FreeSWITCH-users mailing list
> FreeSWITCH-users at lists.freeswitch.org
> http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
> UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
> http://www.freeswitch.org
>
>
>
> FreeSWITCH-users mailing list
> FreeSWITCH-users at lists.freeswitch.org
> http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
> UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
> http://www.freeswitch.org
Join us at ClueCon 2011 Aug 9-11, 2011
More information about the FreeSWITCH-users
mailing list