This makes my eyes bleed. Can you please put this on <a href="http://pastebin.freeswitch.org">pastebin.freeswitch.org</a>? Use &quot;FreeSWITCH Log&quot; as the syntax highlight.<br>-MC<br><br><div class="gmail_quote">On Sun, Jun 26, 2011 at 11:27 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>Thanks very much for the response. There is no dialplan specified for this call. In the FS setting, G729 is used as preferred stack for originating calls. The leg-A and B are bridged immediately after receiving PROGRESS-MEDIA from leg-B. <br>

<br>Calls are originated with following parameters:<br><b><br>-- Leg-A --<br>            &quot;api originate {origination_caller_id_number=&lt;caller&gt;,sip_cid_type=pid,privacy=yes,continue_on_fail=true} &lt;called&gt; &amp;park()&quot;<br>

<br></b><b>-- Leg-B --</b><br><b>            &quot;api originate {origination_caller_id_number=&lt;caller&gt;,originate_timeout=60,sip_cid_type=pid,privacy=yes,continue_on_fail=false} &lt;called&gt; &amp;park()&quot;<br>
</b><br>
<br>The entire debug log for this call follows.<br><br>Thanks,<br>D.Ma<br><br>=================================<br>2011-06-24 13:29:35.887830 [DEBUG] switch_ivr_originate.c:1971 variable string 0 = [origination_caller_id_number=03996563750911]<br>

2011-06-24 13:29:35.887830 [DEBUG] switch_ivr_originate.c:1971 variable string 1 = [originate_timeout=60]<br>2011-06-24 13:29:35.887830 [DEBUG] switch_ivr_originate.c:1971 variable string 2 = [ccd_session_id=20110624132936888918]<br>

2011-06-24 13:29:35.887830 [DEBUG] switch_ivr_originate.c:1971 variable string 3 = [sip_cid_type=pid]<br>2011-06-24 13:29:35.887830 [DEBUG] switch_ivr_originate.c:1971 variable string 4 = [privacy=yes]<br>2011-06-24 13:29:35.887830 [DEBUG] switch_ivr_originate.c:1971 variable string 5 = [continue_on_fail=true]<br>

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]<br>
2011-06-24 13:29:35.887830 [DEBUG] mod_sofia.c:4129 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) State Change CS_NEW -&gt; CS_INIT<br>
2011-06-24 13:29:35.887830 [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>2011-06-24 13:29:35.889072 [DEBUG] switch_core_state_machine.c:320 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) Running State Change CS_INIT<br>

2011-06-24 13:29:35.889829 [DEBUG] switch_core_state_machine.c:356 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) State INIT<br>2011-06-24 13:29:35.889829 [DEBUG] mod_sofia.c:84 sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a> SOFIA INIT<br>

send 999 bytes to udp/[203.208.207.212]:5060 at 05:29:36.398490:<br>   ------------------------------------------------------------------------<br>   INVITE <a href="mailto:sip%3A03996597632298@203.208.207.212" target="_blank">sip:03996597632298@203.208.207.212</a> SIP/2.0<br>

   Via: SIP/2.0/UDP 202.73.56.46:5080;rport;branch=z9hG4bKtpaQ28SQXKvem<br>   Max-Forwards: 70<br>   From: &quot;&quot; &lt;<a href="mailto:sip%3A03996563750911@202.73.56.46" target="_blank">sip:03996563750911@202.73.56.46</a>&gt;;tag=5SNjUy956H2mm<br>

   To: &lt;<a href="mailto:sip%3A03996597632298@203.208.207.212" target="_blank">sip:03996597632298@203.208.207.212</a>&gt;<br>   Call-ID: ca5d29b7-18c5-122f-3387-0015c5fc7ad9<br>   CSeq: 14110624 INVITE<br>   Contact: &lt;<a href="http://sip:mod_sofia@202.73.56.46:5080" target="_blank">sip:mod_sofia@202.73.56.46:5080</a>&gt;<br>

   User-Agent: FreeSWITCH-mod_sofia/1.0.7-hacked-20110603T012235Z<br>   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, PRACK, NOTIFY<br>   Supported: 100rel, 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; &lt;<a href="mailto:sip%3A03996563750911@202.73.56.46" target="_blank">sip:03996563750911@202.73.56.46</a>&gt;<br>

 <br>   v=0<br>   o=FreeSWITCH 1308862405 1308862406 IN IP4 202.73.56.46<br>   s=FreeSWITCH<br>   c=IN IP4 202.73.56.46<br>   t=0 0<br>   m=audio 30970 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-24 13:29:35.891343 [DEBUG] mod_sofia.c:124 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) State Change CS_INIT -&gt; CS_ROUTING<br>

2011-06-24 13:29:35.891343 [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>2011-06-24 13:29:35.891343 [DEBUG] sofia.c:4646 Channel sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a> entering state [calling][0]<br>

2011-06-24 13:29:35.891343 [DEBUG] switch_core_state_machine.c:356 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) State INIT going to sleep<br>2011-06-24 13:29:35.891343 [DEBUG] switch_core_state_machine.c:320 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) Running State Change CS_ROUTING<br>

2011-06-24 13:29:35.891343 [DEBUG] switch_channel.c:1657 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) Callstate Change DOWN -&gt; RINGING<br>2011-06-24 13:29:35.891343 [DEBUG] switch_core_state_machine.c:359 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) State ROUTING<br>

2011-06-24 13:29:35.891343 [DEBUG] mod_sofia.c:147 sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a> SOFIA ROUTING<br>2011-06-24 13:29:35.891343 [DEBUG] switch_ivr_originate.c:66 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) State Change CS_ROUTING -&gt; CS_CONSUME_MEDIA<br>

2011-06-24 13:29:35.891343 [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>2011-06-24 13:29:35.891343 [DEBUG] switch_core_state_machine.c:359 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) State ROUTING going to sleep<br>

2011-06-24 13:29:35.891343 [DEBUG] switch_core_state_machine.c:320 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) Running State Change CS_CONSUME_MEDIA<br>
2011-06-24 13:29:35.891343 [DEBUG] switch_core_state_machine.c:378 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) State CONSUME_MEDIA<br>
2011-06-24 13:29:35.891343 [DEBUG] switch_core_state_machine.c:378 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) State CONSUME_MEDIA going to sleep<br>
recv 307 bytes from udp/[203.208.207.212]:5060 at 05:29:36.404598:<br>
   ------------------------------------------------------------------------<br>   SIP/2.0 100 Trying<br>   Via: SIP/2.0/UDP 10.1.1.46:5080;rport=5080;branch=z9hG4bKtpaQ28SQXKvem;received=10.1.1.46<br>   From: &quot;&quot; &lt;<a href="mailto:sip%3A03996563750911@10.1.1.46" target="_blank">sip:03996563750911@10.1.1.46</a>&gt;;tag=5SNjUy956H2mm<br>

   To: &lt;<a href="mailto:sip%3A03996597632298@203.208.207.212" target="_blank">sip:03996597632298@203.208.207.212</a>&gt;<br>   Call-ID: ca5d29b7-18c5-122f-3387-0015c5fc7ad9<br>   CSeq: 14110624 INVITE<br>   Content-Length:     0<br>
 <br>
   ------------------------------------------------------------------------<br>recv 774 bytes from udp/[203.208.207.212]:5060 at 05:29:37.615248:<br>   ------------------------------------------------------------------------<br>

   SIP/2.0 183 Session Progress<br>   Via: SIP/2.0/UDP 10.1.1.46:5080;rport=5080;branch=z9hG4bKtpaQ28SQXKvem;received=10.1.1.46<br>   From: &quot;&quot; &lt;<a href="mailto:sip%3A03996563750911@10.1.1.46" target="_blank">sip:03996563750911@10.1.1.46</a>&gt;;tag=5SNjUy956H2mm<br>

   To: &lt;<a href="mailto:sip%3A03996597632298@203.208.207.212" target="_blank">sip:03996597632298@203.208.207.212</a>&gt;;tag=2QGB951HCR30000E1D0001Ll000B8RX0S6R1TX<br>   Call-ID: ca5d29b7-18c5-122f-3387-0015c5fc7ad9<br>
   CSeq: 14110624 INVITE<br>
   Contact: &lt;sip:<a href="http://203.208.207.212:5060" target="_blank">203.208.207.212:5060</a>&gt;<br>   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, INFO, REFER, NOTIFY, SUBSCRIBE, UPDATE<br>   Content-Type: application/sdp<br>
   Require: 100rel<br>
   RSeq: 1<br>   Content-Length:   231<br> <br>   v=0<br>   o=- 508539113671071081 1 IN IP4 203.208.207.212<br>   s=session<br>   c=IN IP4 203.208.207.201<br>   t=0 0<br>   m=audio 25120 RTP/AVP 18 101<br>   a=rtpmap:18 G729/8000<br>

   a=fmtp:18 annexb=no<br>   a=rtpmap:101 telephone-event/8000<br>   a=ptime:20<br>   a=sendrecv<br>   ------------------------------------------------------------------------<br>send 651 bytes to udp/[203.208.207.212]:5060 at 05:29:37.615605:<br>

   ------------------------------------------------------------------------<br>   PRACK 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=z9hG4bKUZ3F43aUtvj1F<br>

   Max-Forwards: 70<br>   From: &quot;&quot; &lt;<a href="mailto:sip%3A03996563750911@202.73.56.46" target="_blank">sip:03996563750911@202.73.56.46</a>&gt;;tag=5SNjUy956H2mm<br>   To: &lt;<a href="mailto:sip%3A03996597632298@203.208.207.212" target="_blank">sip:03996597632298@203.208.207.212</a>&gt;;tag=2QGB951HCR30000E1D0001Ll000B8RX0S6R1TX<br>

   Call-ID: ca5d29b7-18c5-122f-3387-0015c5fc7ad9<br>   CSeq: 14110625 PRACK<br>   Contact: &lt;<a href="http://sip:mod_sofia@202.73.56.46:5080" target="_blank">sip:mod_sofia@202.73.56.46:5080</a>&gt;<br>   RAck: 1 14110624 INVITE<br>
   User-Agent: FreeSWITCH-mod_sofia/1.0.7-hacked-20110603T012235Z<br>
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, PRACK, NOTIFY<br>   Supported: 100rel, timer, precondition, path, replaces<br>   Content-Length: 0<br> <br>   ------------------------------------------------------------------------<br>

2011-06-24 13:29:37.107576 [INFO] sofia.c:729 sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a> Update Callee ID to &quot;Outbound Call&quot; &lt;03996597632298&gt;<br>
2011-06-24 13:29:37.107576 [DEBUG] sofia.c:4646 Channel sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a> entering state [proceeding][183]<br>
2011-06-24 13:29:37.107576 [DEBUG] sofia.c:4657 Remote SDP:<br>v=0<br>o=- 508539113671071081 1 IN IP4 203.208.207.212<br>s=session<br>c=IN IP4 203.208.207.201<br>t=0 0<br>m=audio 25120 RTP/AVP 18 101<br>a=rtpmap:18 G729/8000<br>

a=fmtp:18 annexb=no<br>a=rtpmap:101 telephone-event/8000<br>a=ptime:20<br> <br>2011-06-24 13:29:37.107576 [DEBUG] sofia_glue.c:4467 Audio Codec Compare [G729:18:8000:20:8000]/[G729:18:8000:20:8000]<br>2011-06-24 13:29:37.107576 [DEBUG] sofia_glue.c:2757 Set Codec sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a> G729/8000 20 ms 160 samples 8000 bits<br>

2011-06-24 13:29:37.108995 [DEBUG] sofia_glue.c:4565 Set 2833 dtmf send payload to 101<br>2011-06-24 13:29:37.108995 [DEBUG] sofia_glue.c:2987 AUDIO RTP [sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>] 10.1.1.46 port 30970 -&gt; 203.208.207.201 port 25120 codec: 18 ms: 20<br>

2011-06-24 13:29:37.108995 [DEBUG] switch_rtp.c:1607 Starting timer [soft] 160 bytes per 20ms<br>2011-06-24 13:29:37.109893 [DEBUG] sofia_glue.c:3228 Set 2833 dtmf send payload to 101<br>2011-06-24 13:29:37.109893 [DEBUG] sofia_glue.c:3233 Set 2833 dtmf receive payload to 101<br>

2011-06-24 13:29:37.109893 [NOTICE] sofia_glue.c:3680 Pre-Answer sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>!<br>2011-06-24 13:29:37.109893 [DEBUG] switch_channel.c:2627 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) Callstate Change RINGING -&gt; EARLY<br>

2011-06-24 13:29:37.109893 [DEBUG] switch_ivr_originate.c:3408 Originate Resulted in Success: [sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>]<br>2011-06-24 13:29:37.109893 [DEBUG] mod_commands.c:3205 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) State Change CS_CONSUME_MEDIA -&gt; CS_EXECUTE<br>

2011-06-24 13:29:37.109893 [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>2011-06-24 13:29:37.111618 [DEBUG] switch_core_state_machine.c:320 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) Running State Change CS_EXECUTE<br>

2011-06-24 13:29:37.111618 [DEBUG] switch_core_state_machine.c:366 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) State EXECUTE<br>2011-06-24 13:29:37.111618 [DEBUG] mod_sofia.c:240 sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a> SOFIA EXECUTE<br>

2011-06-24 13:29:37.111618 [DEBUG] switch_core_state_machine.c:157 sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a> Standard EXECUTE<br>EXECUTE sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a> park()<br>

recv 382 bytes from udp/[203.208.207.212]:5060 at 05:29:37.620736:<br>   ------------------------------------------------------------------------<br>   SIP/2.0 200 Ok<br>   Via: SIP/2.0/UDP 10.1.1.46:5080;rport=5080;branch=z9hG4bKUZ3F43aUtvj1F;received=10.1.1.46<br>

   From: &quot;&quot; &lt;<a href="mailto:sip%3A03996563750911@10.1.1.46" target="_blank">sip:03996563750911@10.1.1.46</a>&gt;;tag=5SNjUy956H2mm<br>   To: &lt;<a href="mailto:sip%3A03996597632298@203.208.207.212" target="_blank">sip:03996597632298@203.208.207.212</a>&gt;;tag=2QGB951HCR30000E1D0001Ll000B8RX0S6R1TX<br>

   Call-ID: ca5d29b7-18c5-122f-3387-0015c5fc7ad9<br>   CSeq: 14110625 PRACK<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>

2011-06-24 13:29:37.160714 [DEBUG] switch_rtp.c:2933 Correct ip/port confirmed.<br>recv 512 bytes from udp/[203.208.207.212]:5060 at 05:29:45.146388:<br>   ------------------------------------------------------------------------<br>

   SIP/2.0 183 Session Progress<br>   Via: SIP/2.0/UDP 10.1.1.46:5080;rport=5080;branch=z9hG4bKtpaQ28SQXKvem;received=10.1.1.46<br>   From: &quot;&quot; &lt;<a href="mailto:sip%3A03996563750911@10.1.1.46" target="_blank">sip:03996563750911@10.1.1.46</a>&gt;;tag=5SNjUy956H2mm<br>

   To: &lt;<a href="mailto:sip%3A03996597632298@203.208.207.212" target="_blank">sip:03996597632298@203.208.207.212</a>&gt;;tag=2QGB951HCR30000E1D0001Ll000B8RX0S6R1TX<br>   Call-ID: ca5d29b7-18c5-122f-3387-0015c5fc7ad9<br>
   CSeq: 14110624 INVITE<br>
   Contact: &lt;sip:<a href="http://203.208.207.212:5060" target="_blank">203.208.207.212:5060</a>&gt;<br>   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, INFO, REFER, NOTIFY, SUBSCRIBE, UPDATE<br>   Require: 100rel<br>
   RSeq: 2<br>   Content-Length:     0<br>
 <br>   ------------------------------------------------------------------------<br>send 651 bytes to udp/[203.208.207.212]:5060 at 05:29:45.146628:<br>   ------------------------------------------------------------------------<br>

   PRACK 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=z9hG4bKv8v85yUyQ58KB<br>  Max-Forwards: 70<br>   From: &quot;&quot; &lt;<a href="mailto:sip%3A03996563750911@202.73.56.46" target="_blank">sip:03996563750911@202.73.56.46</a>&gt;;tag=5SNjUy956H2mm<br>

   To: &lt;<a href="mailto:sip%3A03996597632298@203.208.207.212" target="_blank">sip:03996597632298@203.208.207.212</a>&gt;;tag=2QGB951HCR30000E1D0001Ll000B8RX0S6R1TX<br>   Call-ID: ca5d29b7-18c5-122f-3387-0015c5fc7ad9<br>
   CSeq: 14110626 PRACK<br>
   Contact: &lt;<a href="http://sip:mod_sofia@202.73.56.46:5080" target="_blank">sip:mod_sofia@202.73.56.46:5080</a>&gt;<br>   RAck: 2 14110624 INVITE<br>   User-Agent: FreeSWITCH-mod_sofia/1.0.7-hacked-20110603T012235Z<br>
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, PRACK, NOTIFY<br>
   Supported: 100rel, timer, precondition, path, replaces<br>   Content-Length: 0<br> <br>   ------------------------------------------------------------------------<br>2011-06-24 13:29:44.639310 [INFO] sofia.c:729 sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a> Update Callee ID to &quot;03996597632298&quot; &lt;03996597632298&gt;<br>

2011-06-24 13:29:44.639310 [DEBUG] sofia.c:4641 Channel sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a> skipping state [proceeding][183]<br>recv 382 bytes from udp/[203.208.207.212]:5060 at 05:29:45.151718:<br>

   ------------------------------------------------------------------------<br>   SIP/2.0 200 Ok<br>   Via: SIP/2.0/UDP 10.1.1.46:5080;rport=5080;branch=z9hG4bKv8v85yUyQ58KB;received=10.1.1.46<br>   From: &quot;&quot; &lt;<a href="mailto:sip%3A03996563750911@10.1.1.46" target="_blank">sip:03996563750911@10.1.1.46</a>&gt;;tag=5SNjUy956H2mm<br>

   To: &lt;<a href="mailto:sip%3A03996597632298@203.208.207.212" target="_blank">sip:03996597632298@203.208.207.212</a>&gt;;tag=2QGB951HCR30000E1D0001Ll000B8RX0S6R1TX<br>   Call-ID: ca5d29b7-18c5-122f-3387-0015c5fc7ad9<br>
   CSeq: 14110626 PRACK<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 529 bytes from udp/[203.208.207.212]:5060 at 05:29:47.446072:<br>

   ------------------------------------------------------------------------<br>   SIP/2.0 200 Ok<br>   Via: SIP/2.0/UDP 10.1.1.46:5080;rport=5080;branch=z9hG4bKtpaQ28SQXKvem;received=10.1.1.46<br>   From: &quot;&quot; &lt;<a href="mailto:sip%3A03996563750911@10.1.1.46" target="_blank">sip:03996563750911@10.1.1.46</a>&gt;;tag=5SNjUy956H2mm<br>

   To: &lt;<a href="mailto:sip%3A03996597632298@203.208.207.212" target="_blank">sip:03996597632298@203.208.207.212</a>&gt;;tag=2QGB951HCR30000E1D0001Ll000B8RX0S6R1TX<br>   Call-ID: ca5d29b7-18c5-122f-3387-0015c5fc7ad9<br>
   CSeq: 14110624 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, SUBSCRIBE, UPDATE<br>
   Supported: 100rel, timer, replaces<br>
   Content-Length:     0<br> <br>   ------------------------------------------------------------------------<br>2011-06-24 13:29:46.938477 [DEBUG] sofia.c:4646 Channel sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a> entering state [completing][200]<br>

send 405 bytes to udp/[203.208.207.212]:5060 at 05:29:47.446869:<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=z9hG4bKXHp17Sc2meZ6p<br>   Max-Forwards: 70<br>   From: &quot;&quot; &lt;<a href="mailto:sip%3A03996563750911@202.73.56.46" target="_blank">sip:03996563750911@202.73.56.46</a>&gt;;tag=5SNjUy956H2mm<br>

   To: &lt;<a href="mailto:sip%3A03996597632298@203.208.207.212" target="_blank">sip:03996597632298@203.208.207.212</a>&gt;;tag=2QGB951HCR30000E1D0001Ll000B8RX0S6R1TX<br>   Call-ID: ca5d29b7-18c5-122f-3387-0015c5fc7ad9<br>
   CSeq: 14110624 ACK<br>
   Contact: &lt;<a href="http://sip:mod_sofia@202.73.56.46:5080" target="_blank">sip:mod_sofia@202.73.56.46:5080</a>&gt;<br>   Content-Length: 0<br> <br>   ------------------------------------------------------------------------<br>
2011-06-24 13:29:46.939738 [DEBUG] sofia.c:4646 Channel sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a> entering state [ready][200]<br>
2011-06-24 13:29:46.939738 [DEBUG] switch_channel.c:2782 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) Callstate Change EARLY -&gt; ACTIVE<br>2011-06-24 13:29:46.939738 [NOTICE] sofia.c:5175 Channel [sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>] has been answered<br>

2011-06-24 13:29:46.942763 [DEBUG] switch_scheduler.c:214 Added task 27 switch_ivr_schedule_hangup (c0bd700d-913c-42ad-b68f-81001bf658b8) to run at 1308896986<br>2011-06-24 13:29:46.944563 [DEBUG] switch_core_session.c:954 Send signal sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a> [BREAK]<br>

2011-06-24 13:29:46.945633 [DEBUG] switch_ivr_originate.c:1971 variable string 0 = [origination_caller_id_number=03996597632298]<br>2011-06-24 13:29:46.945633 [DEBUG] switch_ivr_originate.c:1971 variable string 1 = [ccd_session_id=20110624132936888918]<br>

2011-06-24 13:29:46.945633 [DEBUG] switch_ivr_originate.c:1971 variable string 2 = [sip_cid_type=pid]<br>2011-06-24 13:29:46.945633 [DEBUG] switch_ivr_originate.c:1971 variable string 3 = [privacy=yes]<br>2011-06-24 13:29:46.945633 [DEBUG] switch_ivr_originate.c:1971 variable string 4 = [continue_on_fail=false]<br>

2011-06-24 13:29:46.945633 [NOTICE] switch_channel.c:808 New Channel sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a> [817124e6-26fe-46cc-af55-89715abdfced]<br>
2011-06-24 13:29:46.945633 [DEBUG] mod_sofia.c:4129 (sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a>) State Change CS_NEW -&gt; CS_INIT<br>
2011-06-24 13:29:46.945633 [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:46.945633 [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_INIT<br>

2011-06-24 13:29:46.945633 [DEBUG] switch_core_state_machine.c:356 (sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a>) State INIT<br>2011-06-24 13:29:46.945633 [DEBUG] mod_sofia.c:84 sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a> SOFIA INIT<br>

2011-06-24 13:29:46.945633 [DEBUG] mod_sofia.c:124 (sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a>) State Change CS_INIT -&gt; CS_ROUTING<br>2011-06-24 13:29:46.945633 [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:46.945633 [DEBUG] switch_core_state_machine.c:356 (sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a>) State INIT going to sleep<br>2011-06-24 13:29:46.945633 [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_ROUTING<br>

2011-06-24 13:29:46.945633 [DEBUG] switch_channel.c:1657 (sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a>) Callstate Change DOWN -&gt; RINGING<br>2011-06-24 13:29:46.945633 [DEBUG] switch_core_state_machine.c:359 (sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a>) State ROUTING<br>

2011-06-24 13:29:46.945633 [DEBUG] mod_sofia.c:147 sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a> SOFIA ROUTING<br>2011-06-24 13:29:46.945633 [DEBUG] switch_ivr_originate.c:66 (sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a>) State Change CS_ROUTING -&gt; CS_CONSUME_MEDIA<br>

2011-06-24 13:29:46.945633 [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:46.945633 [DEBUG] switch_core_state_machine.c:359 (sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a>) State ROUTING going to sleep<br>

2011-06-24 13:29:46.945633 [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_CONSUME_MEDIA<br>
send 999 bytes to udp/[203.208.207.212]:5060 at 05:29:47.454251:<br>
   ------------------------------------------------------------------------<br>   INVITE <a href="mailto:sip%3A03996563750911@203.208.207.212" target="_blank">sip:03996563750911@203.208.207.212</a> SIP/2.0<br>   Via: SIP/2.0/UDP 202.73.56.46:5080;rport;branch=z9hG4bKytFt9mX5HQNSj<br>

   Max-Forwards: 70<br>   From: &quot;&quot; &lt;<a href="mailto:sip%3A03996597632298@202.73.56.46" target="_blank">sip:03996597632298@202.73.56.46</a>&gt;;tag=62eBXSt93tr7F<br>   To: &lt;<a href="mailto:sip%3A03996563750911@203.208.207.212" target="_blank">sip:03996563750911@203.208.207.212</a>&gt;<br>

   Call-ID: d0f42376-18c5-122f-3387-0015c5fc7ad92011-06-24 13:29:46.945633 [DEBUG] switch_core_state_machine.c:378 (sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a>) State CONSUME_MEDIA<br>

 <br>   CSeq: 14110629 INVITE<br>   Contact: &lt;<a href="http://sip:mod_sofia@202.73.56.46:5080" target="_blank">sip:mod_sofia@202.73.56.46:5080</a>&gt;<br>2011-06-24 13:29:46.945633 [DEBUG] switch_core_state_machine.c:378 (sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a>) State CONSUME_MEDIA going to sleep<br>

   User-Agent: FreeSWITCH-mod_sofia/1.0.7-hacked-20110603T012235Z<br>   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, PRACK, NOTIFY<br>   Supported: 100rel, 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; &lt;<a href="mailto:sip%3A03996597632298@202.73.56.46" target="_blank">sip:03996597632298@202.73.56.46</a>&gt;<br>

 <br>   v=0<br>   o=FreeSWITCH 1308872756 1308872757 IN IP4 202.73.56.46<br>   s=FreeSWITCH<br>   c=IN IP4 202.73.56.46<br>   t=0 0<br>   m=audio 20630 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-24 13:29:46.946974 [DEBUG] sofia.c:4646 Channel sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a> entering state [calling][0]<br>

recv 307 bytes from udp/[203.208.207.212]:5060 at 05:29:47.460017:<br>   ------------------------------------------------------------------------<br>   SIP/2.0 100 Trying<br>   Via: SIP/2.0/UDP 10.1.1.46:5080;rport=5080;branch=z9hG4bKytFt9mX5HQNSj;received=10.1.1.46<br>

   From: &quot;&quot; &lt;<a href="mailto:sip%3A03996597632298@10.1.1.46" target="_blank">sip:03996597632298@10.1.1.46</a>&gt;;tag=62eBXSt93tr7F<br>   To: &lt;<a href="mailto:sip%3A03996563750911@203.208.207.212" target="_blank">sip:03996563750911@203.208.207.212</a>&gt;<br>

   Call-ID: d0f42376-18c5-122f-3387-0015c5fc7ad9<br>   CSeq: 14110629 INVITE<br>   Content-Length:     0<br> <br>   ------------------------------------------------------------------------<br>2011-06-24 13:29:46.960900 [DEBUG] switch_ivr.c:563 sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a> Command Execute playback(/usr/local/freeswitch/sounds/clearhub/MusicForCalls_v1.wav)<br>

EXECUTE sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a> playback(/usr/local/freeswitch/sounds/clearhub/MusicForCalls_v1.wav)<br>2011-06-24 13:29:46.960900 [DEBUG] switch_core_file.c:176 File /usr/local/freeswitch/sounds/clearhub/MusicForCalls_v1.wav sample rate 11025 doesn&#39;t match requested rate 8000<br>

2011-06-24 13:29:46.960900 [WARNING] switch_core_file.c:189 File has 2 channels, muxing to mono will occur.<br>2011-06-24 13:29:46.960900 [DEBUG] switch_ivr_play_say.c:1244 Codec Activated L16@8000hz 2 channels 20ms<br>2011-06-24 13:29:46.981203 [INFO] mod_com_g729.c:119 ENCODER CREATE - 0x2aaab80894b8 0x5112110<br>

recv 774 bytes from udp/[203.208.207.212]:5060 at 05:29:48.623941:<br>   ------------------------------------------------------------------------<br>   SIP/2.0 183 Session Progress<br>   Via: SIP/2.0/UDP 10.1.1.46:5080;rport=5080;branch=z9hG4bKytFt9mX5HQNSj;received=10.1.1.46<br>

   From: &quot;&quot; &lt;<a href="mailto:sip%3A03996597632298@10.1.1.46" target="_blank">sip:03996597632298@10.1.1.46</a>&gt;;tag=62eBXSt93tr7F<br>   To: &lt;<a href="mailto:sip%3A03996563750911@203.208.207.212" target="_blank">sip:03996563750911@203.208.207.212</a>&gt;;tag=2QGB951HCR30000E1D0001Ll000B8RV0KORLQK<br>

   Call-ID: d0f42376-18c5-122f-3387-0015c5fc7ad9<br>   CSeq: 14110629 INVITE<br>   Contact: &lt;sip:<a href="http://203.208.207.212:5060" target="_blank">203.208.207.212:5060</a>&gt;<br>   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, INFO, REFER, NOTIFY, SUBSCRIBE, UPDATE<br>

   Content-Type: application/sdp<br>   Require: 100rel<br>   RSeq: 1<br>   Content-Length:   231<br> <br>   v=0<br>   o=- 508550174225779858 1 IN IP4 203.208.207.212<br>   s=session<br>   c=IN IP4 203.208.207.202<br>   t=0 0<br>

   m=audio 25150 RTP/AVP 18 101<br>   a=rtpmap:18 G729/8000<br>   a=fmtp:18 annexb=no<br>   a=rtpmap:101 telephone-event/8000<br>   a=ptime:20<br>   a=sendrecv<br>   ------------------------------------------------------------------------<br>

send 651 bytes to udp/[203.208.207.212]:5060 at 05:29:48.624297:<br>   ------------------------------------------------------------------------<br>   PRACK 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=z9hG4bKZ38jBge9e0Bce<br>   Max-Forwards: 70<br>   From: &quot;&quot; &lt;<a href="mailto:sip%3A03996597632298@202.73.56.46" target="_blank">sip:03996597632298@202.73.56.46</a>&gt;;tag=62eBXSt93tr7F<br>

   To: &lt;<a href="mailto:sip%3A03996563750911@203.208.207.212" target="_blank">sip:03996563750911@203.208.207.212</a>&gt;;tag=2QGB951HCR30000E1D0001Ll000B8RV0KORLQK<br>   Call-ID: d0f42376-18c5-122f-3387-0015c5fc7ad9<br>
   CSeq: 14110630 PRACK<br>
   Contact: &lt;<a href="http://sip:mod_sofia@202.73.56.46:5080" target="_blank">sip:mod_sofia@202.73.56.46:5080</a>&gt;<br>   RAck: 1 14110629 INVITE<br>   User-Agent: FreeSWITCH-mod_sofia/1.0.7-hacked-20110603T012235Z<br>
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, PRACK, NOTIFY<br>
   Supported: 100rel, timer, precondition, path, replaces<br>   Content-Length: 0<br> <br>   ------------------------------------------------------------------------<br>2011-06-24 13:29:48.115941 [INFO] sofia.c:729 sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a> Update Callee ID to &quot;Outbound Call&quot; &lt;03996563750911&gt;<br>

2011-06-24 13:29:48.115941 [DEBUG] sofia.c:4646 Channel sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a> entering state [proceeding][183]<br>2011-06-24 13:29:48.115941 [DEBUG] sofia.c:4657 Remote SDP:<br>

v=0<br>o=- 508550174225779858 1 IN IP4 203.208.207.212<br>s=session<br>c=IN IP4 203.208.207.202<br>t=0 0<br>m=audio 25150 RTP/AVP 18 101<br>a=rtpmap:18 G729/8000<br>a=fmtp:18 annexb=no<br>a=rtpmap:101 telephone-event/8000<br>

a=ptime:20<br> <br>2011-06-24 13:29:48.115941 [DEBUG] sofia_glue.c:4467 Audio Codec Compare [G729:18:8000:20:8000]/[G729:18:8000:20:8000]<br>2011-06-24 13:29:48.115941 [DEBUG] sofia_glue.c:2757 Set Codec sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a> G729/8000 20 ms 160 samples 8000 bits<br>

2011-06-24 13:29:48.115941 [DEBUG] sofia_glue.c:4565 Set 2833 dtmf send payload to 101<br>2011-06-24 13:29:48.115941 [DEBUG] sofia_glue.c:2987 AUDIO RTP [sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a>] 10.1.1.46 port 20630 -&gt; 203.208.207.202 port 25150 codec: 18 ms: 20<br>

2011-06-24 13:29:48.115941 [DEBUG] switch_rtp.c:1607 Starting timer [soft] 160 bytes per 20ms<br>2011-06-24 13:29:48.119065 [DEBUG] sofia_glue.c:3228 Set 2833 dtmf send payload to 101<br>2011-06-24 13:29:48.119065 [DEBUG] sofia_glue.c:3233 Set 2833 dtmf receive payload to 101<br>

2011-06-24 13:29:48.119065 [NOTICE] sofia_glue.c:3680 Pre-Answer 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.119065 [DEBUG] switch_channel.c:2627 (sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a>) Callstate Change RINGING -&gt; EARLY<br>

2011-06-24 13:29:48.120495 [DEBUG] switch_ivr_originate.c:3408 Originate Resulted in Success: [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.120495 [DEBUG] mod_commands.c:3205 (sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a>) State Change CS_CONSUME_MEDIA -&gt; CS_EXECUTE<br>

2011-06-24 13:29:48.120495 [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.120495 [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_EXECUTE<br>

2011-06-24 13:29:48.120495 [DEBUG] switch_core_state_machine.c:366 (sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a>) State EXECUTE<br>2011-06-24 13:29:48.120495 [DEBUG] mod_sofia.c:240 sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a> SOFIA EXECUTE<br>

2011-06-24 13:29:48.120495 [DEBUG] switch_core_state_machine.c:157 sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a> Standard EXECUTE<br>EXECUTE sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a> park()<br>

2011-06-24 13:29:48.122782 [DEBUG] switch_core_session.c:954 Send signal sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a> [BREAK]<br>recv 382 bytes from udp/[203.208.207.212]:5060 at 05:29:48.630447:<br>

   ------------------------------------------------------------------------<br>   SIP/2.0 200 Ok<br>   Via: SIP/2.0/UDP 10.1.1.46:5080;rport=5080;branch=z9hG4bKZ38jBge9e0Bce;received=10.1.1.46<br>   From: &quot;&quot; &lt;<a href="mailto:sip%3A03996597632298@10.1.1.46" target="_blank">sip:03996597632298@10.1.1.46</a>&gt;;tag=62eBXSt93tr7F<br>

   To: &lt;<a href="mailto:sip%3A03996563750911@203.208.207.212" target="_blank">sip:03996563750911@203.208.207.212</a>&gt;;tag=2QGB951HCR30000E1D0001Ll000B8RV0KORLQK<br>   Call-ID: d0f42376-18c5-122f-3387-0015c5fc7ad9<br>
   CSeq: 14110630 PRACK<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>2011-06-24 13:29:48.122782 [DEBUG] switch_ivr.c:563 sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a> Command Execute playback(tone_stream://%(2000,4000,440,480);loops=10)<br>

EXECUTE sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a> playback(tone_stream://%(2000,4000,440,480);loops=10)<br>2011-06-24 13:29:48.124434 [DEBUG] switch_ivr_bridge.c:1480 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) State Change CS_EXECUTE -&gt; CS_HIBERNATE<br>

2011-06-24 13:29:48.124434 [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>2011-06-24 13:29:48.124434 [DEBUG] switch_ivr_bridge.c:1482 (sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a>) State Change CS_EXECUTE -&gt; CS_HIBERNATE<br>

2011-06-24 13:29:48.124434 [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.124434 [DEBUG] switch_core_session.c:771 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.124434 [DEBUG] switch_core_session.c:771 Send signal sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a> [BREAK]<br>2011-06-24 13:29:48.124434 [DEBUG] switch_ivr_play_say.c:1244 Codec Activated L16@8000hz 1 channels 20ms<br>

2011-06-24 13:29:48.124434 [DEBUG] switch_ivr_play_say.c:1581 done playing file<br>2011-06-24 13:29:48.124434 [DEBUG] switch_core_state_machine.c:366 (sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a>) State EXECUTE going to sleep<br>

2011-06-24 13:29:48.124434 [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_HIBERNATE<br>
2011-06-24 13:29:48.124434 [DEBUG] switch_core_state_machine.c:381 (sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a>) State HIBERNATE<br>
2011-06-24 13:29:48.124434 [DEBUG] mod_sofia.c:221 sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a> SOFIA HIBERNATE<br>2011-06-24 13:29:48.124434 [DEBUG] switch_ivr_bridge.c:731 (sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a>) State Change CS_HIBERNATE -&gt; CS_RESET<br>

2011-06-24 13:29:48.124434 [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.124434 [DEBUG] switch_core_state_machine.c:381 (sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a>) State HIBERNATE going to sleep<br>

2011-06-24 13:29:48.124434 [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_RESET<br>2011-06-24 13:29:48.124434 [DEBUG] switch_core_state_machine.c:362 (sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a>) State RESET<br>

2011-06-24 13:29:48.124434 [DEBUG] mod_sofia.c:165 sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a> SOFIA RESET<br>2011-06-24 13:29:48.124434 [DEBUG] switch_ivr_bridge.c:716 sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a> CUSTOM RESET<br>

2011-06-24 13:29:48.124434 [DEBUG] switch_core_state_machine.c:66 sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a> Standard RESET<br>2011-06-24 13:29:48.124434 [DEBUG] switch_core_state_machine.c:362 (sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a>) State RESET going to sleep<br>

2011-06-24 13:29:48.126015 [DEBUG] switch_core_session.c:709 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.142264 [DEBUG] switch_ivr_play_say.c:1581 done playing file<br>

2011-06-24 13:29:48.142264 [DEBUG] switch_core_state_machine.c:366 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) State EXECUTE going to sleep<br>2011-06-24 13:29:48.142264 [DEBUG] switch_core_state_machine.c:320 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) Running State Change CS_HIBERNATE<br>

2011-06-24 13:29:48.142264 [DEBUG] switch_core_state_machine.c:381 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) State HIBERNATE<br>2011-06-24 13:29:48.142264 [DEBUG] mod_sofia.c:221 sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a> SOFIA HIBERNATE<br>

2011-06-24 13:29:48.142264 [DEBUG] switch_ivr_bridge.c:731 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) State Change CS_HIBERNATE -&gt; CS_RESET<br>2011-06-24 13:29:48.142264 [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>

2011-06-24 13:29:48.142264 [DEBUG] switch_core_state_machine.c:381 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) State HIBERNATE going to sleep<br>2011-06-24 13:29:48.142264 [DEBUG] switch_core_state_machine.c:320 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) Running State Change CS_RESET<br>

2011-06-24 13:29:48.142264 [DEBUG] switch_core_state_machine.c:362 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) State RESET<br>2011-06-24 13:29:48.142264 [DEBUG] mod_sofia.c:165 sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a> SOFIA RESET<br>

2011-06-24 13:29:48.142264 [DEBUG] switch_ivr_bridge.c:716 sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a> CUSTOM RESET<br>2011-06-24 13:29:48.142264 [DEBUG] switch_ivr_bridge.c:723 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) State Change CS_RESET -&gt; CS_SOFT_EXECUTE<br>

2011-06-24 13:29:48.142264 [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>2011-06-24 13:29:48.142264 [DEBUG] switch_core_state_machine.c:362 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) State RESET going to sleep<br>

2011-06-24 13:29:48.142264 [DEBUG] switch_core_state_machine.c:320 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) Running State Change CS_SOFT_EXECUTE<br>
2011-06-24 13:29:48.142264 [DEBUG] switch_core_state_machine.c:372 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) State SOFT_EXECUTE<br>
2011-06-24 13:29:48.142264 [DEBUG] mod_sofia.c:558 SOFIA SOFT_EXECUTE<br>2011-06-24 13:29:48.142264 [DEBUG] switch_ivr_bridge.c:741 sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a> CUSTOM SOFT_EXECUTE<br>

2011-06-24 13:29:48.142264 [DEBUG] switch_ivr_bridge.c:761 (sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a>) State Change CS_RESET -&gt; CS_SOFT_EXECUTE<br>
2011-06-24 13:29:48.142264 [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.142264 [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_SOFT_EXECUTE<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<br>
2011-06-24 13:29:48.142264 [DEBUG] mod_sofia.c:558 SOFIA SOFT_EXECUTE<br>2011-06-24 13:29:48.142264 [DEBUG] switch_ivr_bridge.c:741 sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a> CUSTOM SOFT_EXECUTE<br>

2011-06-24 13:29:48.142264 [DEBUG] switch_core_state_machine.c:204 sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a> Standard SOFT_EXECUTE<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>

2011-06-24 13:29:48.161779 [DEBUG] switch_core_state_machine.c:372 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) State SOFT_EXECUTE going to sleep<br>
2011-06-24 13:29:48.161779 [DEBUG] switch_core_state_machine.c:320 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) Running State Change CS_HANGUP<br>
2011-06-24 13:29:48.161779 [DEBUG] switch_core_state_machine.c:46 sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a> Standard HANGUP, cause: DESTINATION_OUT_OF_ORDER<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 going to sleep<br>
2011-06-24 13:29:48.161779 [DEBUG] switch_core_state_machine.c:351 (sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a>) State Change CS_HANGUP -&gt; CS_REPORTING<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_REPORTING<br>
2011-06-24 13:29:48.161779 [DEBUG] switch_core_state_machine.c:617 (sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a>) State REPORTING<br>
2011-06-24 13:29:48.161779 [DEBUG] switch_core_state_machine.c:53 sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a> Standard REPORTING, cause: DESTINATION_OUT_OF_ORDER<br>
2011-06-24 13:29:48.161779 [DEBUG] switch_core_state_machine.c:617 (sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a>) State REPORTING going to sleep<br>
2011-06-24 13:29:48.161779 [DEBUG] switch_core_state_machine.c:557 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@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:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a> hanging up, cause: ORIGINATOR_CANCEL<br>

2011-06-24 13:29:48.161779 [DEBUG] mod_sofia.c:500 Sending BYE to sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a><br>2011-06-24 13:29:48.161779 [DEBUG] switch_core_state_machine.c:345 (sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a>) State Change CS_REPORTING -&gt; CS_DESTROY<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_session.c:1288 Session 52 (sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a>) Locked, Waiting on external entities<br>

2011-06-24 13:29:48.161779 [NOTICE] switch_core_session.c:1306 Session 52 (sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a>) Ended<br>2011-06-24 13:29:48.161779 [NOTICE] switch_core_session.c:1308 Close Channel sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a> [CS_DESTROY]<br>

2011-06-24 13:29:48.161779 [DEBUG] switch_core_state_machine.c:449 (sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a>) Callstate Change HANGUP -&gt; DOWN<br>
2011-06-24 13:29:48.161779 [DEBUG] switch_core_state_machine.c:452 (sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a>) Running State Change CS_DESTROY<br>
2011-06-24 13:29:48.161779 [DEBUG] switch_core_state_machine.c:462 (sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a>) State DESTROY<br>2011-06-24 13:29:48.161779 [DEBUG] mod_sofia.c:362 sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a> SOFIA DESTROY<br>

2011-06-24 13:29:48.161779 [INFO] mod_com_g729.c:78 ENCODER DESTROYX - 0x2aaaac03fff8 (nil)<br>2011-06-24 13:29:48.161779 [INFO] mod_com_g729.c:79 DECODER DESTROYX - 0x2aaaac03fff8 (nil)<br>2011-06-24 13:29:48.161779 [INFO] mod_com_g729.c:78 ENCODER DESTROYX - 0x2aaaac068fc8 (nil)<br>

2011-06-24 13:29:48.161779 [INFO] mod_com_g729.c:79 DECODER DESTROYX - 0x2aaaac068fc8 (nil)<br>2011-06-24 13:29:48.161779 [DEBUG] switch_core_state_machine.c:46 sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a> Standard HANGUP, cause: ORIGINATOR_CANCEL<br>

2011-06-24 13:29:48.161779 [DEBUG] switch_core_state_machine.c:60 sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a> Standard DESTROY<br>2011-06-24 13:29:48.161779 [DEBUG] switch_core_state_machine.c:557 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) State HANGUP going to sleep<br>

2011-06-24 13:29:48.161779 [DEBUG] switch_core_state_machine.c:462 (sofia/external/<a href="mailto:03996563750911@203.208.207.212" target="_blank">03996563750911@203.208.207.212</a>) State DESTROY going to sleep<br>2011-06-24 13:29:48.161779 [DEBUG] switch_core_state_machine.c:351 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) State Change CS_HANGUP -&gt; CS_REPORTING<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>2011-06-24 13:29:48.161779 [DEBUG] switch_core_state_machine.c:320 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) Running State Change CS_REPORTING<br>

2011-06-24 13:29:48.161779 [DEBUG] switch_core_state_machine.c:617 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) State REPORTING<br>2011-06-24 13:29:48.161779 [DEBUG] switch_core_state_machine.c:53 sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a> Standard REPORTING, cause: ORIGINATOR_CANCEL<br>

2011-06-24 13:29:48.161779 [DEBUG] switch_core_state_machine.c:617 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) State REPORTING going to sleep<br>send 390 bytes to udp/[203.208.207.212]:5060 at 05:29:48.671783:<br>

   ------------------------------------------------------------------------<br>   CANCEL <a href="mailto:sip%3A03996563750911@203.208.207.212" target="_blank">sip:03996563750911@203.208.207.212</a> SIP/2.0<br>   Via: SIP/2.0/UDP 202.73.56.46:5080;rport;branch=z9hG4bKytFt9mX5HQNSj<br>

   Max-Forwards: 70<br>   From: &quot;&quot; &lt;<a href="mailto:sip%3A03996597632298@202.73.56.46" target="_blank">sip:03996597632298@202.73.56.46</a>&gt;;tag=62eBXSt93tr7F<br>   To: &lt;<a href="mailto:sip%3A03996563750911@203.208.207.212" target="_blank">sip:03996563750911@203.208.207.212</a>&gt;<br>

   Call-ID: d0f42376-18c5-122f-3387-0015c5fc7ad9<br>   CSeq: 14110629 CANCEL<br>   Reason: Q.850;cause=27;text=&quot;DESTINATION_OUT_OF_ORDER&quot;<br>   Content-Length: 0<br> <br>   ------------------------------------------------------------------------<br>

2011-06-24 13:29:48.161779 [DEBUG] switch_core_state_machine.c:345 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) State Change CS_REPORTING -&gt; CS_DESTROY<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>
2011-06-24 13:29:48.161779 [DEBUG] switch_core_session.c:1288 Session 51 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) Locked, Waiting on external entities<br>
2011-06-24 13:29:48.161779 [NOTICE] switch_core_session.c:1306 Session 51 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) Ended<br>
2011-06-24 13:29:48.161779 [NOTICE] switch_core_session.c:1308 Close Channel sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a> [CS_DESTROY]<br>send 677 bytes to udp/[203.208.207.212]:5060 at 05:29:48.671936:<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=z9hG4bK0c2BDBZcc91yS<br>

   Max-Forwards: 70<br>   From: &quot;&quot; &lt;<a href="mailto:sip%3A03996563750911@202.73.56.46" target="_blank">sip:03996563750911@202.73.56.46</a>&gt;;tag=5SNjUy956H2mm<br>   To: &lt;<a href="mailto:sip%3A03996597632298@203.208.207.212" target="_blank">sip:03996597632298@203.208.207.212</a>&gt;;tag=2QGB951HCR30000E1D0001Ll000B8RX0S6R1TX<br>

   Call-ID: ca5d29b7-18c5-122f-3387-0015c5fc7ad9<br>   CSeq: 14110627 BYE<br>   Contact: &lt;<a href="http://sip:mod_sofia@202.73.56.46:5080" target="_blank">sip:mod_sofia@202.73.56.46:5080</a>&gt;<br>   User-Agent: FreeSWITCH-mod_sofia/1.0.7-hacked-20110603T012235Z<br>

   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, PRACK, NOTIFY<br>   Supported: 100rel, timer, precondition, path, replaces<br>   Reason: FreeSWITCH;cause=487;text=&quot;ORIGINATOR_CANCEL&quot;<br>

   Content-Length: 0<br> <br>   ------------------------------------------------------------------------<br>2011-06-24 13:29:48.161779 [DEBUG] switch_core_state_machine.c:449 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) Callstate Change HANGUP -&gt; DOWN<br>

2011-06-24 13:29:48.161779 [DEBUG] switch_core_state_machine.c:452 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) Running State Change CS_DESTROY<br>2011-06-24 13:29:48.161779 [DEBUG] switch_core_state_machine.c:462 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) State DESTROY<br>

2011-06-24 13:29:48.161779 [DEBUG] mod_sofia.c:362 sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a> SOFIA DESTROY<br>2011-06-24 13:29:48.161779 [INFO] mod_com_g729.c:78 ENCODER DESTROYX - 0x2aaab8030878 (nil)<br>

2011-06-24 13:29:48.161779 [INFO] mod_com_g729.c:79 DECODER DESTROYX - 0x2aaab8030878 (nil)<br>2011-06-24 13:29:48.161779 [INFO] mod_com_g729.c:78 ENCODER DESTROYX - 0x2aaab80894b8 0x5112110<br>2011-06-24 13:29:48.161779 [INFO] mod_com_g729.c:79 DECODER DESTROYX - 0x2aaab80894b8 (nil)<br>

2011-06-24 13:29:48.166430 [INFO] mod_com_g729.c:83 ENCODER DESTROY - 0x2aaab80894b8 0x5112110<br>2011-06-24 13:29:48.166430 [DEBUG] switch_core_state_machine.c:60 sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a> Standard DESTROY<br>

2011-06-24 13:29:48.166430 [DEBUG] switch_core_state_machine.c:462 (sofia/external/<a href="mailto:03996597632298@203.208.207.212" target="_blank">03996597632298@203.208.207.212</a>) State DESTROY going to sleep<br>recv 383 bytes from udp/[203.208.207.212]:5060 at 05:29:48.679561:<br>

   ------------------------------------------------------------------------<br>   SIP/2.0 200 Ok<br>   Via: SIP/2.0/UDP 10.1.1.46:5080;rport=5080;branch=z9hG4bKytFt9mX5HQNSj;received=10.1.1.46<br>   From: &quot;&quot; &lt;<a href="mailto:sip%3A03996597632298@10.1.1.46" target="_blank">sip:03996597632298@10.1.1.46</a>&gt;;tag=62eBXSt93tr7F<br>

   To: &lt;<a href="mailto:sip%3A03996563750911@203.208.207.212" target="_blank">sip:03996563750911@203.208.207.212</a>&gt;;tag=2QGB951HCR30000E1D00000u000000013MCNME<br>   Call-ID: d0f42376-18c5-122f-3387-0015c5fc7ad9<br>
   CSeq: 14110629 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 731 bytes from udp/[203.208.207.212]:5060 at 05:29:48.681395:<br>

   ------------------------------------------------------------------------<br>   UPDATE <a href="http://sip:mod_sofia@10.1.1.46:5080" target="_blank">sip:mod_sofia@10.1.1.46:5080</a> SIP/2.0<br>   Via: SIP/2.0/UDP 203.208.207.212:5060;branch=z9hG4bK00151746C47A8307FCE25ED9D752<br>

   From: &lt;<a href="mailto:sip%3A03996563750911@203.208.207.212" target="_blank">sip:03996563750911@203.208.207.212</a>&gt;;tag=2QGB951HCR30000E1D0001Ll000B8RV0KORLQK<br>   To: &quot;&quot; &lt;<a href="mailto:sip%3A03996597632298@10.1.1.46" target="_blank">sip:03996597632298@10.1.1.46</a>&gt;;tag=62eBXSt93tr7F<br>

   Call-ID: d0f42376-18c5-122f-3387-0015c5fc7ad9<br>   CSeq: 46496 UPDATE<br>   Contact: &lt;<a href="http://sip:03996563750911@203.208.207.212:5060" target="_blank">sip:03996563750911@203.208.207.212:5060</a>&gt;<br>   Content-Type: application/sdp<br>

   Max-Forwards: 70<br>   Supported: 100rel, timer, replaces<br>   Content-Length:   231<br> <br>   v=0<br>   o=- 508550174225779858 2 IN IP4 203.208.207.212<br>   s=session<br>   c=IN IP4 203.208.207.202<br>   t=0 0<br>
   m=audio 25150 RTP/AVP 18 101<br>
   a=rtpmap:18 G729/8000<br>   a=fmtp:18 annexb=no<br>   a=rtpmap:101 telephone-event/8000<br>   a=ptime:20<br>   a=inactive<br>   ------------------------------------------------------------------------<br>send 895 bytes to udp/[203.208.207.212]:5060 at 05:29:48.681661:<br>

   ------------------------------------------------------------------------<br>   SIP/2.0 200 OK<br>   Via: SIP/2.0/UDP 203.208.207.212:5060;branch=z9hG4bK00151746C47A8307FCE25ED9D752<br>   From: &lt;<a href="mailto:sip%3A03996563750911@203.208.207.212" target="_blank">sip:03996563750911@203.208.207.212</a>&gt;;tag=2QGB951HCR30000E1D0001Ll000B8RV0KORLQK<br>

   To: &quot;&quot; &lt;<a href="mailto:sip%3A03996597632298@10.1.1.46" target="_blank">sip:03996597632298@10.1.1.46</a>&gt;;tag=62eBXSt93tr7F<br>   Call-ID: d0f42376-18c5-122f-3387-0015c5fc7ad9<br>   CSeq: 46496 UPDATE<br>
   Contact: &lt;<a href="http://sip:mod_sofia@202.73.56.46:5080" target="_blank">sip:mod_sofia@202.73.56.46:5080</a>&gt;<br>
   User-Agent: FreeSWITCH-mod_sofia/1.0.7-hacked-20110603T012235Z<br>   Accept: application/sdp<br>   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, PRACK, NOTIFY<br>   Supported: 100rel, timer, precondition, path, replaces<br>

   Content-Type: application/sdp<br>   Content-Disposition: session<br>   Content-Length: 216<br> <br>   v=0<br>   o=FreeSWITCH 1308872756 1308872758 IN IP4 202.73.56.46<br>   s=FreeSWITCH<br>   c=IN IP4 202.73.56.46<br>
   t=0 0<br>
   m=audio 20630 RTP/AVP 18 101 3 13<br>   a=rtpmap:101 telephone-event/8000<br>   a=fmtp:101 0-16<br>   a=inactive<br>   a=ptime:20<br>   ------------------------------------------------------------------------<br>recv 411 bytes from udp/[203.208.207.212]:5060 at 05:29:48.681824:<br>

   ------------------------------------------------------------------------<br>   SIP/2.0 487 Request Terminated<br>   Via: SIP/2.0/UDP 10.1.1.46:5080;rport=5080;branch=z9hG4bKytFt9mX5HQNSj;received=10.1.1.46<br>   From: &quot;&quot; &lt;<a href="mailto:sip%3A03996597632298@10.1.1.46" target="_blank">sip:03996597632298@10.1.1.46</a>&gt;;tag=62eBXSt93tr7F<br>

   To: &lt;<a href="mailto:sip%3A03996563750911@203.208.207.212" target="_blank">sip:03996563750911@203.208.207.212</a>&gt;;tag=2QGB951HCR30000E1D0001Ll000B8RV0KORLQK<br>   Call-ID: d0f42376-18c5-122f-3387-0015c5fc7ad9<br>
   CSeq: 14110629 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 05:29:48.681913:<br>

   ------------------------------------------------------------------------<br>   ACK <a href="mailto:sip%3A03996563750911@203.208.207.212" target="_blank">sip:03996563750911@203.208.207.212</a> SIP/2.0<br>   Via: SIP/2.0/UDP 202.73.56.46:5080;rport;branch=z9hG4bKytFt9mX5HQNSj<br>

   Max-Forwards: 70<br>   From: &quot;&quot; &lt;<a href="mailto:sip%3A03996597632298@202.73.56.46" target="_blank">sip:03996597632298@202.73.56.46</a>&gt;;tag=62eBXSt93tr7F<br>   To: &lt;<a href="mailto:sip%3A03996563750911@203.208.207.212" target="_blank">sip:03996563750911@203.208.207.212</a>&gt;;tag=2QGB951HCR30000E1D0001Ll000B8RV0KORLQK<br>

   Call-ID: d0f42376-18c5-122f-3387-0015c5fc7ad9<br>   CSeq: 14110629 ACK<br>   Content-Length: 0<br> <br>   ------------------------------------------------------------------------<br>recv 380 bytes from udp/[203.208.207.212]:5060 at 05:29:48.683041:<br>

   ------------------------------------------------------------------------<br>   SIP/2.0 200 Ok<br>   Via: SIP/2.0/UDP 10.1.1.46:5080;rport=5080;branch=z9hG4bK0c2BDBZcc91yS;received=10.1.1.46<br>   From: &quot;&quot; &lt;<a href="mailto:sip%3A03996563750911@10.1.1.46" target="_blank">sip:03996563750911@10.1.1.46</a>&gt;;tag=5SNjUy956H2mm<br>

   To: &lt;<a href="mailto:sip%3A03996597632298@203.208.207.212" target="_blank">sip:03996597632298@203.208.207.212</a>&gt;;tag=2QGB951HCR30000E1D0001Ll000B8RX0S6R1TX<br>   Call-ID: ca5d29b7-18c5-122f-3387-0015c5fc7ad9<br>
   CSeq: 14110627 BYE<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>2011-06-24 13:29:48.524051 [DEBUG] switch_scheduler.c:138 Deleting task 27 switch_ivr_schedule_hangup (c0bd700d-913c-42ad-b68f-81001bf658b8)<br>

 <br><br><br><br><br><br><div class="gmail_quote">On Fri, Jun 24, 2011 at 2:41 PM, Michael Collins <span dir="ltr">&lt;<a href="mailto:msc@freeswitch.org" target="_blank">msc@freeswitch.org</a>&gt;</span> wrote:<br><blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex">

Pastebin the entire debug log, including the siptrace. Also include the originate line and any other dialplan config that might be used.<br><font color="#888888">-MC</font><div><div></div><div><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" 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>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" 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></blockquote></div><br><div style="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%">
</div>
</div></div><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" 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></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>