Pastebin the entire debug log, including the siptrace. Also include the originate line and any other dialplan config that might be used.<br>-MC<br><br><div class="gmail_quote">On Thu, Jun 23, 2011 at 11:26 PM, David Ma <span dir="ltr">&lt;<a href="mailto:mays.david@gmail.com">mays.david@gmail.com</a>&gt;</span> wrote:<br>
<blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex;">Hi Michael, <br><br>Unfortunately this problem still happens. <br><br>I enabled &quot;continue_on_fail&quot; for leg-A when I originated the call. Leg-A call went well. Then I originated leg-B call (&quot;continue_on_fail&quot; is NOT set for leg-B), which failed for  [DESTINATION_OUT_OF_ORDER]. As the consequence, leg-A was hung up by FS automatically for [ORIGINATOR_CANCEL]. <br>

<br>The log excerpt follows. <br><br>Do you think &quot;continue_on_fail&quot; should be also enabled for leg-B call?<br><br>Thanks,<br>D.Ma<br><br><font size="-1"><p class="MsoNormal"><span style="font-size:11.0pt;color:#1F497D">2011-06-24 13:29:35.887830 [DEBUG] switch_ivr_originate.c:1971 variable string 5 = [continue_on_fail=true]</span></p>

<p class="MsoNormal"><span style="font-size:11.0pt;color:#1F497D">2011-06-24 13:29:35.887830 [NOTICE] switch_channel.c:808 New Channel sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a> [c0bd700d-913c-42ad-b68f-81001bf658b8]</span></p>

</font>[...]<br>2011-06-24 13:29:48.142264 [DEBUG] switch_core_state_machine.c:372 (sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a>) State SOFT_EXECUTE going to sleep<br>
2011-06-24 13:29:48.161779 [DEBUG] switch_channel.c:2535 (sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a>) Callstate Change EARLY -&gt; HANGUP<br>
2011-06-24 13:29:48.161779 [NOTICE] switch_ivr_originate.c:1045 Hangup sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a> [CS_SOFT_EXECUTE] [DESTINATION_OUT_OF_ORDER]<br>
2011-06-24 13:29:48.161779 [DEBUG] switch_channel.c:2551 Send signal sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a> [KILL]<br>
2011-06-24 13:29:48.161779 [DEBUG] switch_core_session.c:1116 Send signal sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a> [BREAK]<br>2011-06-24 13:29:48.161779 [DEBUG] switch_core_state_machine.c:320 (sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a>) Running State Change CS_HANGUP<br>

2011-06-24 13:29:48.161779 [DEBUG] switch_channel.c:2535 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) Callstate Change ACTIVE -&gt; HANGUP<br>2011-06-24 13:29:48.161779 [NOTICE] switch_ivr_bridge.c:772 Hangup sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a> [CS_SOFT_EXECUTE] [ORIGINATOR_CANCEL]<br>

2011-06-24 13:29:48.161779 [DEBUG] switch_core_state_machine.c:557 (sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a>) State HANGUP<br>2011-06-24 13:29:48.161779 [DEBUG] mod_sofia.c:457 Channel sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a> hanging up, cause: DESTINATION_OUT_OF_ORDER<br>

2011-06-24 13:29:48.161779 [DEBUG] mod_sofia.c:510 Sending CANCEL to sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a><br>2011-06-24 13:29:48.161779 [DEBUG] switch_channel.c:2551 Send signal sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a> [KILL]<br>

2011-06-24 13:29:48.161779 [DEBUG] switch_core_session.c:1116 Send signal sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a> [BREAK]<br><br><div class="gmail_quote">
On Fri, Jun 17, 2011 at 10:52 AM, David Ma <span dir="ltr">&lt;<a href="mailto:mays.david@gmail.com" target="_blank">mays.david@gmail.com</a>&gt;</span> wrote:<br>
<blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex">Hi Michael, <br><br>Thanks very much for your prompt response! I appreciate the information provided. <br><br>I was actually searching the the existence of such a variable. I was not so luck to find it out and thereby resort to the support forum.<br>


<br>I&#39;ve modified my code to build this parameter into my application. Will feedback to you after verification.<br><br>Thanks again, <br>D.Ma<br><br><div class="gmail_quote"><div><div></div><div>On Fri, Jun 17, 2011 at 4:51 AM, Michael Collins <span dir="ltr">&lt;<a href="mailto:msc@freeswitch.org" target="_blank">msc@freeswitch.org</a>&gt;</span> wrote:<br>


</div></div><blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex"><div><div></div><div>How about setting this?<div><a href="http://wiki.freeswitch.org/wiki/Channel_Variables#continue_on_fail" target="_blank">http://wiki.freeswitch.org/wiki/Channel_Variables#continue_on_fail</a></div>


<div><br></div><div><font color="#888888">-MC</font><div><div></div><div><br><br><div class="gmail_quote">
On Thu, Jun 16, 2011 at 1:32 AM, dma <span dir="ltr">&lt;<a href="mailto:mays.david@gmail.com" target="_blank">mays.david@gmail.com</a>&gt;</span> wrote:<br><blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex">



I am creating a call-back solution. After leg-A answers, I originate leg-B<br>
call. After receiving SIP 183 from Leg-B, I bridge the 2 legs. However, in<br>
some cases, leg-A is automatically disconnected by FreeSwitch on leg-B<br>
failure, for example, DESTINATION_OUT_OF_ORDER. The application is not given<br>
a chance to handle leg-B failure event. This should not be a correct<br>
scenario because I never set &quot;hangup-after-bridge&quot;, which is false by<br>
default.<br>
<br>
The right way should be, FreeSwitch doesn&#39;t hang up leg-A automatically, but<br>
give a chance for the application to decide what to do.<br>
<br>
Please see the logs below:<br>
<br>
=================================================<br>
<br>
2011-06-10 11:09:55.370506 [DEBUG] switch_ivr_originate.c:1971 variable<br>
string 0 = [origination_caller_id_number=03996563750914]<br>
2011-06-10 11:09:55.370506 [DEBUG] switch_ivr_originate.c:1971 variable<br>
string 1 = [originate_timeout=30]<br>
2011-06-10 11:09:55.370506 [DEBUG] switch_ivr_originate.c:1971 variable<br>
string 2 = [ccd_session_id=20110610105829676824]<br>
2011-06-10 11:09:55.370506 [DEBUG] switch_ivr_originate.c:1971 variable<br>
string 3 = [sip_cid_type=pid]<br>
2011-06-10 11:09:55.370506 [DEBUG] switch_ivr_originate.c:1971 variable<br>
string 4 = [privacy=yes]<br>
2011-06-10 11:09:55.370506 [NOTICE] switch_channel.c:808 New Channel<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a><br>
[ea57b74b-a8c2-4fea-9683-98054dc03a79]<br>
2011-06-10 11:09:55.370506 [DEBUG] mod_sofia.c:4129<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) State Change CS_NEW -&gt;<br>
CS_INIT<br>
2011-06-10 11:09:55.370506 [DEBUG] switch_core_session.c:1116 Send signal<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> [BREAK]<br>
2011-06-10 11:09:55.370506 [DEBUG] switch_core_state_machine.c:320<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) Running State Change CS_INIT<br>
2011-06-10 11:09:55.370506 [DEBUG] switch_core_state_machine.c:356<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) State INIT<br>
2011-06-10 11:09:55.370506 [DEBUG] mod_sofia.c:84<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> SOFIA INIT<br>
send 984 bytes to udp/[203.208.207.212]:5060 at 03:09:55.477997:<br>
   ------------------------------------------------------------------------<br>
   INVITE <a href="mailto:sip%3A03996590031055@203.208.207.212" target="_blank">sip:03996590031055@203.208.207.212</a> SIP/2.0<br>
   Via: SIP/2.0/UDP 202.73.56.46:5080;rport;branch=z9hG4bKXjQ7eFpKypy5D<br>
   Max-Forwards: 70<br>
   From: &quot;&quot; &amp;<a href="mailto:lt%3Bsip%3A03996563750914@202.73.56.46" target="_blank">lt;sip:03996563750914@202.73.56.46</a>&amp;gt;;tag=H4ZN43UH9S9Qc<br>
   To: &amp;<a href="mailto:lt%3Bsip%3A03996590031055@203.208.207.212" target="_blank">lt;sip:03996590031055@203.208.207.212</a>&amp;gt;<br>
   Call-ID: f529ae7e-0db1-122f-c4ab-0015c5fc7ad9<br>
   CSeq: 13501633 INVITE<br>
   Contact: &amp;lt;sip:mod_sofia@202.73.56.46:5080&amp;gt;<br>
   User-Agent: FreeSWITCH-mod_sofia/1.0.7-hacked-20110603T012235Z<br>
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO,<br>
REGISTER, REFER, NOTIFY<br>
   Supported: timer, precondition, path, replaces<br>
   Allow-Events: talk, hold, refer<br>
   Privacy: none<br>
   Content-Type: application/sdp<br>
   Content-Disposition: session<br>
   Content-Length: 204<br>
   X-FS-Support: update_display<br>
   P-Asserted-Identity: &quot;&quot; &amp;<a href="mailto:lt%3Bsip%3A03996563750914@202.73.56.46" target="_blank">lt;sip:03996563750914@202.73.56.46</a>&amp;gt;<br>
<br>
   v=0<br>
   o=FreeSWITCH 1307645395 1307645396 IN IP4 202.73.56.46<br>
   s=FreeSWITCH<br>
   c=IN IP4 202.73.56.46<br>
   t=0 0<br>
   m=audio 30000 RTP/AVP 18 3 101 13<br>
   a=rtpmap:101 telephone-event/8000<br>
   a=fmtp:101 0-16<br>
   a=ptime:20<br>
   ------------------------------------------------------------------------<br>
2011-06-10 11:09:55.371674 [DEBUG] mod_sofia.c:124<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) State Change CS_INIT -&gt;<br>
CS_ROUTING<br>
2011-06-10 11:09:55.371674 [DEBUG] switch_core_session.c:1116 Send signal<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> [BREAK]<br>
2011-06-10 11:09:55.371674 [DEBUG] sofia.c:4646 Channel<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> entering state [calling][0]<br>
2011-06-10 11:09:55.373478 [DEBUG] switch_core_state_machine.c:356<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) State INIT going to sleep<br>
2011-06-10 11:09:55.373478 [DEBUG] switch_core_state_machine.c:320<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) Running State Change<br>
CS_ROUTING<br>
2011-06-10 11:09:55.373478 [DEBUG] switch_channel.c:1657<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) Callstate Change DOWN -&gt;<br>
RINGING<br>
2011-06-10 11:09:55.373478 [DEBUG] switch_core_state_machine.c:359<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) State ROUTING<br>
2011-06-10 11:09:55.373478 [DEBUG] mod_sofia.c:147<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> SOFIA ROUTING<br>
2011-06-10 11:09:55.373478 [DEBUG] switch_ivr_originate.c:66<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) State Change CS_ROUTING -&gt;<br>
CS_CONSUME_MEDIA<br>
2011-06-10 11:09:55.373478 [DEBUG] switch_core_session.c:1116 Send signal<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> [BREAK]<br>
2011-06-10 11:09:55.373478 [DEBUG] switch_core_state_machine.c:359<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) State ROUTING going to sleep<br>
2011-06-10 11:09:55.373478 [DEBUG] switch_core_state_machine.c:320<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) Running State Change<br>
CS_CONSUME_MEDIA<br>
2011-06-10 11:09:55.374485 [DEBUG] switch_core_state_machine.c:378<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) State CONSUME_MEDIA<br>
2011-06-10 11:09:55.374485 [DEBUG] switch_core_state_machine.c:378<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) State CONSUME_MEDIA going to<br>
sleep<br>
recv 307 bytes from udp/[203.208.207.212]:5060 at 03:09:55.485130:<br>
   ------------------------------------------------------------------------<br>
   SIP/2.0 100 Trying<br>
   Via: SIP/2.0/UDP<br>
10.1.1.46:5080;rport=5080;branch=z9hG4bKXjQ7eFpKypy5D;received=10.1.1.46<br>
   From: &quot;&quot; &amp;<a href="mailto:lt%3Bsip%3A03996563750914@10.1.1.46" target="_blank">lt;sip:03996563750914@10.1.1.46</a>&amp;gt;;tag=H4ZN43UH9S9Qc<br>
   To: &amp;<a href="mailto:lt%3Bsip%3A03996590031055@203.208.207.212" target="_blank">lt;sip:03996590031055@203.208.207.212</a>&amp;gt;<br>
   Call-ID: f529ae7e-0db1-122f-c4ab-0015c5fc7ad9<br>
   CSeq: 13501633 INVITE<br>
   Content-Length:     0<br>
<br>
   ------------------------------------------------------------------------<br>
recv 669 bytes from udp/[203.208.207.212]:5060 at 03:09:56.677788:<br>
   ------------------------------------------------------------------------<br>
   SIP/2.0 183 Session Progress<br>
   Via: SIP/2.0/UDP<br>
10.1.1.46:5080;rport=5080;branch=z9hG4bKXjQ7eFpKypy5D;received=10.1.1.46<br>
   From: &quot;&quot; &amp;<a href="mailto:lt%3Bsip%3A03996563750914@10.1.1.46" target="_blank">lt;sip:03996563750914@10.1.1.46</a>&amp;gt;;tag=H4ZN43UH9S9Qc<br>
   To:<br>
&amp;<a href="mailto:lt%3Bsip%3A03996590031055@203.208.207.212" target="_blank">lt;sip:03996590031055@203.208.207.212</a>&amp;gt;;tag=2QGB951HCR30000E1D0001Ll0008FJ21EI9PBW<br>
   Call-ID: f529ae7e-0db1-122f-c4ab-0015c5fc7ad9<br>
   CSeq: 13501633 INVITE<br>
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, INFO, REFER, NOTIFY,<br>
SUBSCRIBE, UPDATE<br>
   Content-Type: application/sdp<br>
   Content-Length:   189<br>
<br>
   v=0<br>
   o=- 421265648 1 IN IP4 203.208.207.219<br>
   s=session<br>
   c=IN IP4 203.208.207.196<br>
   t=0 0<br>
   m=audio 30792 RTP/AVP 18 101<br>
   a=rtpmap:18 G729/8000<br>
   a=rtpmap:101 telephone-event/8000<br>
   a=sendrecv<br>
   ------------------------------------------------------------------------<br>
2011-06-10 11:09:56.571839 [INFO] sofia.c:729<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> Update Callee ID to &quot;Outbound<br>
Call&quot; &lt;03996590031055&gt;<br>
2011-06-10 11:09:56.571839 [DEBUG] sofia.c:4646 Channel<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> entering state<br>
[proceeding][183]<br>
2011-06-10 11:09:56.571839 [DEBUG] sofia.c:4657 Remote SDP:<br>
v=0<br>
o=- 421265648 1 IN IP4 203.208.207.219<br>
s=session<br>
c=IN IP4 203.208.207.196<br>
t=0 0<br>
m=audio 30792 RTP/AVP 18 101<br>
a=rtpmap:18 G729/8000<br>
a=rtpmap:101 telephone-event/8000<br>
<br>
2011-06-10 11:09:56.571839 [DEBUG] sofia_glue.c:4467 Audio Codec Compare<br>
[G729:18:8000:20:8000]/[G729:18:8000:20:8000]<br>
2011-06-10 11:09:56.571839 [DEBUG] sofia_glue.c:2757 Set Codec<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> G729/8000 20 ms 160 samples<br>
8000 bits<br>
2011-06-10 11:09:56.571839 [DEBUG] sofia_glue.c:4565 Set 2833 dtmf send<br>
payload to 101<br>
2011-06-10 11:09:56.571839 [DEBUG] sofia_glue.c:2987 AUDIO RTP<br>
[sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>] 10.1.1.46 port 30000 -&gt;<br>
203.208.207.196 port 30792 codec: 18 ms: 20<br>
2011-06-10 11:09:56.571839 [DEBUG] switch_rtp.c:1607 Starting timer [soft]<br>
160 bytes per 20ms<br>
2011-06-10 11:09:56.573731 [DEBUG] sofia_glue.c:3228 Set 2833 dtmf send<br>
payload to 101<br>
2011-06-10 11:09:56.573731 [DEBUG] sofia_glue.c:3233 Set 2833 dtmf receive<br>
payload to 101<br>
2011-06-10 11:09:56.573731 [NOTICE] sofia_glue.c:3680 Pre-Answer<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>!<br>
2011-06-10 11:09:56.573731 [DEBUG] switch_channel.c:2627<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) Callstate Change RINGING -&gt;<br>
EARLY<br>
2011-06-10 11:09:56.573731 [DEBUG] switch_ivr_originate.c:3408 Originate<br>
Resulted in Success: [sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>]<br>
2011-06-10 11:09:56.573731 [DEBUG] mod_commands.c:3205<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) State Change<br>
CS_CONSUME_MEDIA -&gt; CS_EXECUTE<br>
2011-06-10 11:09:56.573731 [DEBUG] switch_core_session.c:1116 Send signal<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> [BREAK]<br>
2011-06-10 11:09:56.575262 [DEBUG] switch_core_state_machine.c:320<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) Running State Change<br>
CS_EXECUTE<br>
2011-06-10 11:09:56.575262 [DEBUG] switch_core_state_machine.c:366<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) State EXECUTE<br>
2011-06-10 11:09:56.575262 [DEBUG] mod_sofia.c:240<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> SOFIA EXECUTE<br>
2011-06-10 11:09:56.575262 [DEBUG] switch_core_state_machine.c:157<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> Standard EXECUTE<br>
EXECUTE sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> park()<br>
2011-06-10 11:09:56.618770 [DEBUG] switch_rtp.c:2933 Correct ip/port<br>
confirmed.<br>
recv 669 bytes from udp/[203.208.207.212]:5060 at 03:10:01.562021:<br>
   ------------------------------------------------------------------------<br>
   SIP/2.0 183 Session Progress<br>
   Via: SIP/2.0/UDP<br>
10.1.1.46:5080;rport=5080;branch=z9hG4bKXjQ7eFpKypy5D;received=10.1.1.46<br>
   From: &quot;&quot; &amp;<a href="mailto:lt%3Bsip%3A03996563750914@10.1.1.46" target="_blank">lt;sip:03996563750914@10.1.1.46</a>&amp;gt;;tag=H4ZN43UH9S9Qc<br>
   To:<br>
&amp;<a href="mailto:lt%3Bsip%3A03996590031055@203.208.207.212" target="_blank">lt;sip:03996590031055@203.208.207.212</a>&amp;gt;;tag=2QGB951HCR30000E1D0001Ll0008FJ21EI9PBW<br>
   Call-ID: f529ae7e-0db1-122f-c4ab-0015c5fc7ad9<br>
   CSeq: 13501633 INVITE<br>
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, INFO, REFER, NOTIFY,<br>
SUBSCRIBE, UPDATE<br>
   Content-Type: application/sdp<br>
   Content-Length:   189<br>
<br>
   v=0<br>
   o=- 421265648 2 IN IP4 203.208.207.219<br>
   s=session<br>
   c=IN IP4 203.208.207.196<br>
   t=0 0<br>
   m=audio 30792 RTP/AVP 18 101<br>
   a=rtpmap:18 G729/8000<br>
   a=rtpmap:101 telephone-event/8000<br>
   a=sendrecv<br>
   ------------------------------------------------------------------------<br>
2011-06-10 11:10:01.455944 [INFO] sofia.c:729<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> Update Callee ID to<br>
&quot;03996590031055&quot; &lt;03996590031055&gt;<br>
2011-06-10 11:10:01.455944 [DEBUG] sofia.c:4641 Channel<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> skipping state<br>
[proceeding][183]<br>
recv 669 bytes from udp/[203.208.207.212]:5060 at 03:10:01.563178:<br>
   ------------------------------------------------------------------------<br>
   SIP/2.0 183 Session Progress<br>
   Via: SIP/2.0/UDP<br>
10.1.1.46:5080;rport=5080;branch=z9hG4bKXjQ7eFpKypy5D;received=10.1.1.46<br>
   From: &quot;&quot; &amp;<a href="mailto:lt%3Bsip%3A03996563750914@10.1.1.46" target="_blank">lt;sip:03996563750914@10.1.1.46</a>&amp;gt;;tag=H4ZN43UH9S9Qc<br>
   To:<br>
&amp;<a href="mailto:lt%3Bsip%3A03996590031055@203.208.207.212" target="_blank">lt;sip:03996590031055@203.208.207.212</a>&amp;gt;;tag=2QGB951HCR30000E1D0001Ll0008FJ21EI9PBW<br>
   Call-ID: f529ae7e-0db1-122f-c4ab-0015c5fc7ad9<br>
   CSeq: 13501633 INVITE<br>
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, INFO, REFER, NOTIFY,<br>
SUBSCRIBE, UPDATE<br>
   Content-Type: application/sdp<br>
   Content-Length:   189<br>
<br>
   v=0<br>
   o=- 421265648 3 IN IP4 203.208.207.219<br>
   s=session<br>
   c=IN IP4 203.208.207.196<br>
   t=0 0<br>
   m=audio 30792 RTP/AVP 18 101<br>
   a=rtpmap:18 G729/8000<br>
   a=rtpmap:101 telephone-event/8000<br>
   a=sendrecv<br>
   ------------------------------------------------------------------------<br>
2011-06-10 11:10:01.457169 [DEBUG] sofia.c:4641 Channel<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> skipping state<br>
[proceeding][183]<br>
recv 749 bytes from udp/[203.208.207.212]:5060 at 03:10:27.365284:<br>
   ------------------------------------------------------------------------<br>
   SIP/2.0 200 Ok<br>
   Via: SIP/2.0/UDP<br>
10.1.1.46:5080;rport=5080;branch=z9hG4bKXjQ7eFpKypy5D;received=10.1.1.46<br>
   From: &quot;&quot; &amp;<a href="mailto:lt%3Bsip%3A03996563750914@10.1.1.46" target="_blank">lt;sip:03996563750914@10.1.1.46</a>&amp;gt;;tag=H4ZN43UH9S9Qc<br>
   To:<br>
&amp;<a href="mailto:lt%3Bsip%3A03996590031055@203.208.207.212" target="_blank">lt;sip:03996590031055@203.208.207.212</a>&amp;gt;;tag=2QGB951HCR30000E1D0001Ll0008FJ21EI9PBW<br>
   Call-ID: f529ae7e-0db1-122f-c4ab-0015c5fc7ad9<br>
   CSeq: 13501633 INVITE<br>
   Contact: &lt;sip:<a href="http://203.208.207.212:5060" target="_blank">203.208.207.212:5060</a>&gt;<br>
   Allow-Events: refer<br>
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, INFO, REFER, NOTIFY,<br>
SUBSCRIBE, UPDATE<br>
   Content-Type: application/sdp<br>
   Supported: 100rel, timer, replaces<br>
   Content-Length:   189<br>
<br>
   v=0<br>
   o=- 421265648 4 IN IP4 203.208.207.219<br>
   s=session<br>
   c=IN IP4 203.208.207.196<br>
   t=0 0<br>
   m=audio 30792 RTP/AVP 18 101<br>
   a=rtpmap:18 G729/8000<br>
   a=rtpmap:101 telephone-event/8000<br>
   a=sendrecv<br>
   ------------------------------------------------------------------------<br>
2011-06-10 11:10:27.258092 [DEBUG] sofia.c:4646 Channel<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> entering state<br>
[completing][200]<br>
2011-06-10 11:10:27.258092 [DEBUG] sofia.c:4657 Remote SDP:<br>
v=0<br>
o=- 421265648 4 IN IP4 203.208.207.219<br>
s=session<br>
c=IN IP4 203.208.207.196<br>
t=0 0<br>
m=audio 30792 RTP/AVP 18 101<br>
a=rtpmap:18 G729/8000<br>
a=rtpmap:101 telephone-event/8000<br>
<br>
send 405 bytes to udp/[203.208.207.212]:5060 at 03:10:27.366562:<br>
   ------------------------------------------------------------------------<br>
   ACK sip:<a href="http://203.208.207.212:5060" target="_blank">203.208.207.212:5060</a> SIP/2.0<br>
   Via: SIP/2.0/UDP 202.73.56.46:5080;rport;branch=z9hG4bKyUg0ga7pUZmrS<br>
   Max-Forwards: 70<br>
   From: &quot;&quot; &amp;<a href="mailto:lt%3Bsip%3A03996563750914@202.73.56.46" target="_blank">lt;sip:03996563750914@202.73.56.46</a>&amp;gt;;tag=H4ZN43UH9S9Qc<br>
   To:<br>
&amp;<a href="mailto:lt%3Bsip%3A03996590031055@203.208.207.212" target="_blank">lt;sip:03996590031055@203.208.207.212</a>&amp;gt;;tag=2QGB951HCR30000E1D0001Ll0008FJ21EI9PBW<br>
   Call-ID: f529ae7e-0db1-122f-c4ab-0015c5fc7ad9<br>
   CSeq: 13501633 ACK<br>
   Contact: &amp;lt;sip:mod_sofia@202.73.56.46:5080&amp;gt;<br>
   Content-Length: 0<br>
<br>
   ------------------------------------------------------------------------<br>
2011-06-10 11:10:27.260267 [DEBUG] sofia.c:4646 Channel<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> entering state [ready][200]<br>
2011-06-10 11:10:27.260267 [DEBUG] switch_channel.c:2782<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) Callstate Change EARLY -&gt;<br>
ACTIVE<br>
2011-06-10 11:10:27.260267 [NOTICE] sofia.c:5175 Channel<br>
[sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>] has been answered<br>
2011-06-10 11:10:27.264178 [DEBUG] switch_scheduler.c:214 Added task 23<br>
switch_ivr_schedule_hangup (ea57b74b-a8c2-4fea-9683-98054dc03a79) to run at<br>
1307676927<br>
2011-06-10 11:10:27.265202 [DEBUG] switch_core_session.c:954 Send signal<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> [BREAK]<br>
2011-06-10 11:10:27.266218 [DEBUG] switch_ivr_originate.c:1971 variable<br>
string 0 = [origination_caller_id_number=03996590031055]<br>
2011-06-10 11:10:27.266218 [DEBUG] switch_ivr_originate.c:1971 variable<br>
string 1 = [ccd_session_id=20110610105829676824]<br>
2011-06-10 11:10:27.266218 [DEBUG] switch_ivr_originate.c:1971 variable<br>
string 2 = [sip_cid_type=pid]<br>
2011-06-10 11:10:27.266218 [DEBUG] switch_ivr_originate.c:1971 variable<br>
string 3 = [privacy=yes]<br>
2011-06-10 11:10:27.266218 [NOTICE] switch_channel.c:808 New Channel<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a><br>
[30228d2b-756a-4a98-871d-db63a2955b52]<br>
2011-06-10 11:10:27.266218 [DEBUG] mod_sofia.c:4129<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) State Change CS_NEW -&gt;<br>
CS_INIT<br>
2011-06-10 11:10:27.266218 [DEBUG] switch_core_session.c:1116 Send signal<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a> [BREAK]<br>
2011-06-10 11:10:27.266218 [DEBUG] switch_core_state_machine.c:320<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) Running State Change CS_INIT<br>
2011-06-10 11:10:27.266218 [DEBUG] switch_core_state_machine.c:356<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) State INIT<br>
2011-06-10 11:10:27.266218 [DEBUG] mod_sofia.c:84<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a> SOFIA INIT<br>
2011-06-10 11:10:27.266218 [DEBUG] mod_sofia.c:124<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) State Change CS_INIT -&gt;<br>
CS_ROUTING<br>
2011-06-10 11:10:27.266218 [DEBUG] switch_core_session.c:1116 Send signal<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a> [BREAK]<br>
2011-06-10 11:10:27.266218 [DEBUG] switch_core_state_machine.c:356<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) State INIT going to sleep<br>
2011-06-10 11:10:27.266218 [DEBUG] switch_core_state_machine.c:320<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) Running State Change<br>
CS_ROUTING<br>
2011-06-10 11:10:27.266218 [DEBUG] switch_channel.c:1657<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) Callstate Change DOWN -&gt;<br>
RINGING<br>
2011-06-10 11:10:27.266218 [DEBUG] switch_core_state_machine.c:359<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) State ROUTING<br>
send 984 bytes to udp/[203.208.207.212]:5060 at 03:10:27.373220:<br>
   ------------------------------------------------------------------------<br>
   INVITE <a href="mailto:sip%3A03996563750914@203.208.207.212" target="_blank">sip:03996563750914@203.208.207.212</a> SIP/2.0<br>
   Via: SIP/2.0/UDP<br>
202.73.56.46:5080;rport;branch=z9hG4bKZ49rj5Qtr8aBN2011-06-10<br>
11:10:27.266218 [DEBUG] mod_sofia.c:147<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a> SOFIA ROUTING<br>
<br>
   Max-Forwards: 70<br>
   From: &quot;&quot; &amp;<a href="mailto:lt%3Bsip%3A03996590031055@202.73.56.46" target="_blank">lt;sip:03996590031055@202.73.56.46</a>&amp;gt;;tag=jDSe6ycN62Zar<br>
   To: &amp;<a href="mailto:lt%3Bsip%3A03996563750914@203.208.207.212" target="_blank">lt;sip:03996563750914@203.208.207.212</a>&amp;gt;<br>
   Call-ID: 082c8244-0db2-122f-c4ab-0015c5fc7ad9<br>
   CSeq: 13501649 INVITE<br>
   Contact: &amp;lt;sip:mod_sofia@202.73.56.46:5080&amp;gt;<br>
   User-Agent: FreeSWITCH-mod_sofia/1.0.7-hacked-20110603T012235Z<br>
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO,<br>
REGISTER, REFER, NOTIFY<br>
   Supported: timer, precondition, path, replaces<br>
   Allow-Events: talk, hold, refer<br>
   Privacy: none<br>
   Content-Type: application/sdp<br>
   Content-Disposition: session<br>
   Content-Length: 204<br>
   X-FS-Support: update_display<br>
   P-Asserted-Identity: &quot;&quot; &amp;<a href="mailto:lt%3Bsip%3A03996590031055@202.73.56.46" target="_blank">lt;sip:03996590031055@202.73.56.46</a>&amp;gt;<br>
<br>
   v=0<br>
   o=FreeSWITCH 1307646863 1307646864 IN IP4 202.73.56.46<br>
   s=FreeSWITCH<br>
   c=IN IP4 202.73.56.46<br>
   t=0 0<br>
   m=audio 28564 RTP/AVP 18 3 101 13<br>
   a=rtpmap:101 telephone-event/8000<br>
   a=fmtp:101 0-16<br>
   a=ptime:20<br>
   ------------------------------------------------------------------------<br>
2011-06-10 11:10:27.267630 [DEBUG] sofia.c:4646 Channel<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a> entering state [calling][0]<br>
2011-06-10 11:10:27.267630 [DEBUG] switch_ivr_originate.c:66<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) State Change CS_ROUTING -&gt;<br>
CS_CONSUME_MEDIA<br>
2011-06-10 11:10:27.267630 [DEBUG] switch_core_session.c:1116 Send signal<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a> [BREAK]<br>
2011-06-10 11:10:27.267630 [DEBUG] switch_core_state_machine.c:359<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) State ROUTING going to sleep<br>
2011-06-10 11:10:27.267630 [DEBUG] switch_core_state_machine.c:320<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) Running State Change<br>
CS_CONSUME_MEDIA<br>
2011-06-10 11:10:27.267630 [DEBUG] switch_core_state_machine.c:378<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) State CONSUME_MEDIA<br>
2011-06-10 11:10:27.267630 [DEBUG] switch_core_state_machine.c:378<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) State CONSUME_MEDIA going to<br>
sleep<br>
recv 307 bytes from udp/[203.208.207.212]:5060 at 03:10:27.378710:<br>
   ------------------------------------------------------------------------<br>
   SIP/2.0 100 Trying<br>
   Via: SIP/2.0/UDP<br>
10.1.1.46:5080;rport=5080;branch=z9hG4bKZ49rj5Qtr8aBN;received=10.1.1.46<br>
   From: &quot;&quot; &amp;<a href="mailto:lt%3Bsip%3A03996590031055@10.1.1.46" target="_blank">lt;sip:03996590031055@10.1.1.46</a>&amp;gt;;tag=jDSe6ycN62Zar<br>
   To: &amp;<a href="mailto:lt%3Bsip%3A03996563750914@203.208.207.212" target="_blank">lt;sip:03996563750914@203.208.207.212</a>&amp;gt;<br>
   Call-ID: 082c8244-0db2-122f-c4ab-0015c5fc7ad9<br>
   CSeq: 13501649 INVITE<br>
   Content-Length:     0<br>
<br>
   ------------------------------------------------------------------------<br>
2011-06-10 11:10:27.278484 [DEBUG] switch_ivr.c:563<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> Command Execute<br>
playback(/usr/local/freeswitch/sounds/clearhub/MusicForCalls_v1.wav)<br>
EXECUTE sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a><br>
playback(/usr/local/freeswitch/sounds/clearhub/MusicForCalls_v1.wav)<br>
2011-06-10 11:10:27.278484 [DEBUG] switch_core_file.c:176 File<br>
/usr/local/freeswitch/sounds/clearhub/MusicForCalls_v1.wav sample rate 11025<br>
doesn&#39;t match requested rate 8000<br>
2011-06-10 11:10:27.278484 [WARNING] switch_core_file.c:189 File has 2<br>
channels, muxing to mono will occur.<br>
2011-06-10 11:10:27.278484 [DEBUG] switch_ivr_play_say.c:1244 Codec<br>
Activated L16@8000hz 2 channels 20ms<br>
2011-06-10 11:10:27.298764 [INFO] mod_com_g729.c:119 ENCODER CREATE -<br>
0x2aaab00310c0 0x2aaab00b20c0<br>
recv 666 bytes from udp/[203.208.207.212]:5060 at 03:10:28.618472:<br>
   ------------------------------------------------------------------------<br>
   SIP/2.0 183 Session Progress<br>
   Via: SIP/2.0/UDP<br>
10.1.1.46:5080;rport=5080;branch=z9hG4bKZ49rj5Qtr8aBN;received=10.1.1.46<br>
   From: &quot;&quot; &amp;<a href="mailto:lt%3Bsip%3A03996590031055@10.1.1.46" target="_blank">lt;sip:03996590031055@10.1.1.46</a>&amp;gt;;tag=jDSe6ycN62Zar<br>
   To:<br>
&amp;<a href="mailto:lt%3Bsip%3A03996563750914@203.208.207.212" target="_blank">lt;sip:03996563750914@203.208.207.212</a>&amp;gt;;tag=2QGB951HCR30000E1D0001Ll0008FJ410OWC5F<br>
   Call-ID: 082c8244-0db2-122f-c4ab-0015c5fc7ad9<br>
   CSeq: 13501649 INVITE<br>
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, INFO, REFER, NOTIFY,<br>
SUBSCRIBE, UPDATE<br>
   Content-Type: application/sdp<br>
   Content-Length:   186<br>
<br>
   v=0<br>
   o=- 131082 1 IN IP4 203.208.207.218<br>
   s=session<br>
   c=IN IP4 203.208.207.195<br>
   t=0 0<br>
   m=audio 45002 RTP/AVP 18 101<br>
   a=rtpmap:18 G729/8000<br>
   a=rtpmap:101 telephone-event/8000<br>
   a=sendrecv<br>
   ------------------------------------------------------------------------<br>
2011-06-10 11:10:28.513195 [INFO] sofia.c:729<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a> Update Callee ID to &quot;Outbound<br>
Call&quot; &lt;03996563750914&gt;<br>
2011-06-10 11:10:28.513195 [DEBUG] sofia.c:4646 Channel<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a> entering state<br>
[proceeding][183]<br>
2011-06-10 11:10:28.513195 [DEBUG] sofia.c:4657 Remote SDP:<br>
v=0<br>
o=- 131082 1 IN IP4 203.208.207.218<br>
s=session<br>
c=IN IP4 203.208.207.195<br>
t=0 0<br>
m=audio 45002 RTP/AVP 18 101<br>
a=rtpmap:18 G729/8000<br>
a=rtpmap:101 telephone-event/8000<br>
<br>
2011-06-10 11:10:28.513195 [DEBUG] sofia_glue.c:4467 Audio Codec Compare<br>
[G729:18:8000:20:8000]/[G729:18:8000:20:8000]<br>
2011-06-10 11:10:28.513195 [DEBUG] sofia_glue.c:2757 Set Codec<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a> G729/8000 20 ms 160 samples<br>
8000 bits<br>
2011-06-10 11:10:28.513195 [DEBUG] sofia_glue.c:4565 Set 2833 dtmf send<br>
payload to 101<br>
2011-06-10 11:10:28.513195 [DEBUG] sofia_glue.c:2987 AUDIO RTP<br>
[sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>] 10.1.1.46 port 28564 -&gt;<br>
203.208.207.195 port 45002 codec: 18 ms: 20<br>
2011-06-10 11:10:28.513195 [DEBUG] switch_rtp.c:1607 Starting timer [soft]<br>
160 bytes per 20ms<br>
2011-06-10 11:10:28.514938 [DEBUG] sofia_glue.c:3228 Set 2833 dtmf send<br>
payload to 101<br>
2011-06-10 11:10:28.514938 [DEBUG] sofia_glue.c:3233 Set 2833 dtmf receive<br>
payload to 101<br>
2011-06-10 11:10:28.514938 [NOTICE] sofia_glue.c:3680 Pre-Answer<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>!<br>
2011-06-10 11:10:28.514938 [DEBUG] switch_channel.c:2627<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) Callstate Change RINGING -&gt;<br>
EARLY<br>
2011-06-10 11:10:28.514938 [DEBUG] switch_ivr_originate.c:3408 Originate<br>
Resulted in Success: [sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>]<br>
2011-06-10 11:10:28.514938 [DEBUG] mod_commands.c:3205<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) State Change<br>
CS_CONSUME_MEDIA -&gt; CS_EXECUTE<br>
2011-06-10 11:10:28.514938 [DEBUG] switch_core_session.c:1116 Send signal<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a> [BREAK]<br>
2011-06-10 11:10:28.515884 [DEBUG] switch_core_state_machine.c:320<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) Running State Change<br>
CS_EXECUTE<br>
2011-06-10 11:10:28.515884 [DEBUG] switch_core_state_machine.c:366<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) State EXECUTE<br>
2011-06-10 11:10:28.515884 [DEBUG] mod_sofia.c:240<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a> SOFIA EXECUTE<br>
2011-06-10 11:10:28.515884 [DEBUG] switch_core_state_machine.c:157<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a> Standard EXECUTE<br>
EXECUTE sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a> park()<br>
2011-06-10 11:10:28.516887 [DEBUG] switch_core_session.c:954 Send signal<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> [BREAK]<br>
2011-06-10 11:10:28.517896 [DEBUG] switch_ivr_bridge.c:1480<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) State Change CS_EXECUTE -&gt;<br>
CS_HIBERNATE<br>
2011-06-10 11:10:28.517896 [DEBUG] switch_core_session.c:1116 Send signal<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> [BREAK]<br>
2011-06-10 11:10:28.517896 [DEBUG] switch_ivr_bridge.c:1482<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) State Change CS_EXECUTE -&gt;<br>
CS_HIBERNATE<br>
2011-06-10 11:10:28.517896 [DEBUG] switch_core_session.c:1116 Send signal<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a> [BREAK]<br>
2011-06-10 11:10:28.517896 [DEBUG] switch_core_session.c:771 Send signal<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a> [BREAK]<br>
2011-06-10 11:10:28.517896 [DEBUG] switch_core_session.c:771 Send signal<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> [BREAK]<br>
2011-06-10 11:10:28.519223 [DEBUG] switch_ivr_play_say.c:1581 done playing<br>
file<br>
2011-06-10 11:10:28.519223 [DEBUG] switch_ivr.c:563<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> Command Execute<br>
playback(tone_stream://%(2000,4000,440,480);loops=10)<br>
2011-06-10 11:10:28.519223 [DEBUG] switch_core_state_machine.c:366<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) State EXECUTE going to sleep<br>
2011-06-10 11:10:28.519223 [DEBUG] switch_core_state_machine.c:320<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) Running State Change<br>
CS_HIBERNATE<br>
2011-06-10 11:10:28.519223 [DEBUG] switch_core_state_machine.c:381<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) State HIBERNATE<br>
2011-06-10 11:10:28.519223 [DEBUG] mod_sofia.c:221<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a> SOFIA HIBERNATE<br>
2011-06-10 11:10:28.519223 [DEBUG] switch_ivr_bridge.c:731<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) State Change CS_HIBERNATE -&gt;<br>
CS_RESET<br>
2011-06-10 11:10:28.519223 [DEBUG] switch_core_session.c:1116 Send signal<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a> [BREAK]<br>
2011-06-10 11:10:28.519223 [DEBUG] switch_core_state_machine.c:381<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) State HIBERNATE going to<br>
sleep<br>
2011-06-10 11:10:28.519223 [DEBUG] switch_core_state_machine.c:320<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) Running State Change<br>
CS_RESET<br>
2011-06-10 11:10:28.519223 [DEBUG] switch_core_state_machine.c:362<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) State RESET<br>
2011-06-10 11:10:28.519223 [DEBUG] mod_sofia.c:165<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a> SOFIA RESET<br>
2011-06-10 11:10:28.519223 [DEBUG] switch_ivr_bridge.c:716<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a> CUSTOM RESET<br>
2011-06-10 11:10:28.519223 [DEBUG] switch_core_state_machine.c:66<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a> Standard RESET<br>
2011-06-10 11:10:28.519223 [DEBUG] switch_core_state_machine.c:362<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) State RESET going to sleep<br>
2011-06-10 11:10:28.519223 [DEBUG] switch_core_session.c:709 Send signal<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a> [BREAK]<br>
recv 666 bytes from udp/[203.208.207.212]:5060 at 03:10:30.540814:<br>
   ------------------------------------------------------------------------<br>
   SIP/2.0 183 Session Progress<br>
   Via: SIP/2.0/UDP<br>
10.1.1.46:5080;rport=5080;branch=z9hG4bKZ49rj5Qtr8aBN;received=10.1.1.46<br>
   From: &quot;&quot; &amp;<a href="mailto:lt%3Bsip%3A03996590031055@10.1.1.46" target="_blank">lt;sip:03996590031055@10.1.1.46</a>&amp;gt;;tag=jDSe6ycN62Zar<br>
   To:<br>
&amp;<a href="mailto:lt%3Bsip%3A03996563750914@203.208.207.212" target="_blank">lt;sip:03996563750914@203.208.207.212</a>&amp;gt;;tag=2QGB951HCR30000E1D0001Ll0008FJ410OWC5F<br>
   Call-ID: 082c8244-0db2-122f-c4ab-0015c5fc7ad9<br>
   CSeq: 13501649 INVITE<br>
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, INFO, REFER, NOTIFY,<br>
SUBSCRIBE, UPDATE<br>
   Content-Type: application/sdp<br>
   Content-Length:   186<br>
<br>
   v=0<br>
   o=- 131082 2 IN IP4 203.208.207.218<br>
   s=session<br>
   c=IN IP4 203.208.207.195<br>
   t=0 0<br>
   m=audio 45002 RTP/AVP 18 101<br>
   a=rtpmap:18 G729/8000<br>
   a=rtpmap:101 telephone-event/8000<br>
   a=sendrecv<br>
   ------------------------------------------------------------------------<br>
2011-06-10 11:10:30.435309 [INFO] sofia.c:729<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a> Update Callee ID to<br>
&quot;03996563750914&quot; &lt;03996563750914&gt;<br>
2011-06-10 11:10:30.435309 [DEBUG] sofia.c:4641 Channel<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a> skipping state<br>
[proceeding][183]<br>
2011-06-10 11:10:30.691404 [WARNING] switch_core_session.c:1940 Cannot<br>
execute app &#39;playback&#39; media required on an outbound channel that does not<br>
have media established<br>
2011-06-10 11:10:30.691404 [DEBUG] switch_core_state_machine.c:366<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) State EXECUTE going to sleep<br>
2011-06-10 11:10:30.691404 [DEBUG] switch_core_state_machine.c:320<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) Running State Change<br>
CS_HIBERNATE<br>
2011-06-10 11:10:30.691404 [DEBUG] switch_core_state_machine.c:381<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) State HIBERNATE<br>
2011-06-10 11:10:30.691404 [DEBUG] mod_sofia.c:221<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> SOFIA HIBERNATE<br>
2011-06-10 11:10:30.691404 [DEBUG] switch_ivr_bridge.c:731<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) State Change CS_HIBERNATE -&gt;<br>
CS_RESET<br>
2011-06-10 11:10:30.691404 [DEBUG] switch_core_session.c:1116 Send signal<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> [BREAK]<br>
2011-06-10 11:10:30.691404 [DEBUG] switch_core_state_machine.c:381<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) State HIBERNATE going to<br>
sleep<br>
2011-06-10 11:10:30.691404 [DEBUG] switch_core_state_machine.c:320<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) Running State Change<br>
CS_RESET<br>
2011-06-10 11:10:30.691404 [DEBUG] switch_core_state_machine.c:362<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) State RESET<br>
2011-06-10 11:10:30.691404 [DEBUG] mod_sofia.c:165<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> SOFIA RESET<br>
2011-06-10 11:10:30.691404 [DEBUG] switch_ivr_bridge.c:716<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> CUSTOM RESET<br>
2011-06-10 11:10:30.691404 [DEBUG] switch_ivr_bridge.c:723<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) State Change CS_RESET -&gt;<br>
CS_SOFT_EXECUTE<br>
2011-06-10 11:10:30.691404 [DEBUG] switch_core_session.c:1116 Send signal<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> [BREAK]<br>
2011-06-10 11:10:30.691404 [DEBUG] switch_core_state_machine.c:362<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) State RESET going to sleep<br>
2011-06-10 11:10:30.691404 [DEBUG] switch_core_state_machine.c:320<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) Running State Change<br>
CS_SOFT_EXECUTE<br>
2011-06-10 11:10:30.691404 [DEBUG] switch_core_state_machine.c:372<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) State SOFT_EXECUTE<br>
2011-06-10 11:10:30.691404 [DEBUG] mod_sofia.c:558 SOFIA SOFT_EXECUTE<br>
2011-06-10 11:10:30.691404 [DEBUG] switch_ivr_bridge.c:741<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> CUSTOM SOFT_EXECUTE<br>
2011-06-10 11:10:30.691404 [DEBUG] switch_ivr_bridge.c:761<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) State Change CS_RESET -&gt;<br>
CS_SOFT_EXECUTE<br>
2011-06-10 11:10:30.691404 [DEBUG] switch_core_session.c:1116 Send signal<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a> [BREAK]<br>
2011-06-10 11:10:30.691404 [DEBUG] switch_core_state_machine.c:320<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) Running State Change<br>
CS_SOFT_EXECUTE<br>
2011-06-10 11:10:30.691404 [DEBUG] switch_core_state_machine.c:372<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) State SOFT_EXECUTE<br>
2011-06-10 11:10:30.691404 [DEBUG] mod_sofia.c:558 SOFIA SOFT_EXECUTE<br>
2011-06-10 11:10:30.691404 [DEBUG] switch_ivr_bridge.c:741<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a> CUSTOM SOFT_EXECUTE<br>
2011-06-10 11:10:30.691404 [DEBUG] switch_core_state_machine.c:204<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a> Standard SOFT_EXECUTE<br>
2011-06-10 11:10:30.691404 [DEBUG] switch_core_state_machine.c:372<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) State SOFT_EXECUTE going to<br>
sleep<br>
2011-06-10 11:10:30.711798 [DEBUG] switch_channel.c:2535<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) Callstate Change EARLY -&gt;<br>
HANGUP<br>
2011-06-10 11:10:30.711798 [NOTICE] switch_ivr_originate.c:1045 Hangup<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a> [CS_SOFT_EXECUTE]<br>
[DESTINATION_OUT_OF_ORDER]<br>
2011-06-10 11:10:30.711798 [DEBUG] switch_channel.c:2551 Send signal<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a> [KILL]<br>
2011-06-10 11:10:30.711798 [DEBUG] switch_core_session.c:1116 Send signal<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a> [BREAK]<br>
2011-06-10 11:10:30.711798 [DEBUG] switch_core_state_machine.c:320<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) Running State Change<br>
CS_HANGUP<br>
2011-06-10 11:10:30.711798 [DEBUG] switch_channel.c:2535<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) Callstate Change ACTIVE -&gt;<br>
HANGUP<br>
2011-06-10 11:10:30.711798 [DEBUG] switch_core_state_machine.c:557<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) State HANGUP<br>
2011-06-10 11:10:30.711798 [DEBUG] mod_sofia.c:457 Channel<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a> hanging up, cause:<br>
DESTINATION_OUT_OF_ORDER<br>
2011-06-10 11:10:30.711798 [DEBUG] mod_sofia.c:510 Sending CANCEL to<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a><br>
send 390 bytes to udp/[203.208.207.212]:5060 at 03:10:30.818391:<br>
   ------------------------------------------------------------------------<br>
   CANCEL <a href="mailto:sip%3A03996563750914@203.208.207.212" target="_blank">sip:03996563750914@203.208.207.212</a> SIP/2.0<br>
   Via: SIP/2.0/UDP 202.73.56.46:5080;rport;branch=z9hG4bKZ49rj5Qtr8aBN<br>
   Max-Forwards: 70<br>
   From: &quot;&quot; &amp;<a href="mailto:lt%3Bsip%3A03996590031055@202.73.56.46" target="_blank">lt;sip:03996590031055@202.73.56.46</a>&amp;gt;;tag=jDSe6ycN62Zar<br>
   To: &amp;<a href="mailto:lt%3Bsip%3A03996563750914@203.208.207.212" target="_blank">lt;sip:03996563750914@203.208.207.212</a>&amp;gt;<br>
   Call-ID: 082c8244-0db2-122f-c4ab-0015c5fc7ad9<br>
   CSeq: 13501649 CANCEL<br>
   Reason: Q.850;cause=27;text=&quot;DESTINATION_OUT_OF_ORDER&quot;<br>
   Content-Length: 0<br>
<br>
   ------------------------------------------------------------------------<br>
2011-06-10 11:10:30.711798 [NOTICE] switch_ivr_bridge.c:772 Hangup<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> [CS_SOFT_EXECUTE]<br>
[ORIGINATOR_CANCEL]<br>
2011-06-10 11:10:30.711798 [DEBUG] switch_core_state_machine.c:46<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a> Standard HANGUP, cause:<br>
DESTINATION_OUT_OF_ORDER<br>
2011-06-10 11:10:30.711798 [DEBUG] switch_core_state_machine.c:557<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) State HANGUP going to sleep<br>
2011-06-10 11:10:30.711798 [DEBUG] switch_core_state_machine.c:351<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) State Change CS_HANGUP -&gt;<br>
CS_REPORTING<br>
2011-06-10 11:10:30.711798 [DEBUG] switch_core_session.c:1116 Send signal<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a> [BREAK]<br>
2011-06-10 11:10:30.711798 [DEBUG] switch_core_state_machine.c:320<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) Running State Change<br>
CS_REPORTING<br>
2011-06-10 11:10:30.711798 [DEBUG] switch_core_state_machine.c:617<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) State REPORTING<br>
2011-06-10 11:10:30.711798 [DEBUG] switch_core_state_machine.c:53<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a> Standard REPORTING, cause:<br>
DESTINATION_OUT_OF_ORDER<br>
2011-06-10 11:10:30.711798 [DEBUG] switch_core_state_machine.c:617<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) State REPORTING going to<br>
sleep<br>
2011-06-10 11:10:30.711798 [DEBUG] switch_channel.c:2551 Send signal<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> [KILL]<br>
2011-06-10 11:10:30.711798 [DEBUG] switch_core_session.c:1116 Send signal<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> [BREAK]<br>
2011-06-10 11:10:30.711798 [DEBUG] switch_core_state_machine.c:372<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) State SOFT_EXECUTE going to<br>
sleep<br>
2011-06-10 11:10:30.711798 [DEBUG] switch_core_state_machine.c:320<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) Running State Change<br>
CS_HANGUP<br>
2011-06-10 11:10:30.711798 [DEBUG] switch_core_state_machine.c:345<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) State Change CS_REPORTING -&gt;<br>
CS_DESTROY<br>
2011-06-10 11:10:30.711798 [DEBUG] switch_core_session.c:1116 Send signal<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a> [BREAK]<br>
2011-06-10 11:10:30.711798 [DEBUG] switch_core_session.c:1288 Session 40<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) Locked, Waiting on external<br>
entities<br>
2011-06-10 11:10:30.711798 [NOTICE] switch_core_session.c:1306 Session 40<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) Ended<br>
2011-06-10 11:10:30.711798 [NOTICE] switch_core_session.c:1308 Close Channel<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a> [CS_DESTROY]<br>
2011-06-10 11:10:30.711798 [DEBUG] switch_core_state_machine.c:449<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) Callstate Change HANGUP -&gt;<br>
DOWN<br>
2011-06-10 11:10:30.711798 [DEBUG] switch_core_state_machine.c:452<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) Running State Change<br>
CS_DESTROY<br>
2011-06-10 11:10:30.711798 [DEBUG] switch_core_state_machine.c:462<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) State DESTROY<br>
2011-06-10 11:10:30.711798 [DEBUG] mod_sofia.c:362<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a> SOFIA DESTROY<br>
2011-06-10 11:10:30.711798 [INFO] mod_com_g729.c:78 ENCODER DESTROYX -<br>
0x2aaaac013028 (nil)<br>
2011-06-10 11:10:30.711798 [INFO] mod_com_g729.c:79 DECODER DESTROYX -<br>
0x2aaaac013028 (nil)<br>
2011-06-10 11:10:30.711798 [INFO] mod_com_g729.c:78 ENCODER DESTROYX -<br>
0x2aaaac013088 (nil)<br>
2011-06-10 11:10:30.711798 [INFO] mod_com_g729.c:79 DECODER DESTROYX -<br>
0x2aaaac013088 (nil)<br>
2011-06-10 11:10:30.711798 [DEBUG] switch_core_state_machine.c:60<br>
sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a> Standard DESTROY<br>
2011-06-10 11:10:30.711798 [DEBUG] switch_core_state_machine.c:462<br>
(sofia/external/<a href="mailto:03996563750914@203.208.207.212" target="_blank">03996563750914@203.208.207.212</a>) State DESTROY going to sleep<br>
2011-06-10 11:10:30.711798 [DEBUG] switch_core_state_machine.c:557<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) State HANGUP<br>
2011-06-10 11:10:30.711798 [DEBUG] mod_sofia.c:457 Channel<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> hanging up, cause:<br>
ORIGINATOR_CANCEL<br>
2011-06-10 11:10:30.711798 [DEBUG] mod_sofia.c:500 Sending BYE to<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a><br>
2011-06-10 11:10:30.711798 [DEBUG] switch_core_state_machine.c:46<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> Standard HANGUP, cause:<br>
ORIGINATOR_CANCEL<br>
2011-06-10 11:10:30.711798 [DEBUG] switch_core_state_machine.c:557<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) State HANGUP going to sleep<br>
2011-06-10 11:10:30.711798 [DEBUG] switch_core_state_machine.c:351<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) State Change CS_HANGUP -&gt;<br>
CS_REPORTING<br>
2011-06-10 11:10:30.711798 [DEBUG] switch_core_session.c:1116 Send signal<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> [BREAK]<br>
2011-06-10 11:10:30.711798 [DEBUG] switch_core_state_machine.c:320<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) Running State Change<br>
CS_REPORTING<br>
2011-06-10 11:10:30.711798 [DEBUG] switch_core_state_machine.c:617<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) State REPORTING<br>
2011-06-10 11:10:30.714001 [DEBUG] switch_core_state_machine.c:53<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> Standard REPORTING, cause:<br>
ORIGINATOR_CANCEL<br>
2011-06-10 11:10:30.714001 [DEBUG] switch_core_state_machine.c:617<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) State REPORTING going to<br>
sleep<br>
2011-06-10 11:10:30.714001 [DEBUG] switch_core_state_machine.c:345<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) State Change CS_REPORTING -&gt;<br>
CS_DESTROY<br>
2011-06-10 11:10:30.714001 [DEBUG] switch_core_session.c:1116 Send signal<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> [BREAK]<br>
2011-06-10 11:10:30.714001 [DEBUG] switch_core_session.c:1288 Session 39<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) Locked, Waiting on external<br>
entities<br>
2011-06-10 11:10:30.714001 [NOTICE] switch_core_session.c:1306 Session 39<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) Ended<br>
2011-06-10 11:10:30.714001 [NOTICE] switch_core_session.c:1308 Close Channel<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> [CS_DESTROY]<br>
2011-06-10 11:10:30.714001 [DEBUG] switch_core_state_machine.c:449<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) Callstate Change HANGUP -&gt;<br>
DOWN<br>
2011-06-10 11:10:30.714001 [DEBUG] switch_core_state_machine.c:452<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) Running State Change<br>
CS_DESTROY<br>
2011-06-10 11:10:30.714001 [DEBUG] switch_core_state_machine.c:462<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) State DESTROY<br>
2011-06-10 11:10:30.714001 [DEBUG] mod_sofia.c:362<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> SOFIA DESTROY<br>
2011-06-10 11:10:30.714001 [INFO] mod_com_g729.c:78 ENCODER DESTROYX -<br>
0x2aaab0031060 (nil)<br>
2011-06-10 11:10:30.714001 [INFO] mod_com_g729.c:79 DECODER DESTROYX -<br>
0x2aaab0031060 (nil)<br>
2011-06-10 11:10:30.714001 [INFO] mod_com_g729.c:78 ENCODER DESTROYX -<br>
0x2aaab00310c0 0x2aaab00b20c0<br>
2011-06-10 11:10:30.714001 [INFO] mod_com_g729.c:79 DECODER DESTROYX -<br>
0x2aaab00310c0 (nil)<br>
send 662 bytes to udp/[203.208.207.212]:5060 at 03:10:30.820530:<br>
   ------------------------------------------------------------------------<br>
   BYE sip:<a href="http://203.208.207.212:5060" target="_blank">203.208.207.212:5060</a> SIP/2.0<br>
   Via: SIP/2.0/UDP 202.73.56.46:5080;rport;branch=z9hG4bK0D3Hm08XNH1Xg<br>
   Max-Forwards: 70<br>
   From: &quot;&quot; &amp;<a href="mailto:lt%3Bsip%3A03996563750914@202.73.56.46" target="_blank">lt;sip:03996563750914@202.73.56.46</a>&amp;gt;;tag=H4ZN43UH9S9Qc<br>
   To:<br>
&amp;<a href="mailto:lt%3Bsip%3A03996590031055@203.208.207.212" target="_blank">lt;sip:03996590031055@203.208.207.212</a>&amp;gt;;tag=2QGB951HCR30000E1D0001Ll0008FJ21EI9PBW<br>
   Call-ID: f529ae7e-0db1-122f-c4ab-0015c5fc7ad9<br>
   CSeq: 13501634 BYE<br>
   Contact: &amp;lt;sip:mod_sofia@202.73.56.46:5080&amp;gt;<br>
   User-Agent: FreeSWITCH-mod_sofia/1.0.7-hacked-20110603T012235Z<br>
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO,<br>
REGISTER, REFER, NOTIFY<br>
   Supported: timer, precondition, path, replaces<br>
   Reason: FreeSWITCH;cause=487;text=&quot;ORIGINATOR_CANCEL&quot;<br>
   Content-Length: 0<br>
<br>
   ------------------------------------------------------------------------<br>
2011-06-10 11:10:30.715878 [INFO] mod_com_g729.c:83 ENCODER DESTROY -<br>
0x2aaab00310c0 0x2aaab00b20c0<br>
2011-06-10 11:10:30.715878 [DEBUG] switch_core_state_machine.c:60<br>
sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a> Standard DESTROY<br>
2011-06-10 11:10:30.715878 [DEBUG] switch_core_state_machine.c:462<br>
(sofia/external/<a href="mailto:03996590031055@203.208.207.212" target="_blank">03996590031055@203.208.207.212</a>) State DESTROY going to sleep<br>
recv 383 bytes from udp/[203.208.207.212]:5060 at 03:10:30.823302:<br>
   ------------------------------------------------------------------------<br>
   SIP/2.0 200 Ok<br>
   Via: SIP/2.0/UDP<br>
10.1.1.46:5080;rport=5080;branch=z9hG4bKZ49rj5Qtr8aBN;received=10.1.1.46<br>
   From: &quot;&quot; &amp;<a href="mailto:lt%3Bsip%3A03996590031055@10.1.1.46" target="_blank">lt;sip:03996590031055@10.1.1.46</a>&amp;gt;;tag=jDSe6ycN62Zar<br>
   To:<br>
&amp;<a href="mailto:lt%3Bsip%3A03996563750914@203.208.207.212" target="_blank">lt;sip:03996563750914@203.208.207.212</a>&amp;gt;;tag=2QGB951HCR30000E1D00000u00000001QXU3LU<br>
   Call-ID: 082c8244-0db2-122f-c4ab-0015c5fc7ad9<br>
   CSeq: 13501649 CANCEL<br>
   Contact: &lt;sip:<a href="http://203.208.207.212:5060" target="_blank">203.208.207.212:5060</a>&gt;<br>
   Content-Length:     0<br>
<br>
   ------------------------------------------------------------------------<br>
recv 411 bytes from udp/[203.208.207.212]:5060 at 03:10:30.824765:<br>
   ------------------------------------------------------------------------<br>
   SIP/2.0 487 Request Terminated<br>
   Via: SIP/2.0/UDP<br>
10.1.1.46:5080;rport=5080;branch=z9hG4bKZ49rj5Qtr8aBN;received=10.1.1.46<br>
   From: &quot;&quot; &amp;<a href="mailto:lt%3Bsip%3A03996590031055@10.1.1.46" target="_blank">lt;sip:03996590031055@10.1.1.46</a>&amp;gt;;tag=jDSe6ycN62Zar<br>
   To:<br>
&amp;<a href="mailto:lt%3Bsip%3A03996563750914@203.208.207.212" target="_blank">lt;sip:03996563750914@203.208.207.212</a>&amp;gt;;tag=2QGB951HCR30000E1D0001Ll0008FJ410OWC5F<br>
   Call-ID: 082c8244-0db2-122f-c4ab-0015c5fc7ad9<br>
   CSeq: 13501649 INVITE<br>
   Reason: SIP;cause=487;text=&quot;Request Terminated&quot;<br>
   Content-Length:     0<br>
<br>
   ------------------------------------------------------------------------<br>
send 371 bytes to udp/[203.208.207.212]:5060 at 03:10:30.824891:<br>
   ------------------------------------------------------------------------<br>
   ACK <a href="mailto:sip%3A03996563750914@203.208.207.212" target="_blank">sip:03996563750914@203.208.207.212</a> SIP/2.0<br>
   Via: SIP/2.0/UDP 202.73.56.46:5080;rport;branch=z9hG4bKZ49rj5Qtr8aBN<br>
   Max-Forwards: 70<br>
   From: &quot;&quot; &amp;<a href="mailto:lt%3Bsip%3A03996590031055@202.73.56.46" target="_blank">lt;sip:03996590031055@202.73.56.46</a>&amp;gt;;tag=jDSe6ycN62Zar<br>
   To:<br>
&amp;<a href="mailto:lt%3Bsip%3A03996563750914@203.208.207.212" target="_blank">lt;sip:03996563750914@203.208.207.212</a>&amp;gt;;tag=2QGB951HCR30000E1D0001Ll0008FJ410OWC5F<br>
   Call-ID: 082c8244-0db2-122f-c4ab-0015c5fc7ad9<br>
   CSeq: 13501649 ACK<br>
   Content-Length: 0<br>
<br>
   ------------------------------------------------------------------------<br>
recv 380 bytes from udp/[203.208.207.212]:5060 at 03:10:30.826375:<br>
   ------------------------------------------------------------------------<br>
   SIP/2.0 200 Ok<br>
   Via: SIP/2.0/UDP<br>
10.1.1.46:5080;rport=5080;branch=z9hG4bK0D3Hm08XNH1Xg;received=10.1.1.46<br>
   From: &quot;&quot; &amp;<a href="mailto:lt%3Bsip%3A03996563750914@10.1.1.46" target="_blank">lt;sip:03996563750914@10.1.1.46</a>&amp;gt;;tag=H4ZN43UH9S9Qc<br>
   To:<br>
&amp;<a href="mailto:lt%3Bsip%3A03996590031055@203.208.207.212" target="_blank">lt;sip:03996590031055@203.208.207.212</a>&amp;gt;;tag=2QGB951HCR30000E1D0001Ll0008FJ21EI9PBW<br>
   Call-ID: f529ae7e-0db1-122f-c4ab-0015c5fc7ad9<br>
   CSeq: 13501634 BYE<br>
<br>
<br>
<br>
--<br>
View this message in context: <a href="http://freeswitch-users.2379917.n2.nabble.com/Leg-A-is-automatically-disconnected-on-Leg-B-orginate-failure-tp6482192p6482192.html" target="_blank">http://freeswitch-users.2379917.n2.nabble.com/Leg-A-is-automatically-disconnected-on-Leg-B-orginate-failure-tp6482192p6482192.html</a><br>




Sent from the freeswitch-users mailing list archive at Nabble.com.<br>
<br>
_______________________________________________<br>
FreeSWITCH-users mailing list<br>
<a href="mailto:FreeSWITCH-users@lists.freeswitch.org" target="_blank">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></div></div></div>
<br></div></div>_______________________________________________<br>
Join us at ClueCon 2011, Aug 9-11, Chicago<br>
<a href="http://www.cluecon.com" target="_blank">http://www.cluecon.com</a> 877-7-4ACLUE<div><br>
<br>
FreeSWITCH-users mailing list<br>
<a href="mailto:FreeSWITCH-users@lists.freeswitch.org" target="_blank">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>
<br></div></blockquote></div><br>
</blockquote></div><br>
<br>_______________________________________________<br>
Join us at ClueCon 2011, Aug 9-11, Chicago<br>
<a href="http://www.cluecon.com" target="_blank">http://www.cluecon.com</a> 877-7-4ACLUE<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>
<br></blockquote></div><br><div style="visibility: hidden; left: -5000px; position: absolute; z-index: 9999; padding: 0px; margin-left: 0px; margin-top: 0px; overflow: hidden; word-wrap: break-word; color: black; font-size: 10px; text-align: left; line-height: 130%;" id="avg_ls_inline_popup">
</div>