<div dir="ltr">First, you should not post issues on the list use JIRA <a href="http://jira.freeswitch.org">http://jira.freeswitch.org</a><div>Second, you should paste logs into the body of messages, attach them to the ticket or email.</div>
<div> </div></div><div class="gmail_extra"><br><br><div class="gmail_quote">On Thu, Dec 5, 2013 at 9:01 AM, Germán Ruiz <span dir="ltr"><<a href="mailto:chmp99@gmail.com" target="_blank">chmp99@gmail.com</a>></span> wrote:<br>
<blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex">Hi !<br>
I have problems when I call twice a client conected to rtmp endpoint.<br>
The first one is ok and ring. But when I retry few seconds ago (less<br>
than 15 sec), I get a abort error.<br>
Looking in the log, I can see that is executing two times my dialplan.<br>
The first time with the dialed number and the second with the rtmp<br>
connection uuid (!)<br>
<br>
In the example below, I call from user "user1001" to user<br>
"<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>".<br>
<br>
First execute for dialplan:<br>
2013-12-05 11:23:20.418092 [INFO] mod_dialplan_xml.c:558 Processing<br>
<user1001>-><a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> in context default<br>
<br>
Execute bride:<br>
EXECUTE rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a><br>
bridge(user/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>,rtmp/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>)<br>
<br>
And next re-execute the dialplan, taking the dialed string as the uuid leg.<br>
2013-12-05 11:23:20.487852 [INFO] mod_dialplan_xml.c:558 Processing Abel<br>
Valencia<br>
<user1001>->99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a><br>
in context default<br>
<br>
I only see this behavior in RTMP. Users connected with SIP don't have<br>
this problem. Is it a bug in rtmp module or I have a wrong configuration ?<br>
<br>
Thanks in advance!<br>
<br>
<br>
The extension "autenticado" is<br>
<extension name="autenticado"><br>
<condition field="destination_number"<br>
expression="^(sip:)?([a-z]([a-z0-9])+)(@${domain})?"><br>
<action application="export" data="dialed=$2"/><br>
<action application="export" data="processed=true"/><br>
<action application="set" data="ringback=${us-ring}"/><br>
<action application="set" data="call_timeout=30"/><br>
<action application="set" data="hangup_after_bridge=true"/><br>
<action application="set" data="fail_on_single_reject=false" /><br>
<action application="set" data="ignore_early_media=true" /><br>
<action application="info"/><br>
<action application="bridge"<br>
data="user/${<a href="mailto:dialed%7D@172.16.0.216">dialed}@172.16.0.216</a>,${rtmp_contact(default/${<a href="mailto:dialed%7D@172.16.0.216">dialed}@172.16.0.216</a>)}"/><br>
</condition><br>
</extension><br>
<br>
FS version:<br>
FreeSWITCH Version 1.2.15+git~20131205T011841Z~cb244aea1d~64bit (git<br>
cb244ae 2013-12-05 01:18:41Z 64bit)<br>
<br>
Full log from second call (the first was ok!)<br>
2013-12-05 11:23:20.387941 [DEBUG] rtmp.c:905 [chunk_stream=2 type=0x4<br>
ts=7649694 stream_id=0x0] len=10<br>
2013-12-05 11:23:20.387941 [DEBUG] rtmp.c:77 Control (3): 00 00 00 00 00<br>
00 00 c8<br>
2013-12-05 11:23:20.387941 [WARNING] rtmp.c:101 [amfnumber=2] Unhandled<br>
control packet (type=0x3)<br>
2013-12-05 11:23:20.387941 [DEBUG] rtmp.c:905 [chunk_stream=3 type=0x14<br>
ts=76296 stream_id=0x0] len=25<br>
2013-12-05 11:23:20.387941 [DEBUG] rtmp.c:171 [amfnumber=3] Got INVOKE<br>
for createStream<br>
2013-12-05 11:23:20.387941 [DEBUG] rtmp.c:572 [amfnumber=3 type=0x14<br>
stream_id=0x0] len=29<br>
2013-12-05 11:23:20.387941 [INFO] rtmp_sig.c:136 Replied to createStream<br>
(17)<br>
2013-12-05 11:23:20.387941 [DEBUG] rtmp.c:905 [chunk_stream=3 type=0x14<br>
ts=76296 stream_id=0x0] len=25<br>
2013-12-05 11:23:20.387941 [DEBUG] rtmp.c:171 [amfnumber=3] Got INVOKE<br>
for createStream<br>
2013-12-05 11:23:20.387941 [DEBUG] rtmp.c:572 [amfnumber=3 type=0x14<br>
stream_id=0x0] len=29<br>
2013-12-05 11:23:20.387941 [INFO] rtmp_sig.c:136 Replied to createStream<br>
(18)<br>
2013-12-05 11:23:20.387941 [DEBUG] rtmp.c:905 [chunk_stream=3 type=0x14<br>
ts=76296 stream_id=0x0] len=81<br>
2013-12-05 11:23:20.387941 [DEBUG] rtmp.c:171 [amfnumber=3] Got INVOKE<br>
for makeCall<br>
2013-12-05 11:23:20.387941 [INFO] mod_rtmp.c:953 New FreeSWITCH session<br>
created: ca7f1924-5db8-11e3-90b2-8518b7899937<br>
2013-12-05 11:23:20.387941 [NOTICE] switch_channel.c:1052 New Channel<br>
rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a><br>
[ca7f1924-5db8-11e3-90b2-8518b7899937]<br>
2013-12-05 11:23:20.418092 [DEBUG] mod_rtmp.c:1007<br>
(rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>) State Change CS_NEW -> CS_INIT<br>
2013-12-05 11:23:20.418092 [DEBUG] switch_core_session.c:1351 Send<br>
signal rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> [BREAK]<br>
2013-12-05 11:23:20.418092 [DEBUG] rtmp.c:572 [amfnumber=3 type=0x14<br>
stream_id=0x0] len=114<br>
2013-12-05 11:23:20.418092 [DEBUG] switch_core_state_machine.c:415<br>
(rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>) Running State Change CS_INIT<br>
2013-12-05 11:23:20.418092 [DEBUG] rtmp.c:572 [amfnumber=3 type=0x14<br>
stream_id=0x0] len=60<br>
2013-12-05 11:23:20.418092 [DEBUG] switch_core_state_machine.c:454<br>
(rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>) State INIT<br>
2013-12-05 11:23:20.418092 [DEBUG] rtmp.c:572 [amfnumber=3 type=0x14<br>
stream_id=0x0] len=68<br>
2013-12-05 11:23:20.418092 [DEBUG] rtmp.c:905 [chunk_stream=2 type=0x4<br>
ts=7649694 stream_id=0x0] len=10<br>
2013-12-05 11:23:20.418092 [DEBUG] rtmp.c:77 Control (3): 00 00 00 11 00<br>
00 00 c8<br>
2013-12-05 11:23:20.418092 [WARNING] rtmp.c:101 [amfnumber=2] Unhandled<br>
control packet (type=0x3)<br>
2013-12-05 11:23:20.418092 [DEBUG] mod_rtmp.c:171<br>
(rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>) State Change CS_INIT -> CS_ROUTING<br>
2013-12-05 11:23:20.418092 [DEBUG] switch_core_session.c:1351 Send<br>
signal rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> [BREAK]<br>
2013-12-05 11:23:20.418092 [DEBUG] rtmp.c:905 [chunk_stream=8 type=0x14<br>
ts=76296 stream_id=0x11] len=24<br>
2013-12-05 11:23:20.418092 [DEBUG] switch_core_state_machine.c:454<br>
(rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>) State INIT going to sleep<br>
2013-12-05 11:23:20.418092 [DEBUG] rtmp.c:171 [amfnumber=8] Got INVOKE<br>
for play<br>
2013-12-05 11:23:20.418092 [DEBUG] rtmp_sig.c:188 Got play for play on<br>
stream 17<br>
2013-12-05 11:23:20.418092 [DEBUG] rtmp.c:572 [amfnumber=2 type=0x4<br>
stream_id=0x0] len=6<br>
2013-12-05 11:23:20.418092 [DEBUG] rtmp.c:572 [amfnumber=2 type=0x4<br>
stream_id=0x0] len=10<br>
2013-12-05 11:23:20.418092 [DEBUG] rtmp.c:572 [amfnumber=5 type=0x14<br>
stream_id=0x11] len=135<br>
2013-12-05 11:23:20.418092 [DEBUG] rtmp.c:572 [amfnumber=5 type=0x14<br>
stream_id=0x11] len=135<br>
2013-12-05 11:23:20.418092 [DEBUG] rtmp.c:572 [amfnumber=5 type=0x12<br>
stream_id=0x11] len=44<br>
2013-12-05 11:23:20.418092 [DEBUG] rtmp.c:572 [amfnumber=5 type=0x12<br>
stream_id=0x11] len=24<br>
2013-12-05 11:23:20.418092 [DEBUG] rtmp.c:905 [chunk_stream=14 type=0x14<br>
ts=76296 stream_id=0x12] len=37<br>
2013-12-05 11:23:20.418092 [DEBUG] switch_core_state_machine.c:415<br>
(rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>) Running State Change CS_ROUTING<br>
2013-12-05 11:23:20.418092 [DEBUG] rtmp.c:171 [amfnumber=14] Got INVOKE<br>
for publish<br>
2013-12-05 11:23:20.418092 [DEBUG] switch_channel.c:2164<br>
(rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>) Callstate Change DOWN -> RINGING<br>
2013-12-05 11:23:20.418092 [DEBUG] rtmp.c:572 [amfnumber=2 type=0x4<br>
stream_id=0x0] len=6<br>
2013-12-05 11:23:20.418092 [DEBUG] rtmp.c:572 [amfnumber=14 type=0x14<br>
stream_id=0x0] len=21<br>
2013-12-05 11:23:20.418092 [INFO] rtmp_sig.c:274 Got publish on stream 18.<br>
2013-12-05 11:23:20.418092 [DEBUG] rtmp.c:905 [chunk_stream=8 type=0x14<br>
ts=76296 stream_id=0x11] len=27<br>
2013-12-05 11:23:20.418092 [DEBUG] rtmp.c:171 [amfnumber=8] Got INVOKE<br>
for receiveAudio<br>
2013-12-05 11:23:20.418092 [INFO] rtmp_sig.c:159 Sending audio<br>
2013-12-05 11:23:20.418092 [DEBUG] switch_core_state_machine.c:470<br>
(rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>) State ROUTING<br>
2013-12-05 11:23:20.418092 [DEBUG] rtmp.c:572 [amfnumber=3 type=0x14<br>
stream_id=0x0] len=71<br>
2013-12-05 11:23:20.418092 [DEBUG] mod_rtmp.c:197<br>
rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> CHANNEL ROUTING<br>
2013-12-05 11:23:20.418092 [DEBUG] switch_core_state_machine.c:117<br>
rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> Standard ROUTING<br>
2013-12-05 11:23:20.418092 [INFO] mod_dialplan_xml.c:558 Processing<br>
<user1001>-><a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> in context default<br>
Dialplan: rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> parsing<br>
[default->global] continue=true<br>
Dialplan: rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> Regex (FAIL) [global]<br>
${call_debug}(false) =~ /^true$/ break=never<br>
Dialplan: rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> Absolute Condition [global]<br>
Dialplan: rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> Action<br>
export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})<br>
Dialplan: rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> parsing<br>
[default->conferencias web] continue=false<br>
Dialplan: rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> Regex (FAIL)<br>
[conferencias web] destination_number(<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>) =~<br>
/^(_conf_.*)$/<br>
break=on-false<br>
<br>
Dialplan: rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> parsing<br>
[default->show_info] continue=false<br>
Dialplan: rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> Regex (FAIL)<br>
[show_info] destination_number(<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>) =~<br>
/^(sip:)?(9192+)(@<a href="http://172.16.0.216" target="_blank">172.16.0.216</a>)?/<br>
break=on-false<br>
<br>
Dialplan: rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> parsing<br>
[default->transf_both_legs] continue=false<br>
Dialplan: rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> Regex (FAIL)<br>
[transf_both_legs] destination_number(<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>) =~<br>
/^transf_both_(.*)_(.*)_(.*)$/<br>
break=on-false<br>
<br>
Dialplan: rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> parsing<br>
[default->autenticado] continue=false<br>
Dialplan: rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> Regex (PASS)<br>
[autenticado] destination_number(<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>) =~<br>
/^(sip:)?([a-z]([a-z0-9])+)(@<a href="http://172.16.0.216" target="_blank">172.16.0.216</a>)?/<br>
break=on-false<br>
<br>
Dialplan: rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> Action<br>
export(dialed=user1002)<br>
Dialplan: rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> Action<br>
export(processed=true)<br>
Dialplan: rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> Action<br>
set(ringback=${us-ring})<br>
Dialplan: rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> Action<br>
set(call_timeout=30)<br>
Dialplan: rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> Action<br>
set(hangup_after_bridge=true)<br>
Dialplan: rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> Action<br>
set(fail_on_single_reject=false)<br>
Dialplan: rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> Action<br>
set(ignore_early_media=true)<br>
Dialplan: rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> Action info()<br>
Dialplan: rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> Action<br>
bridge(user/${<a href="mailto:dialed%7D@172.16.0.216">dialed}@172.16.0.216</a>,${rtmp_contact(default/${<a href="mailto:dialed%7D@172.16.0.216">dialed}@172.16.0.216</a>)})<br>
<br>
2013-12-05 11:23:20.418092 [DEBUG] switch_core_state_machine.c:167<br>
(rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>) State Change CS_ROUTING -><br>
CS_EXECUTE<br>
2013-12-05 11:23:20.418092 [DEBUG] switch_core_session.c:1351 Send<br>
signal rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> [BREAK]<br>
2013-12-05 11:23:20.418092 [DEBUG] switch_core_state_machine.c:470<br>
(rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>) State ROUTING going to sleep<br>
2013-12-05 11:23:20.418092 [DEBUG] switch_core_state_machine.c:415<br>
(rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>) Running State Change CS_EXECUTE<br>
2013-12-05 11:23:20.418092 [DEBUG] switch_core_state_machine.c:477<br>
(rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>) State EXECUTE<br>
2013-12-05 11:23:20.418092 [DEBUG] rtmp.c:572 [amfnumber=3 type=0x14<br>
stream_id=0x0] len=71<br>
2013-12-05 11:23:20.418092 [DEBUG] mod_rtmp.c:215<br>
rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> CHANNEL EXECUTE<br>
2013-12-05 11:23:20.418092 [DEBUG] switch_core_state_machine.c:209<br>
rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> Standard EXECUTE<br>
EXECUTE rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> export(RFC2822_DATE=Thu,<br>
05 Dec 2013 11:23:20 -0300)<br>
2013-12-05 11:23:20.418092 [DEBUG] switch_channel.c:1244 EXPORT<br>
(export_vars) [RFC2822_DATE]=[Thu, 05 Dec 2013 11:23:20 -0300]<br>
EXECUTE rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> export(dialed=user1002)<br>
2013-12-05 11:23:20.418092 [DEBUG] switch_channel.c:1244 EXPORT<br>
(export_vars) [dialed]=[user1002]<br>
EXECUTE rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> export(processed=true)<br>
2013-12-05 11:23:20.418092 [DEBUG] switch_channel.c:1244 EXPORT<br>
(export_vars) [processed]=[true]<br>
EXECUTE rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a><br>
set(ringback=%(2000,4000,440,480))<br>
2013-12-05 11:23:20.418092 [DEBUG] mod_dptools.c:1402<br>
rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> SET [ringback]=[%(2000,4000,440,480)]<br>
EXECUTE rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> set(call_timeout=30)<br>
2013-12-05 11:23:20.418092 [DEBUG] mod_dptools.c:1402<br>
rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> SET [call_timeout]=[30]<br>
EXECUTE rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> set(hangup_after_bridge=true)<br>
2013-12-05 11:23:20.418092 [DEBUG] mod_dptools.c:1402<br>
rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> SET [hangup_after_bridge]=[true]<br>
EXECUTE rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a><br>
set(fail_on_single_reject=false)<br>
2013-12-05 11:23:20.418092 [DEBUG] mod_dptools.c:1402<br>
rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> SET [fail_on_single_reject]=[false]<br>
EXECUTE rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> set(ignore_early_media=true)<br>
2013-12-05 11:23:20.447790 [DEBUG] mod_dptools.c:1402<br>
rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> SET [ignore_early_media]=[true]<br>
EXECUTE rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> info()<br>
2013-12-05 11:23:20.447790 [INFO] mod_dptools.c:1614 CHANNEL_DATA:<br>
Channel-State:<br>
[CS_EXECUTE]<br>
<br>
Channel-Call-State:<br>
[RINGING]<br>
<br>
Channel-State-Number:<br>
[4]<br>
<br>
Channel-Name:<br>
[rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>]<br>
<br>
Unique-ID:<br>
[ca7f1924-5db8-11e3-90b2-8518b7899937]<br>
<br>
Call-Direction:<br>
[inbound]<br>
<br>
Presence-Call-Direction:<br>
[inbound]<br>
<br>
Channel-HIT-Dialplan:<br>
[true]<br>
<br>
Channel-Call-UUID:<br>
[ca7f1924-5db8-11e3-90b2-8518b7899937]<br>
<br>
Answer-State:<br>
[ringing]<br>
<br>
Channel-Read-Codec-Name:<br>
[SPEEX]<br>
<br>
Channel-Read-Codec-Rate:<br>
[16000]<br>
<br>
Channel-Read-Codec-Bit-Rate:<br>
[42200]<br>
<br>
Channel-Write-Codec-Name:<br>
[SPEEX]<br>
<br>
Channel-Write-Codec-Rate:<br>
[16000]<br>
<br>
Channel-Write-Codec-Bit-Rate:<br>
[42200]<br>
<br>
Caller-Direction:<br>
[inbound]<br>
<br>
Caller-Username:<br>
[user1001]<br>
<br>
Caller-Dialplan:<br>
[XML]<br>
<br>
Caller-Caller-ID-Number:<br>
[user1001]<br>
<br>
Caller-Orig-Caller-ID-Number:<br>
[user1001]<br>
<br>
Caller-Network-Addr:<br>
[192.168.0.156]<br>
<br>
Caller-Destination-Number:<br>
[<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>]<br>
<br>
Caller-Unique-ID:<br>
[ca7f1924-5db8-11e3-90b2-8518b7899937]<br>
<br>
Caller-Source:<br>
[mod_rtmp]<br>
<br>
Caller-Context:<br>
[default]<br>
<br>
Caller-Channel-Name:<br>
[rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>]<br>
<br>
Caller-Profile-Index:<br>
[1]<br>
<br>
Caller-Profile-Created-Time:<br>
[1386253400418092]<br>
<br>
Caller-Channel-Created-Time:<br>
[1386253400418092]<br>
<br>
Caller-Channel-Answered-Time:<br>
[0]<br>
<br>
Caller-Channel-Progress-Time:<br>
[0]<br>
<br>
Caller-Channel-Progress-Media-Time:<br>
[0]<br>
<br>
Caller-Channel-Hangup-Time:<br>
[0]<br>
<br>
Caller-Channel-Transfer-Time:<br>
[0]<br>
<br>
Caller-Channel-Resurrect-Time:<br>
[0]<br>
<br>
Caller-Channel-Bridged-Time:<br>
[0]<br>
<br>
Caller-Channel-Last-Hold:<br>
[0]<br>
<br>
Caller-Channel-Hold-Accum:<br>
[0]<br>
<br>
Caller-Screen-Bit:<br>
[true]<br>
<br>
Caller-Privacy-Hide-Name:<br>
[false]<br>
<br>
Caller-Privacy-Hide-Number:<br>
[false]<br>
<br>
variable_direction:<br>
[inbound]<br>
<br>
variable_uuid:<br>
[ca7f1924-5db8-11e3-90b2-8518b7899937]<br>
<br>
variable_session_id:<br>
[56]<br>
<br>
variable_channel_name:<br>
[rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>]<br>
<br>
variable_user_context:<br>
[default]<br>
<br>
variable_effective_caller_id_name: [Abel<br>
Valencia]<br>
<br>
variable_user_name:<br>
[user1001]<br>
<br>
variable_domain_name:<br>
[172.16.0.216]<br>
<br>
variable_rtmp_authorized:<br>
[true]<br>
<br>
variable_read_codec:<br>
[SPEEX]<br>
<br>
variable_read_rate:<br>
[16000]<br>
<br>
variable_write_codec:<br>
[SPEEX]<br>
<br>
variable_write_rate:<br>
[16000]<br>
<br>
variable_rtmp_profile:<br>
[default]<br>
<br>
variable_rtmp_session:<br>
[9d04d178-5db8-11e3-8fd7-8518b7899937]<br>
<br>
variable_rtmp_flash_version: [LNX<br>
11,2,202,310]<br>
<br>
variable_rtmp_swf_url:<br>
[<a href="https://172.16.0.216/flash/phone.swf" target="_blank">https://172.16.0.216/flash/phone.swf</a>]<br>
<br>
variable_rtmp_tc_url:<br>
[rtmp://<a href="http://172.16.0.216:1935" target="_blank">172.16.0.216:1935</a>]<br>
<br>
variable_rtmp_page_url:<br>
[<a href="https://172.16.0.216" target="_blank">https://172.16.0.216</a>]<br>
<br>
variable_rtmp_remote_address:<br>
[192.168.0.156]<br>
<br>
variable_rtmp_remote_port:<br>
[44345]<br>
<br>
variable_DP_MATCH:<br>
[<a href="mailto:ARRAY%3A%3Asip%3Auser1002@172.16.0.216">ARRAY::sip:user1002@172.16.0.216</a>|:sip:|:user1002|:2|:@<a href="http://172.16.0.216" target="_blank">172.16.0.216</a>]<br>
<br>
variable_call_uuid:<br>
[ca7f1924-5db8-11e3-90b2-8518b7899937]<br>
<br>
variable_RFC2822_DATE: [Thu, 05 Dec 2013 11:23:20<br>
-0300]<br>
<br>
variable_dialed:<br>
[user1002]<br>
<br>
variable_processed:<br>
[true]<br>
<br>
variable_export_vars:<br>
[RFC2822_DATE,dialed,processed]<br>
<br>
variable_ringback:<br>
[%(2000,4000,440,480)]<br>
<br>
variable_call_timeout:<br>
[30]<br>
<br>
variable_hangup_after_bridge:<br>
[true]<br>
<br>
variable_fail_on_single_reject:<br>
[false]<br>
<br>
variable_ignore_early_media:<br>
[true]<br>
<br>
variable_current_application:<br>
[info]<br>
<br>
<br>
<br>
EXECUTE rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a><br>
bridge(user/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>,rtmp/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>)<br>
2013-12-05 11:23:20.447790 [DEBUG] switch_channel.c:1198<br>
rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> EXPORTING[export_vars]<br>
[RFC2822_DATE]=[Thu, 05 Dec 2013 11:23:20 -0300] to<br>
event<br>
<br>
2013-12-05 11:23:20.447790 [DEBUG] switch_channel.c:1198<br>
rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> EXPORTING[export_vars]<br>
[dialed]=[user1002] to event<br>
2013-12-05 11:23:20.447790 [DEBUG] switch_channel.c:1198<br>
rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> EXPORTING[export_vars]<br>
[processed]=[true] to event<br>
2013-12-05 11:23:20.447790 [DEBUG] switch_ivr_originate.c:2061 Parsing<br>
global variables<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_channel.c:1198<br>
rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> EXPORTING[export_vars]<br>
[RFC2822_DATE]=[Thu, 05 Dec 2013 11:23:20 -0300] to<br>
event<br>
<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_channel.c:1198<br>
rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> EXPORTING[export_vars]<br>
[dialed]=[user1002] to event<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_channel.c:1198<br>
rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> EXPORTING[export_vars]<br>
[processed]=[true] to event<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_ivr_originate.c:2061 Parsing<br>
global variables<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_event.c:1654 Parsing variable<br>
[presence_id]=[<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>]<br>
2013-12-05 11:23:20.487852 [NOTICE] switch_ivr_originate.c:2662 Cannot<br>
create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_ivr_originate.c:3639 Originate<br>
Resulted in Error Cause: 606 [USER_NOT_REGISTERED]<br>
2013-12-05 11:23:20.487852 [NOTICE] switch_ivr_originate.c:2662 Cannot<br>
create outgoing channel of type [user] cause: [USER_NOT_REGISTERED]<br>
2013-12-05 11:23:20.487852 [NOTICE] switch_channel.c:1052 New Channel<br>
rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a><br>
[ca8dfa2a-5db8-11e3-90c8-8518b7899937]<br>
<br>
2013-12-05 11:23:20.487852 [NOTICE] mod_rtmp.c:670 Ring Ready<br>
rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>!<br>
2013-12-05 11:23:20.487852 [NOTICE] mod_rtmp.c:670 Ring-Ready<br>
rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>!<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_channel.c:3238<br>
(rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>) Callstate<br>
Change DOWN -><br>
RINGING<br>
<br>
2013-12-05 11:23:20.487852 [DEBUG] rtmp.c:572 [amfnumber=3 type=0x14<br>
stream_id=0x0] len=119<br>
2013-12-05 11:23:20.487852 [DEBUG] mod_rtmp.c:673<br>
(rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>) State<br>
Change CS_NEW -><br>
CS_INIT<br>
<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_core_session.c:1351 Send<br>
signal<br>
rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a><br>
[BREAK]<br>
<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_core_state_machine.c:415<br>
(rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>) Running<br>
State Change<br>
CS_INIT<br>
<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_core_state_machine.c:454<br>
(rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>) State<br>
INIT<br>
<br>
2013-12-05 11:23:20.487852 [DEBUG] rtmp.c:572 [amfnumber=3 type=0x14<br>
stream_id=0x0] len=71<br>
2013-12-05 11:23:20.487852 [DEBUG] mod_rtmp.c:171<br>
(rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>) State<br>
Change CS_INIT -><br>
CS_ROUTING<br>
<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_core_session.c:1351 Send<br>
signal<br>
rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a><br>
[BREAK]<br>
<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_core_state_machine.c:454<br>
(rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>) State<br>
INIT going to<br>
sleep<br>
<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_core_state_machine.c:415<br>
(rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>) Running<br>
State Change<br>
CS_ROUTING<br>
<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_core_state_machine.c:470<br>
(rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>) State<br>
ROUTING<br>
<br>
2013-12-05 11:23:20.487852 [DEBUG] rtmp.c:572 [amfnumber=3 type=0x14<br>
stream_id=0x0] len=71<br>
2013-12-05 11:23:20.487852 [DEBUG] mod_rtmp.c:197<br>
rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a><br>
CHANNEL ROUTING<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_core_state_machine.c:117<br>
rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a><br>
Standard<br>
ROUTING<br>
<br>
2013-12-05 11:23:20.487852 [INFO] mod_dialplan_xml.c:558 Processing Abel<br>
Valencia<br>
<user1001>->99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a><br>
in context<br>
default<br>
<br>
Dialplan:<br>
rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a><br>
parsing [default->global] continue=true<br>
2013-12-05 11:23:20.487852 [NOTICE] mod_rtmp.c:549 Pre-Answer<br>
rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>!<br>
Dialplan:<br>
rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a><br>
Regex (FAIL) [global] ${call_debug}(false) =~ /^true$/<br>
break=never<br>
<br>
Dialplan:<br>
rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a><br>
Absolute Condition [global]<br>
Dialplan:<br>
rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a><br>
Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})<br>
Dialplan:<br>
rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a><br>
parsing [default->conferencias web] continue=false<br>
Dialplan:<br>
rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a><br>
Regex (FAIL) [conferencias web]<br>
destination_number(99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>)<br>
=~ /^(_conf_.*)$/<br>
break=on-false<br>
<br>
Dialplan:<br>
rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a><br>
parsing [default->show_info] continue=false<br>
Dialplan:<br>
rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a><br>
Regex (FAIL) [show_info]<br>
destination_number(99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>)<br>
=~ /^(sip:)?(9192+)(@<a href="http://172.16.0.216" target="_blank">172.16.0.216</a>)?/<br>
break=on-false<br>
Dialplan:<br>
rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a><br>
parsing [default->transf_both_legs] continue=false<br>
Dialplan:<br>
rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a><br>
Regex (FAIL) [transf_both_legs]<br>
destination_number(99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>)<br>
=~ /^transf_both_(.*)_(.*)_(.*)$/<br>
break=on-false<br>
Dialplan:<br>
rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a><br>
parsing [default->autenticado] continue=false<br>
Dialplan:<br>
rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a><br>
Regex (FAIL) [autenticado]<br>
destination_number(99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>)<br>
=~ /^(sip:)?([a-z]([a-z0-9])+)(@<a href="http://172.16.0.216" target="_blank">172.16.0.216</a>)?/<br>
break=on-false<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_core_state_machine.c:167<br>
(rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>) State<br>
Change CS_ROUTING -><br>
CS_EXECUTE<br>
<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_core_session.c:1351 Send<br>
signal<br>
rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a><br>
[BREAK]<br>
<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_core_state_machine.c:470<br>
(rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>) State<br>
ROUTING going to<br>
sleep<br>
<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_core_state_machine.c:415<br>
(rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>) Running<br>
State Change<br>
CS_EXECUTE<br>
<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_core_state_machine.c:477<br>
(rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>) State<br>
EXECUTE<br>
<br>
2013-12-05 11:23:20.487852 [DEBUG] rtmp.c:572 [amfnumber=3 type=0x14<br>
stream_id=0x0] len=71<br>
2013-12-05 11:23:20.487852 [DEBUG] mod_rtmp.c:215<br>
rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a><br>
CHANNEL EXECUTE<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_core_state_machine.c:209<br>
rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a><br>
Standard<br>
EXECUTE<br>
<br>
EXECUTE<br>
rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a><br>
export(RFC2822_DATE=Thu, 05 Dec 2013 11:23:20 -0300)<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_channel.c:3364<br>
(rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>) Callstate Change RINGING -> EARLY<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_channel.c:1244 EXPORT<br>
(export_vars) [RFC2822_DATE]=[Thu, 05 Dec 2013 11:23:20 -0300]<br>
2013-12-05 11:23:20.487852 [DEBUG] rtmp.c:572 [amfnumber=3 type=0x14<br>
stream_id=0x0] len=69<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_core_session.c:871 Send signal<br>
rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> [BREAK]<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_ivr_originate.c:1248 Raw Codec<br>
Activation Success L16@16000hz 1 channel 20ms<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_core_codec.c:219<br>
rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> Push codec L16:70<br>
2013-12-05 11:23:20.487852 [NOTICE] switch_core_state_machine.c:262<br>
rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a><br>
has executed the last dialplan instruction, hanging<br>
up.<br>
<br>
2013-12-05 11:23:20.487852 [NOTICE] switch_core_state_machine.c:264<br>
Hangup<br>
rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a><br>
[CS_EXECUTE]<br>
[NORMAL_CLEARING]<br>
<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_ivr_originate.c:1316 Play<br>
Ringback Tone [%(2000,4000,440,480)]<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_channel.c:3183 Send signal<br>
rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a><br>
[KILL]<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_core_session.c:1351 Send<br>
signal<br>
rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a><br>
[BREAK]<br>
<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_core_state_machine.c:477<br>
(rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>) State<br>
EXECUTE going to<br>
sleep<br>
<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_core_state_machine.c:415<br>
(rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>) Running<br>
State Change<br>
CS_HANGUP<br>
<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_core_state_machine.c:678<br>
(rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>) State<br>
HANGUP<br>
<br>
2013-12-05 11:23:20.487852 [DEBUG] mod_rtmp.c:273<br>
rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a><br>
CHANNEL HANGUP<br>
2013-12-05 11:23:20.487852 [DEBUG] rtmp.c:572 [amfnumber=3 type=0x14<br>
stream_id=0x0] len=71<br>
2013-12-05 11:23:20.487852 [DEBUG] rtmp.c:572 [amfnumber=3 type=0x14<br>
stream_id=0x0] len=78<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_core_state_machine.c:48<br>
rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a><br>
Standard HANGUP, cause:<br>
NORMAL_CLEARING<br>
<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_core_state_machine.c:678<br>
(rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>) State<br>
HANGUP going to<br>
sleep<br>
<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_core_state_machine.c:689<br>
(rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>) Callstate<br>
Change RINGING -><br>
HANGUP<br>
<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_core_state_machine.c:446<br>
(rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>) State<br>
Change CS_HANGUP -><br>
CS_REPORTING<br>
<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_core_session.c:1351 Send<br>
signal<br>
rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a><br>
[BREAK]<br>
<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_core_state_machine.c:415<br>
(rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>) Running<br>
State Change<br>
CS_REPORTING<br>
<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_core_state_machine.c:761<br>
(rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>) State<br>
REPORTING<br>
<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_core_state_machine.c:92<br>
rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a><br>
Standard REPORTING, cause:<br>
NORMAL_CLEARING<br>
<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_core_state_machine.c:761<br>
(rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>) State<br>
REPORTING going to<br>
sleep<br>
<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_core_state_machine.c:440<br>
(rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>) State<br>
Change CS_REPORTING -><br>
CS_DESTROY<br>
<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_core_session.c:1351 Send<br>
signal<br>
rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a><br>
[BREAK]<br>
<br>
2013-12-05 11:23:20.487852 [DEBUG] switch_core_session.c:1559 Session 57<br>
(rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>) Locked,<br>
Waiting on external<br>
entities<br>
<br>
2013-12-05 11:23:20.507798 [DEBUG] switch_core_codec.c:244<br>
rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> Restore previous codec SPEEX:99.<br>
2013-12-05 11:23:20.507798 [DEBUG] switch_ivr_originate.c:3639 Originate<br>
Resulted in Error Cause: 16 [NORMAL_CLEARING]<br>
2013-12-05 11:23:20.507798 [INFO] mod_dptools.c:3201 Originate Failed.<br>
Cause: NORMAL_CLEARING<br>
2013-12-05 11:23:20.507798 [NOTICE] switch_channel.c:4643 Hangup<br>
rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> [CS_EXECUTE] [NORMAL_CLEARING]<br>
2013-12-05 11:23:20.507798 [DEBUG] switch_channel.c:3183 Send signal<br>
rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> [KILL]<br>
2013-12-05 11:23:20.507798 [DEBUG] switch_core_session.c:1351 Send<br>
signal rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> [BREAK]<br>
2013-12-05 11:23:20.507798 [DEBUG] switch_core_session.c:2810<br>
rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> skip receive message<br>
[APPLICATION_EXEC_COMPLETE] (channel is hungup<br>
already)<br>
<br>
2013-12-05 11:23:20.507798 [DEBUG] switch_core_state_machine.c:477<br>
(rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>) State EXECUTE going to sleep<br>
2013-12-05 11:23:20.507798 [DEBUG] switch_core_state_machine.c:415<br>
(rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>) Running State Change CS_HANGUP<br>
2013-12-05 11:23:20.507798 [DEBUG] switch_core_state_machine.c:678<br>
(rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>) State HANGUP<br>
2013-12-05 11:23:20.507798 [DEBUG] mod_rtmp.c:273<br>
rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> CHANNEL HANGUP<br>
2013-12-05 11:23:20.507798 [DEBUG] rtmp.c:572 [amfnumber=3 type=0x14<br>
stream_id=0x0] len=24<br>
2013-12-05 11:23:20.507798 [NOTICE] switch_core_session.c:1577 Session<br>
57<br>
(rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>) Ended<br>
<br>
2013-12-05 11:23:20.507798 [NOTICE] switch_core_session.c:1581 Close<br>
Channel<br>
rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a><br>
[CS_DESTROY]<br>
<br>
2013-12-05 11:23:20.507798 [DEBUG] switch_core_state_machine.c:565<br>
(rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>) Callstate<br>
Change HANGUP -><br>
DOWN<br>
<br>
2013-12-05 11:23:20.507798 [DEBUG] rtmp.c:572 [amfnumber=3 type=0x14<br>
stream_id=0x0] len=69<br>
2013-12-05 11:23:20.507798 [DEBUG] switch_core_state_machine.c:568<br>
(rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>) Running<br>
State Change CS_DESTROY<br>
2013-12-05 11:23:20.507798 [DEBUG] rtmp.c:572 [amfnumber=3 type=0x14<br>
stream_id=0x0] len=78<br>
2013-12-05 11:23:20.507798 [DEBUG] switch_core_state_machine.c:48<br>
rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> Standard HANGUP, cause:<br>
NORMAL_CLEARING<br>
2013-12-05 11:23:20.507798 [DEBUG] switch_core_state_machine.c:678<br>
(rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>) State HANGUP going to sleep<br>
2013-12-05 11:23:20.507798 [DEBUG] switch_core_state_machine.c:689<br>
(rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>) Callstate Change EARLY -> HANGUP<br>
2013-12-05 11:23:20.507798 [DEBUG] switch_core_state_machine.c:578<br>
(rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>) State<br>
DESTROY<br>
2013-12-05 11:23:20.507798 [DEBUG] switch_core_state_machine.c:99<br>
rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a><br>
Standard DESTROY<br>
2013-12-05 11:23:20.507798 [DEBUG] switch_core_state_machine.c:578<br>
(rtmp/default/99e9f39c-5db8-11e3-8fd2-8518b7899937/<a href="mailto:user1002@172.16.0.216">user1002@172.16.0.216</a>) State<br>
DESTROY going to sleep<br>
2013-12-05 11:23:20.507798 [DEBUG] switch_core_state_machine.c:446<br>
(rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>) State Change CS_HANGUP -><br>
CS_REPORTING<br>
2013-12-05 11:23:20.507798 [DEBUG] switch_core_session.c:1351 Send<br>
signal rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> [BREAK]<br>
2013-12-05 11:23:20.507798 [DEBUG] switch_core_state_machine.c:415<br>
(rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>) Running State Change CS_REPORTING<br>
2013-12-05 11:23:20.507798 [DEBUG] switch_core_state_machine.c:761<br>
(rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>) State REPORTING<br>
2013-12-05 11:23:20.507798 [DEBUG] switch_core_state_machine.c:92<br>
rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> Standard REPORTING, cause:<br>
NORMAL_CLEARING<br>
2013-12-05 11:23:20.507798 [DEBUG] switch_core_state_machine.c:761<br>
(rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>) State REPORTING going to sleep<br>
2013-12-05 11:23:20.507798 [DEBUG] switch_core_state_machine.c:440<br>
(rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>) State Change CS_REPORTING -><br>
CS_DESTROY<br>
2013-12-05 11:23:20.507798 [DEBUG] switch_core_session.c:1351 Send<br>
signal rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> [BREAK]<br>
2013-12-05 11:23:20.507798 [DEBUG] switch_core_session.c:1559 Session 56<br>
(rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>) Locked, Waiting on external<br>
entities<br>
2013-12-05 11:23:20.507798 [NOTICE] switch_core_session.c:1577 Session<br>
56 (rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>) Ended<br>
2013-12-05 11:23:20.507798 [NOTICE] switch_core_session.c:1581 Close<br>
Channel rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> [CS_DESTROY]<br>
2013-12-05 11:23:20.507798 [DEBUG] switch_core_state_machine.c:565<br>
(rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>) Callstate Change HANGUP -> DOWN<br>
2013-12-05 11:23:20.507798 [DEBUG] switch_core_state_machine.c:568<br>
(rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>) Running State Change CS_DESTROY<br>
2013-12-05 11:23:20.507798 [DEBUG] switch_core_state_machine.c:578<br>
(rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>) State DESTROY<br>
2013-12-05 11:23:20.507798 [DEBUG] switch_core_state_machine.c:99<br>
rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a> Standard DESTROY<br>
2013-12-05 11:23:20.507798 [DEBUG] switch_core_state_machine.c:578<br>
(rtmp/default/<a href="mailto:sip%3Auser1002@172.16.0.216">sip:user1002@172.16.0.216</a>) State DESTROY going to sleep<br>
2013-12-05 11:23:20.747829 [DEBUG] rtmp.c:905 [chunk_stream=14 type=0x14<br>
ts=76656 stream_id=0x12] len=24<br>
2013-12-05 11:23:20.747829 [DEBUG] rtmp.c:171 [amfnumber=14] Got INVOKE<br>
for closeStream<br>
2013-12-05 11:23:20.747829 [DEBUG] rtmp.c:905 [chunk_stream=8 type=0x14<br>
ts=76656 stream_id=0x11] len=24<br>
2013-12-05 11:23:20.747829 [DEBUG] rtmp.c:171 [amfnumber=8] Got INVOKE<br>
for closeStream<br>
2013-12-05 11:23:20.807853 [DEBUG] rtmp.c:905 [chunk_stream=3 type=0x14<br>
ts=76727 stream_id=0x0] len=34<br>
2013-12-05 11:23:20.807853 [DEBUG] rtmp.c:171 [amfnumber=3] Got INVOKE<br>
for deleteStream<br>
2013-12-05 11:23:20.807853 [DEBUG] rtmp.c:905 [chunk_stream=3 type=0x14<br>
ts=76727 stream_id=0x0] len=34<br>
2013-12-05 11:23:20.807853 [DEBUG] rtmp.c:171 [amfnumber=3] Got INVOKE<br>
for deleteStream<br>
<br>
_________________________________________________________________________<br>
Professional FreeSWITCH Consulting Services:<br>
<a href="mailto:consulting@freeswitch.org">consulting@freeswitch.org</a><br>
<a href="http://www.freeswitchsolutions.com" target="_blank">http://www.freeswitchsolutions.com</a><br>
<br>
FreeSWITCH-powered IP PBX: The CudaTel Communication Server<br>
<a href="http://www.cudatel.com" target="_blank">http://www.cudatel.com</a><br>
<br>
Official FreeSWITCH Sites<br>
<a href="http://www.freeswitch.org" target="_blank">http://www.freeswitch.org</a><br>
<a href="http://wiki.freeswitch.org" target="_blank">http://wiki.freeswitch.org</a><br>
<a href="http://www.cluecon.com" target="_blank">http://www.cluecon.com</a><br>
<br>
FreeSWITCH-users mailing list<br>
<a href="mailto:FreeSWITCH-users@lists.freeswitch.org">FreeSWITCH-users@lists.freeswitch.org</a><br>
<a href="http://lists.freeswitch.org/mailman/listinfo/freeswitch-users" target="_blank">http://lists.freeswitch.org/mailman/listinfo/freeswitch-users</a><br>
UNSUBSCRIBE:<a href="http://lists.freeswitch.org/mailman/options/freeswitch-users" target="_blank">http://lists.freeswitch.org/mailman/options/freeswitch-users</a><br>
<a href="http://www.freeswitch.org" target="_blank">http://www.freeswitch.org</a><br>
</blockquote></div><br><br clear="all"><div><br></div>-- <br>Anthony Minessale II<br><br>FreeSWITCH <a href="http://www.freeswitch.org/">http://www.freeswitch.org/</a><br>ClueCon <a href="http://www.cluecon.com/">http://www.cluecon.com/</a><br>
Twitter: <a href="http://twitter.com/FreeSWITCH_wire">http://twitter.com/FreeSWITCH_wire</a><br><br>AIM: anthm<br><a href="mailto:MSN%3Aanthony_minessale@hotmail.com">MSN:anthony_minessale@hotmail.com</a><br>GTALK/JABBER/<a href="mailto:PAYPAL%3Aanthony.minessale@gmail.com">PAYPAL:anthony.minessale@gmail.com</a><br>
IRC: <a href="http://irc.freenode.net">irc.freenode.net</a> #freeswitch<br><br>FreeSWITCH Developer Conference<br><a href="mailto:sip%3A888@conference.freeswitch.org">sip:888@conference.freeswitch.org</a><br><a href="mailto:googletalk%3Aconf%2B888@conference.freeswitch.org">googletalk:conf+888@conference.freeswitch.org</a><br>
pstn:+19193869900
</div>