[Freeswitch-users] FreeSwitch Utilizes 100% of CPU Sometimes When User Quits Conference
Anthony Minessale
anthony.minessale at gmail.com
Wed Aug 24 20:01:02 MSD 2011
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-users
> 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
Join us at ClueCon 2011 Aug 9-11, 2011
More information about the FreeSWITCH-users
mailing list