<html><body><div style="color:#000; background-color:#fff; font-family:times new roman, new york, times, serif;font-size:12pt"><div><span><font color="#454545" face="arial, helvetica, sans-serif" size="2">okay good to know about java. and since i cant use java i wont be using spidermonkey teletone, i was trying to use the example answering machine script . i want to have voice bulletin board that would allow callers to record a public message and have other callers be able to listen to the last 30 or so. and the mod voicemail has too many options right now for this. as far as the mod shout goes. yes i want to have a folder of mp3s and maybe even an internet stream or too so this is important to me. when you say not to mix 32bit and 64 bit dlls. do you mean if i installed the 64 bit msi not to build 32bit dlls? if not, is it just better for me to always run the 32 bit even on a 64 bit windows server?</font></span></div><div><span><font color="#454545"
 face="arial, helvetica, sans-serif" size="2"><br></font></span></div><div><span><font color="#454545" face="arial, helvetica, sans-serif" size="2">rodney</font></span></div><div style="font-family: 'times new roman', 'new york', times, serif; font-size: 12pt; "><br></div>  <div style="font-size: 12pt; font-family: 'times new roman', 'new york', times, serif; "> <div style="font-size: 12pt; font-family: 'times new roman', 'new york', times, serif; "> <font size="2" face="Arial"> <hr size="1">  <b><span style="font-weight:bold;">From:</span></b> "freeswitch-users-request@lists.freeswitch.org" &lt;freeswitch-users-request@lists.freeswitch.org&gt;<br> <b><span style="font-weight: bold;">To:</span></b> freeswitch-users@lists.freeswitch.org <br> <b><span style="font-weight: bold;">Sent:</span></b> Sunday, January 8, 2012 8:33 PM<br> <b><span style="font-weight: bold;">Subject:</span></b> FreeSWITCH-users Digest, Vol 67, Issue 69<br> </font> <br>-----
 Forwarded Message -----<br><br>
Send FreeSWITCH-users mailing list submissions to<br>&nbsp;&nbsp;&nbsp; <a ymailto="mailto:freeswitch-users@lists.freeswitch.org" href="mailto:freeswitch-users@lists.freeswitch.org">freeswitch-users@lists.freeswitch.org</a><br><br>To subscribe or unsubscribe via the World Wide Web, visit<br>&nbsp;&nbsp;&nbsp; http://lists.freeswitch.org/mailman/listinfo/freeswitch-users<br>or, via email, send a message with subject or body 'help' to<br>&nbsp;&nbsp;&nbsp; <a ymailto="mailto:freeswitch-users-request@lists.freeswitch.org" href="mailto:freeswitch-users-request@lists.freeswitch.org">freeswitch-users-request@lists.freeswitch.org</a><br><br>You can reach the person managing the list at<br>&nbsp;&nbsp;&nbsp; <a ymailto="mailto:freeswitch-users-owner@lists.freeswitch.org" href="mailto:freeswitch-users-owner@lists.freeswitch.org">freeswitch-users-owner@lists.freeswitch.org</a><br><br>When replying, please edit your Subject line so it is more specific<br>than "Re:
 Contents of FreeSWITCH-users digest..."<br><br>Today's Topics:<br><br>&nbsp;  1. error loading module dll open error /sym error (Rodney)<br>&nbsp;  2. Re: error loading module dll open error /sym&nbsp;&nbsp;&nbsp; error (Jeff Lenk)<br>&nbsp;  3. Re: error loading module dll open error /sym error (Peter Olsson)<br>&nbsp;  4. MPL v2 (Pusk?s Zsolt)<br>&nbsp;  5. Witholding number on demand (Bob Smith)<br>&nbsp;  6. Re: MPL v2 (curriegrad2004)<br>&nbsp;  7. FreeTDM [MANDATORY_IE_MISSING] (Adam Ford)<br><div id="yiv2073197183"><div><div style="color: rgb(0, 0, 0); background-color: rgb(255, 255, 255); font-size: 12pt; font-family: 'times new roman', 'new york', times, serif; "><div style="font-size: 12pt; font-family: times, serif; ">I am using Freeswitch Version 1.0.head (git-a2ea9e5 2012-01-05 16-12-35 -0800) on windows 64</div><div style="font-size: 12pt; font-family: times, serif; "><br></div><div style="font-size: 12pt; font-family: times, serif; ">when
 I try to load most modules not pre loaded I get errors. even though the dlls are in the mod folder. here are some sample errors</div><div style="font-size: 12pt; font-family: times, serif; "><br></div><div><div><font face="'times new roman', 'new york', times, serif">[CRIT] switch_loadable_module.c:1281 Error Loading module C:\Program Files\Freeswitch\mod\mod_java.dll</font></div><div><font face="'times new roman', 'new york',
 times, serif"><br></font></div><div><font face="'times new roman', 'new york', times, serif">dll open error 1261</font></div><div><font face="'times new roman', 'new york', times, serif"><br></font></div><div><font face="'times new roman', 'new york', times, serif">[CRIT] switch_loadable_module.c:1281 Error Loading module C:\Program Files\Freeswitch\mod\mod_shout.dll</font></div><div><font face="'times new roman', 'new york', times, serif"><br></font></div><div><font face="'times new roman', 'new york', times, serif">dll open error 1931</font></div><div><font face="'times new roman', 'new york', times, serif"><br></font></div><div><font face="'times new roman', 'new york', times, serif"><br></font></div><div><font face="'times new roman', 'new york', times, serif">[CRIT] switch_loadable_module.c:1281 Error Loading module C:\Program Files\Freeswitch\mod\mod_spidermonkey_teletone.dll</font></div><div><font face="'times new roman', 'new york', times,
 serif"><br></font></div><div><font face="'times new roman', 'new york', times, serif">dll sym error 1271</font></div><div><font face="'times new roman', 'new york', times, serif"><br></font></div><div><font face="'times new roman', 'new york', times, serif"><br></font></div><div><font face="'times new roman', 'new york', times, serif"><br></font></div><div><font face="'times new roman', 'new york', times, serif">since this is happening on most modules is there a windows permission problem or should i be looking in another place? thanks.</font></div></div></div></div></div>mod_java is not currently supported on windows so I'm not sure how you built<br>that.<br><br>the spidermonkey error is because thats a sub module of mod_spidermonkey not<br>loadable directly by fs.<br><br>make sure you are not mixing 32 and 64 version of dlls.<br><br>--<br>View this message in context: <a
 href="http://freeswitch-users.2379917.n2.nabble.com/error-loading-module-dll-open-error-sym-error-tp7165636p7165750.html" target="_blank">http://freeswitch-users.2379917.n2.nabble.com/error-loading-module-dll-open-error-sym-error-tp7165636p7165750.html</a><br>Sent from the freeswitch-users mailing list archive at Nabble.com.<br><br><br>Have you built the modules yourself?<br><br>mod_spidermonkey_teletone.dll is only loaded by mod_spidermonkey.dll, nothing you should load youself. mod_java.dll and mod_shout.dll I've never tried myself, I've never even tried to build them. Is this modules you will actually be using?<br><br>/Peter<br>________________________________<br>Från: <a ymailto="mailto:freeswitch-users-bounces@lists.freeswitch.org" href="mailto:freeswitch-users-bounces@lists.freeswitch.org">freeswitch-users-bounces@lists.freeswitch.org</a> [<a ymailto="mailto:freeswitch-users-bounces@lists.freeswitch.org"
 href="mailto:freeswitch-users-bounces@lists.freeswitch.org">freeswitch-users-bounces@lists.freeswitch.org</a>] för Rodney [<a ymailto="mailto:notlikeme75@yahoo.com" href="mailto:notlikeme75@yahoo.com">notlikeme75@yahoo.com</a>]<br>Skickat: den 8 januari 2012 20:42<br>Till: <a ymailto="mailto:freeswitch-users@lists.freeswitch.org" href="mailto:freeswitch-users@lists.freeswitch.org">freeswitch-users@lists.freeswitch.org</a><br>Ämne: [Freeswitch-users] error loading module dll open error /sym error<br><br>I am using Freeswitch Version 1.0.head (git-a2ea9e5 2012-01-05 16-12-35 -0800) on windows 64<br><br>when I try to load most modules not pre loaded I get errors. even though the dlls are in the mod folder. here are some sample errors<br><br>[CRIT] switch_loadable_module.c:1281 Error Loading module C:\Program Files\Freeswitch\mod\mod_java.dll<br><br>dll open error 1261<br><br>[CRIT] switch_loadable_module.c:1281 Error Loading module C:\Program
 Files\Freeswitch\mod\mod_shout.dll<br><br>dll open error 1931<br><br><br>[CRIT] switch_loadable_module.c:1281 Error Loading module C:\Program Files\Freeswitch\mod\mod_spidermonkey_teletone.dll<br><br>dll sym error 1271<br><br><br><br>since this is happening on most modules is there a windows permission problem or should i be looking in another place? thanks.<br>!DSPAM:4f09f21e32761579542154!<br><br><br>Hi.<br><br>A new version of the MPL license just came out ( <a href="http://www.opensource.org/licenses/MPL-2.0" target="_blank">http://www.opensource.org/licenses/MPL-2.0</a> ). Is the new version better than the last one? I'm trying to find the differences but this kind of text is to hard for me :)<br><br>Any plans for changing FreeSWITCH license to the new one ?<br><br>Zsolt<br><br><br>Hi,<br><br>I'm a bit of a newbie to Freeswitch at the moment, still trying to wrap my head around its power.<br><br>My current pet project is fairly simple, trying to
 mimick the prefix based number withhold features typically offered by carriers (e.g dialling 141 in the UK, or, I believe *67 will withhold your number from the recipient). &nbsp;Basically I want to set the RPID/Privacy Flags etc. if a certain prefix is dialled ahead of the main number.<br><br>My current dialplan is along the following lines :<br><br>&lt;include&gt;<br>&lt;extension name="Premium International Rates"&gt;<br>&nbsp; &nbsp; &nbsp; &nbsp; &nbsp;&lt;condition field="${toll_allow}" expression="int_premium" break="on-false" /&gt;<br>&nbsp; &nbsp; &nbsp; &nbsp; &nbsp;&lt;condition field="destination_number" expression="^(?:\+|00)(&lt;bunch of numbers&gt;)\d{1,13}$"&nbsp;break="on-false"&gt;<br>&lt;action application="bridge" data="sofia/gateway/xyz/$1"/&gt;<br>&lt;/condition&gt;<br>&lt;/extension&gt;<br>more extensions here.....<br>&lt;/include&gt;<br><br>I've found the prefix dialling example here&nbsp;<a
 href="http://wiki.freeswitch.org/wiki/Prefix_dialing" target="_blank">http://wiki.freeswitch.org/wiki/Prefix_dialing</a>, but I can't see how I can integrate it with a syntax similar to the above where I am already checking for other prefixes?&nbsp;<br><br>Thanks in advance<br><br>Bob<br><br><br><div id="yiv577508147"><div>No, can't change the license version yet. This matter may require Tony to comment on.</div>
<div class="yiv577508147gmail_quote">On 2012-01-08 1:32 PM, "Puskás Zsolt" &lt;<a rel="nofollow" ymailto="mailto:errotan@elder.hu" target="_blank" href="mailto:errotan@elder.hu">errotan@elder.hu</a>&gt; wrote:<br><blockquote class="yiv577508147gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex;">
Hi.<br>
<br>
A new version of the MPL license just came out (<br>
<a rel="nofollow" target="_blank" href="http://www.opensource.org/licenses/MPL-2.0">http://www.opensource.org/licenses/MPL-2.0</a> ). Is the new version better<br>
than the last one? I'm trying to find the differences but this kind of<br>
text is to hard for me :)<br>
<br>
Any plans for changing FreeSWITCH license to the new one ?<br>
<br>
Zsolt<br>
<br>
_________________________________________________________________________<br>
Professional FreeSWITCH Consulting Services:<br>
<a rel="nofollow" ymailto="mailto:consulting@freeswitch.org" target="_blank" href="mailto:consulting@freeswitch.org">consulting@freeswitch.org</a><br>
<a rel="nofollow" target="_blank" href="http://www.freeswitchsolutions.com">http://www.freeswitchsolutions.com</a><br>
<br>
FreeSWITCH-powered IP PBX: The CudaTel Communication Server<br>
<a rel="nofollow" target="_blank" href="http://www.cudatel.com">http://www.cudatel.com</a><br>
<br>
Official FreeSWITCH Sites<br>
<a rel="nofollow" target="_blank" href="http://www.freeswitch.org">http://www.freeswitch.org</a><br>
<a rel="nofollow" target="_blank" href="http://wiki.freeswitch.org">http://wiki.freeswitch.org</a><br>
<a rel="nofollow" target="_blank" href="http://www.cluecon.com">http://www.cluecon.com</a><br>
<br>
FreeSWITCH-users mailing list<br>
<a rel="nofollow" ymailto="mailto:FreeSWITCH-users@lists.freeswitch.org" target="_blank" href="mailto:FreeSWITCH-users@lists.freeswitch.org">FreeSWITCH-users@lists.freeswitch.org</a><br>
<a rel="nofollow" target="_blank" href="http://lists.freeswitch.org/mailman/listinfo/freeswitch-users">http://lists.freeswitch.org/mailman/listinfo/freeswitch-users</a><br>
UNSUBSCRIBE:<a rel="nofollow" target="_blank" href="http://lists.freeswitch.org/mailman/options/freeswitch-users">http://lists.freeswitch.org/mailman/options/freeswitch-users</a><br>
<a rel="nofollow" target="_blank" href="http://www.freeswitch.org">http://www.freeswitch.org</a><br>
</blockquote></div>
</div><div id="yiv1932920488"><style><!--
#yiv1932920488  
 _filtered #yiv1932920488 {font-family:"Cambria Math";panose-1:2 4 5 3 5 4 6 3 2 4;}
 _filtered #yiv1932920488 {font-family:Calibri;panose-1:2 15 5 2 2 2 4 3 2 4;}
#yiv1932920488  
#yiv1932920488 p.yiv1932920488MsoNormal, #yiv1932920488 li.yiv1932920488MsoNormal, #yiv1932920488 div.yiv1932920488MsoNormal
        {margin:0in;margin-bottom:.0001pt;font-size:11.0pt;font-family:"sans-serif";}
#yiv1932920488 a:link, #yiv1932920488 span.yiv1932920488MsoHyperlink
        {color:blue;text-decoration:underline;}
#yiv1932920488 a:visited, #yiv1932920488 span.yiv1932920488MsoHyperlinkFollowed
        {color:purple;text-decoration:underline;}
#yiv1932920488 span.yiv1932920488EmailStyle17
        {font-family:"sans-serif";color:windowtext;}
#yiv1932920488 .yiv1932920488MsoChpDefault
        {}
 _filtered #yiv1932920488 {margin:1.0in 1.0in 1.0in 1.0in;}
#yiv1932920488 div.yiv1932920488WordSection1
        {}
--></style><div><div class="yiv1932920488WordSection1"><div class="yiv1932920488MsoNormal">I can’t seem to find any info on the problem I am having by searching the archives, so I apologize if this has been answered in the past (found several about MANDATORY_IE_MISSING but they were different situations).</div><div class="yiv1932920488MsoNormal"> &nbsp;</div><div class="yiv1932920488MsoNormal">I am trying to setup FreeSWITCH using a FreeTDM + libpri + DAHDI + foneBridge2 stack.&nbsp; Outgoing calls work great, but I am running into the ‘MANDATORY_IE_MISSING’ problem with incoming calls.&nbsp; I am running the latest git version as of this morning, and completely default configuration with the exception of FreeTDM/DAHDI configuration and a modification of the default inbound_did dialplan to pass my DID 5530 to the default extension 1001.</div><div class="yiv1932920488MsoNormal"> &nbsp;</div><div class="yiv1932920488MsoNormal">Below is what I get in
 the log, I highlighted in <span style="color:#C00000;">RED</span> as soon as the call appears to start failing -</div><div class="yiv1932920488MsoNormal"> &nbsp;</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:54.946902 [NOTICE] ftmod_libpri.c:1363 -- Ring on channel 1:1 (from ********** to 5530)</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:54.946902 [DEBUG] ftmod_libpri.c:1394 RING event with complete indicator (or overlap receive disabled)</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:54.946902 [DEBUG] ftmod_libpri.c:1395 [s1c1][1:1] Changed state from DOWN to RING</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:54.946902 [DEBUG] ftdm_state.c:511 [s1c1][1:1] Executing state processor for RING</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:54.946902 [DEBUG] ftmod_libpri.c:679 -- 1:1 STATE [RING]</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:54.946902 [DEBUG] ftmod_libpri.c:687
 [s1c1][1:1] Completed state change from DOWN to RING in 0ms</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:54.946902 [DEBUG] mod_freetdm.c:2416 got clear channel sig [START]</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:54.946902 [DEBUG] ftdm_io.c:3131 [s1c1][1:1] Enabled software DTMF detector</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:54.946902 [DEBUG] mod_freetdm.c:407 Set codec PCMU 20ms</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:54.946902 [DEBUG] mod_freetdm.c:1740 Connect inbound channel FreeTDM/1:1/5530</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:54.946902 [NOTICE] switch_channel.c:924 New Channel FreeTDM/1:1/5530 [f11ea7a0-3a5d-11e1-a157-018f03d45a74]</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:54.946902 [DEBUG] mod_freetdm.c:1846 (FreeTDM/1:1/5530) State Change CS_NEW -&gt; CS_INIT</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:54.946902 [DEBUG]
 switch_core_session.c:1180 Send signal FreeTDM/1:1/5530 [BREAK]</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:54.946902 [DEBUG] switch_core_state_machine.c:362 (FreeTDM/1:1/5530) Running State Change CS_INIT</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:54.946902 [DEBUG] switch_core_state_machine.c:401 (FreeTDM/1:1/5530) State INIT</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:54.946902 [DEBUG] mod_freetdm.c:435 (FreeTDM/1:1/5530) State Change CS_INIT -&gt; CS_ROUTING</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:54.946902 [DEBUG] switch_core_session.c:1180 Send signal FreeTDM/1:1/5530 [BREAK]</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:54.946902 [DEBUG] switch_core_state_machine.c:401 (FreeTDM/1:1/5530) State INIT going to sleep</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:54.946902 [DEBUG] switch_core_state_machine.c:362 (FreeTDM/1:1/5530) Running State Change
 CS_ROUTING</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:54.946902 [DEBUG] switch_channel.c:1884 (FreeTDM/1:1/5530) Callstate Change DOWN -&gt; RINGING</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:54.946902 [DEBUG] switch_core_state_machine.c:410 (FreeTDM/1:1/5530) State ROUTING</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:54.946902 [DEBUG] mod_freetdm.c:458 FreeTDM/1:1/5530 CHANNEL ROUTING</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:54.946902 [DEBUG] mod_freetdm.c:461 [s1c1][1:1] Indicating PROCEED in state RING</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:54.946902 [DEBUG] mod_freetdm.c:461 [s1c1][1:1] Changed state from RING to PROCEED</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] ftdm_state.c:511 [s1c1][1:1] Executing state processor for PROCEED</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] ftmod_libpri.c:679 -- 1:1 STATE
 [PROCEED]</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] ftmod_libpri.c:687 [s1c1][1:1] Completed state change from RING to PROCEED in 55ms</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_core_state_machine.c:104 FreeTDM/1:1/5530 Standard ROUTING</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [INFO] mod_dialplan_xml.c:481 Processing ********** &lt;**********&gt;-&gt;5530 in context public</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 parsing [public-&gt;unloop] continue=false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 parsing [public-&gt;outside_call]
 continue=true</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Absolute Condition [outside_call]</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Action set(outside_call=true) </div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)}) </div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 parsing [public-&gt;call_debug] continue=true</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Regex (FAIL) [call_debug] ${call_debug}(false) =~ /^true$/ break=never</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 parsing [public-&gt;public_extensions] continue=false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Regex (FAIL) [public_extensions] destination_number(5530) =~ /^(10[01][0-9])$/ break=on-false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 parsing
 [public-&gt;public_did] continue=false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Regex (PASS) [public_did] destination_number(5530) =~ /^(5530)$/ break=on-false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Action set(domain_name=xx.xx.xx.xxx) </div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Action transfer(1001 XML default) </div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_core_state_machine.c:154 (FreeTDM/1:1/5530) State Change CS_ROUTING -&gt; CS_EXECUTE</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_core_session.c:1180 Send signal FreeTDM/1:1/5530 [BREAK]</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_core_state_machine.c:410 (FreeTDM/1:1/5530) State ROUTING going to sleep</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_core_state_machine.c:362
 (FreeTDM/1:1/5530) Running State Change CS_EXECUTE</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_core_state_machine.c:417 (FreeTDM/1:1/5530) State EXECUTE</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] mod_freetdm.c:478 FreeTDM/1:1/5530 CHANNEL EXECUTE</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_core_state_machine.c:192 FreeTDM/1:1/5530 Standard EXECUTE</div><div class="yiv1932920488MsoNormal">EXECUTE FreeTDM/1:1/5530 set(outside_call=true)</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] mod_dptools.c:1281 FreeTDM/1:1/5530 SET [outside_call]=[true]</div><div class="yiv1932920488MsoNormal">EXECUTE FreeTDM/1:1/5530 set(RFC2822_DATE=Sun, 08 Jan 2012 18:04:55 -0700)</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] mod_dptools.c:1281 FreeTDM/1:1/5530 SET [RFC2822_DATE]=[Sun, 08 Jan 2012 18:04:55
 -0700]</div><div class="yiv1932920488MsoNormal">EXECUTE FreeTDM/1:1/5530 set(domain_name=xx.xx.xx.xxx)</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] mod_dptools.c:1281 FreeTDM/1:1/5530 SET [domain_name]=[xx.xx.xx.xxx]</div><div class="yiv1932920488MsoNormal">EXECUTE FreeTDM/1:1/5530 transfer(1001 XML default)</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_ivr.c:1711 (FreeTDM/1:1/5530) State Change CS_EXECUTE -&gt; CS_ROUTING</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_core_session.c:1180 Send signal FreeTDM/1:1/5530 [BREAK]</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_core_session.c:729 Send signal FreeTDM/1:1/5530 [BREAK]</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [NOTICE] switch_ivr.c:1717 Transfer FreeTDM/1:1/5530 to XML[1001@default]</div><div class="yiv1932920488MsoNormal">2012-01-08
 18:04:55.006902 [DEBUG] switch_core_state_machine.c:417 (FreeTDM/1:1/5530) State EXECUTE going to sleep</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_core_state_machine.c:362 (FreeTDM/1:1/5530) Running State Change CS_ROUTING</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_core_state_machine.c:410 (FreeTDM/1:1/5530) State ROUTING</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] mod_freetdm.c:458 FreeTDM/1:1/5530 CHANNEL ROUTING</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] mod_freetdm.c:461 [s1c1][1:1] Indicating PROCEED in state PROCEED</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_core_state_machine.c:104 FreeTDM/1:1/5530 Standard ROUTING</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [INFO] mod_dialplan_xml.c:481 Processing ********** &lt;**********&gt;-&gt;1001 in
 context default</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 parsing [default-&gt;unloop] continue=false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 parsing [default-&gt;tod_example] continue=true</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Date/TimeMatch (FAIL) [tod_example] break=on-false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 parsing [default-&gt;holiday_example] continue=true</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Date/TimeMatch (FAIL) [holiday_example] break=on-false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 parsing
 [default-&gt;global-intercept] continue=false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Regex (FAIL) [global-intercept] destination_number(1001) =~ /^886$/ break=on-false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 parsing [default-&gt;group-intercept] continue=false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Regex (FAIL) [group-intercept] destination_number(1001) =~ /^\*8$/ break=on-false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 parsing [default-&gt;intercept-ext] continue=false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Regex (FAIL) [intercept-ext] destination_number(1001) =~ /^\*\*(\d+)$/ break=on-false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 parsing [default-&gt;redial] continue=false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Regex (FAIL) [redial] destination_number(1001)
 =~ /^(redial|870)$/ break=on-false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 parsing [default-&gt;global] continue=true</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Regex (FAIL) [global] ${call_debug}(false) =~ /^true$/ break=never</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Regex (FAIL) [global] ${sip_has_crypto}() =~ /^(AES_CM_128_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_80)$/ break=never</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Absolute Condition [global]</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Action hash(insert/${domain_name}-spymap/${caller_id_number}/${uuid}) </div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number}) </div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Action
 hash(insert/${domain_name}-last_dial/global/${uuid}) </div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)}) </div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 parsing [default-&gt;snom-demo-2] continue=false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Regex (FAIL) [snom-demo-2] destination_number(1001) =~ /^9001$/ break=on-false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 parsing [default-&gt;snom-demo-1] continue=false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Regex (FAIL) [snom-demo-1] destination_number(1001) =~ /^9000$/ break=on-false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 parsing [default-&gt;eavesdrop] continue=false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Regex (FAIL) [eavesdrop] destination_number(1001) =~ /^88(\d{4})$|^\*0(.*)$/
 break=on-false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 parsing [default-&gt;eavesdrop] continue=false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Regex (FAIL) [eavesdrop] destination_number(1001) =~ /^779$/ break=on-false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 parsing [default-&gt;call_return] continue=false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Regex (FAIL) [call_return] destination_number(1001) =~ /^\*69$|^869$|^lcr$/ break=on-false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 parsing [default-&gt;del-group] continue=false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Regex (FAIL) [del-group] destination_number(1001) =~ /^80(\d{2})$/ break=on-false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 parsing [default-&gt;add-group] continue=false</div><div
 class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Regex (FAIL) [add-group] destination_number(1001) =~ /^81(\d{2})$/ break=on-false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 parsing [default-&gt;call-group-simo] continue=false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Regex (FAIL) [call-group-simo] destination_number(1001) =~ /^82(\d{2})$/ break=on-false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 parsing [default-&gt;call-group-order] continue=false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Regex (FAIL) [call-group-order] destination_number(1001) =~ /^83(\d{2})$/ break=on-false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 parsing [default-&gt;extension-intercom] continue=false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Regex (FAIL) [extension-intercom] destination_number(1001) =~
 /^8(10[01][0-9])$/ break=on-false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 parsing [default-&gt;Local_Extension] continue=false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Regex (PASS) [Local_Extension] destination_number(1001) =~ /^(10[01][0-9])$/ break=on-false</div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Action export(dialed_extension=1001) </div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Action bind_meta_app(1 b s execute_extension::dx XML features) </div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Action bind_meta_app(2 b s record_session::/usr/local/freeswitch/recordings/${caller_id_number}.${strftime(%Y-%m-%d-%H-%M-%S)}.wav) </div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Action bind_meta_app(3 b s execute_extension::cf XML features) </div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Action
 bind_meta_app(4 b s execute_extension::att_xfer XML features) </div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Action set(ringback=${us-ring}) </div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Action set(transfer_ringback=local_stream://moh) </div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Action set(call_timeout=30) </div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Action set(hangup_after_bridge=true) </div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Action set(continue_on_fail=true) </div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Action hash(insert/${domain_name}-call_return/${dialed_extension}/${caller_id_number}) </div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Action hash(insert/${domain_name}-last_dial_ext/${dialed_extension}/${uuid}) </div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Action
 set(called_party_callgroup=${user_data(${dialed_extension}@${domain_name} var callgroup)}) </div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Action hash(insert/${domain_name}-last_dial_ext/${called_party_callgroup}/${uuid}) </div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Action hash(insert/${domain_name}-last_dial_ext/global/${uuid}) </div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Action hash(insert/${domain_name}-last_dial/${called_party_callgroup}/${uuid}) </div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Action bridge(user/${dialed_extension}@${domain_name}) </div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Action answer() </div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Action sleep(1000) </div><div class="yiv1932920488MsoNormal">Dialplan: FreeTDM/1:1/5530 Action bridge(loopback/app=voicemail:default ${domain_name}
 ${dialed_extension}) </div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_core_state_machine.c:154 (FreeTDM/1:1/5530) State Change CS_ROUTING -&gt; CS_EXECUTE</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_core_session.c:1180 Send signal FreeTDM/1:1/5530 [BREAK]</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_core_state_machine.c:410 (FreeTDM/1:1/5530) State ROUTING going to sleep</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_core_state_machine.c:362 (FreeTDM/1:1/5530) Running State Change CS_EXECUTE</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_core_state_machine.c:417 (FreeTDM/1:1/5530) State EXECUTE</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] mod_freetdm.c:478 FreeTDM/1:1/5530 CHANNEL EXECUTE</div><div class="yiv1932920488MsoNormal">2012-01-08
 18:04:55.006902 [DEBUG] switch_core_state_machine.c:192 FreeTDM/1:1/5530 Standard EXECUTE</div><div class="yiv1932920488MsoNormal">EXECUTE FreeTDM/1:1/5530 hash(insert/xx.xx.xx.xxx-spymap/**********/f11ea7a0-3a5d-11e1-a157-018f03d45a74)</div><div class="yiv1932920488MsoNormal">EXECUTE FreeTDM/1:1/5530 hash(insert/xx.xx.xx.xxx-last_dial/**********/1001)</div><div class="yiv1932920488MsoNormal">EXECUTE FreeTDM/1:1/5530 hash(insert/xx.xx.xx.xxx-last_dial/global/f11ea7a0-3a5d-11e1-a157-018f03d45a74)</div><div class="yiv1932920488MsoNormal">EXECUTE FreeTDM/1:1/5530 set(RFC2822_DATE=Sun, 08 Jan 2012 18:04:55 -0700)</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] mod_dptools.c:1281 FreeTDM/1:1/5530 SET [RFC2822_DATE]=[Sun, 08 Jan 2012 18:04:55 -0700]</div><div class="yiv1932920488MsoNormal">EXECUTE FreeTDM/1:1/5530 export(dialed_extension=1001)</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG]
 switch_channel.c:1091 EXPORT (export_vars) [dialed_extension]=[1001]</div><div class="yiv1932920488MsoNormal">EXECUTE FreeTDM/1:1/5530 bind_meta_app(1 b s execute_extension::dx XML features)</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [INFO] switch_ivr_async.c:3179 Bound B-Leg: *1 execute_extension::dx XML features</div><div class="yiv1932920488MsoNormal">EXECUTE FreeTDM/1:1/5530 bind_meta_app(2 b s record_session::/usr/local/freeswitch/recordings/**********.2012-01-08-18-04-55.wav)</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [INFO] switch_ivr_async.c:3179 Bound B-Leg: *2 record_session::/usr/local/freeswitch/recordings/**********.2012-01-08-18-04-55.wav</div><div class="yiv1932920488MsoNormal">EXECUTE FreeTDM/1:1/5530 bind_meta_app(3 b s execute_extension::cf XML features)</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [INFO] switch_ivr_async.c:3179 Bound B-Leg: *3
 execute_extension::cf XML features</div><div class="yiv1932920488MsoNormal">EXECUTE FreeTDM/1:1/5530 bind_meta_app(4 b s execute_extension::att_xfer XML features)</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [INFO] switch_ivr_async.c:3179 Bound B-Leg: *4 execute_extension::att_xfer XML features</div><div class="yiv1932920488MsoNormal">EXECUTE FreeTDM/1:1/5530 set(ringback=%(2000,4000,440,480))</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] mod_dptools.c:1281 FreeTDM/1:1/5530 SET [ringback]=[%(2000,4000,440,480)]</div><div class="yiv1932920488MsoNormal">EXECUTE FreeTDM/1:1/5530 set(transfer_ringback=local_stream://moh)</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] mod_dptools.c:1281 FreeTDM/1:1/5530 SET [transfer_ringback]=[local_stream://moh]</div><div class="yiv1932920488MsoNormal">EXECUTE FreeTDM/1:1/5530 set(call_timeout=30)</div><div
 class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] mod_dptools.c:1281 FreeTDM/1:1/5530 SET [call_timeout]=[30]</div><div class="yiv1932920488MsoNormal">EXECUTE FreeTDM/1:1/5530 set(hangup_after_bridge=true)</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] mod_dptools.c:1281 FreeTDM/1:1/5530 SET [hangup_after_bridge]=[true]</div><div class="yiv1932920488MsoNormal">EXECUTE FreeTDM/1:1/5530 set(continue_on_fail=true)</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] mod_dptools.c:1281 FreeTDM/1:1/5530 SET [continue_on_fail]=[true]</div><div class="yiv1932920488MsoNormal">EXECUTE FreeTDM/1:1/5530 hash(insert/xx.xx.xx.xxx-call_return/1001/**********)</div><div class="yiv1932920488MsoNormal">EXECUTE FreeTDM/1:1/5530 hash(insert/xx.xx.xx.xxx-last_dial_ext/1001/f11ea7a0-3a5d-11e1-a157-018f03d45a74)</div><div class="yiv1932920488MsoNormal">EXECUTE FreeTDM/1:1/5530
 set(called_party_callgroup=techsupport)</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] mod_dptools.c:1281 FreeTDM/1:1/5530 SET [called_party_callgroup]=[techsupport]</div><div class="yiv1932920488MsoNormal">EXECUTE FreeTDM/1:1/5530 hash(insert/xx.xx.xx.xxx-last_dial_ext/techsupport/f11ea7a0-3a5d-11e1-a157-018f03d45a74)</div><div class="yiv1932920488MsoNormal">EXECUTE FreeTDM/1:1/5530 hash(insert/xx.xx.xx.xxx-last_dial_ext/global/f11ea7a0-3a5d-11e1-a157-018f03d45a74)</div><div class="yiv1932920488MsoNormal">EXECUTE FreeTDM/1:1/5530 hash(insert/xx.xx.xx.xxx-last_dial/techsupport/f11ea7a0-3a5d-11e1-a157-018f03d45a74)</div><div class="yiv1932920488MsoNormal">EXECUTE FreeTDM/1:1/5530 bridge(user/1001@xx.xx.xx.xxx)</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_channel.c:1045 FreeTDM/1:1/5530 EXPORTING[export_vars] [dialed_extension]=[1001] to event</div><div
 class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_ivr_originate.c:1884 Parsing global variables</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_channel.c:1045 FreeTDM/1:1/5530 EXPORTING[export_vars] [dialed_extension]=[1001] to event</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_ivr_originate.c:1884 Parsing global variables</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_event.c:1521 Parsing variable [sip_invite_domain]=[xx.xx.xx.xxx]</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_event.c:1521 Parsing variable [presence_id]=[1001@xx.xx.xx.xxx]</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [NOTICE] switch_channel.c:924 New Channel sofia/internal/sip:1001@xx.xx.xx.xxx:52564 [f1292a54-3a5d-11e1-a15e-018f03d45a74]</div><div class="yiv1932920488MsoNormal">2012-01-08
 18:04:55.006902 [DEBUG] mod_sofia.c:4674 (sofia/internal/sip:1001@xx.xx.xx.xxx:52564) State Change CS_NEW -&gt; CS_INIT</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_core_session.c:1180 Send signal sofia/internal/sip:1001@xx.xx.xx.xxx:52564 [BREAK]</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_core_state_machine.c:362 (sofia/internal/sip:1001@xx.xx.xx.xxx:52564) Running State Change CS_INIT</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_core_state_machine.c:401 (sofia/internal/sip:1001@xx.xx.xx.xxx:52564) State INIT</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] mod_sofia.c:85 sofia/internal/sip:1001@xx.xx.xx.xxx:52564 SOFIA INIT</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] mod_sofia.c:125 (sofia/internal/sip:1001@xx.xx.xx.xxx:52564) State Change CS_INIT -&gt; CS_ROUTING</div><div
 class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_core_session.c:1180 Send signal sofia/internal/sip:1001@xx.xx.xx.xxx:52564 [BREAK]</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_core_state_machine.c:401 (sofia/internal/sip:1001@xx.xx.xx.xxx:52564) State INIT going to sleep</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_core_state_machine.c:362 (sofia/internal/sip:1001@xx.xx.xx.xxx:52564) Running State Change CS_ROUTING</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_channel.c:1884 (sofia/internal/sip:1001@xx.xx.xx.xxx:52564) Callstate Change DOWN -&gt; RINGING</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_core_state_machine.c:410 (sofia/internal/sip:1001@xx.xx.xx.xxx:52564) State ROUTING</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] mod_sofia.c:148
 sofia/internal/sip:1001@xx.xx.xx.xxx:52564 SOFIA ROUTING</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_ivr_originate.c:66 (sofia/internal/sip:1001@xx.xx.xx.xxx:52564) State Change CS_ROUTING -&gt; CS_CONSUME_MEDIA</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_core_session.c:1180 Send signal sofia/internal/sip:1001@xx.xx.xx.xxx:52564 [BREAK]</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_core_state_machine.c:410 (sofia/internal/sip:1001@xx.xx.xx.xxx:52564) State ROUTING going to sleep</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_core_session.c:875 Send signal sofia/internal/sip:1001@xx.xx.xx.xxx:52564 [BREAK]</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_core_state_machine.c:362 (sofia/internal/sip:1001@xx.xx.xx.xxx:52564) Running State Change CS_CONSUME_MEDIA</div><div
 class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_core_state_machine.c:429 (sofia/internal/sip:1001@xx.xx.xx.xxx:52564) State CONSUME_MEDIA</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] switch_core_state_machine.c:429 (sofia/internal/sip:1001@xx.xx.xx.xxx:52564) State CONSUME_MEDIA going to sleep</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.006902 [DEBUG] sofia.c:5482 Channel sofia/internal/sip:1001@xx.xx.xx.xxx:52564 entering state [calling][0]</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.046916 [DEBUG] ftmod_libpri.c:1668 Got a FACILITY event on span 1:1</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.046916 [DEBUG] ftmod_libpri.c:1697 FACILITY subcommand 2 is not implemented, ignoring</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.046916 [DEBUG] ftmod_libpri.c:1700 FACILITY subcommand 2 handler returned -1</div><div
 class="yiv1932920488MsoNormal">2012-01-08 18:04:55.046916 [DEBUG] ftmod_libpri.c:1703 Caught Event on span 1 11 (FACILITY)</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.126907 [DEBUG] switch_core_session.c:875 Send signal sofia/internal/sip:1001@xx.xx.xx.xxx:52564 [BREAK]</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.126907 [DEBUG] switch_core_session.c:875 Send signal sofia/internal/sip:1001@xx.xx.xx.xxx:52564 [BREAK]</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.126907 [DEBUG] sofia.c:5482 Channel sofia/internal/sip:1001@xx.xx.xx.xxx:52564 entering state [proceeding][180]</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.126907 [NOTICE] sofia.c:5574 Ring-Ready sofia/internal/sip:1001@xx.xx.xx.xxx:52564!</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.126907 [DEBUG] mod_freetdm.c:970 [s1c1][1:1] Indicating PROGRESS_MEDIA in state PROCEED</div><div
 class="yiv1932920488MsoNormal">2012-01-08 18:04:55.126907 [DEBUG] mod_freetdm.c:970 [s1c1][1:1] Changed state from PROCEED to PROGRESS</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.146908 [DEBUG] ftdm_state.c:511 [s1c1][1:1] Executing state processor for PROGRESS</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.146908 [DEBUG] ftmod_libpri.c:679 -- 1:1 STATE [PROGRESS]</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.146908 [DEBUG] ftmod_libpri.c:687 [s1c1][1:1] Completed state change from PROCEED to PROGRESS in 22ms</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.146908 [ERR] ftmod_libpri.c:132 XXX Progress message requested but no information is provided</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.146908 [DEBUG] mod_freetdm.c:970 [s1c1][1:1] Changed state from PROGRESS to PROGRESS_MEDIA</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.206902 [DEBUG] ftdm_state.c:511
 [s1c1][1:1] Executing state processor for PROGRESS_MEDIA</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.206902 [DEBUG] ftmod_libpri.c:679 -- 1:1 STATE [PROGRESS_MEDIA]</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.206902 [DEBUG] ftmod_libpri.c:687 [s1c1][1:1] Completed state change from PROGRESS to PROGRESS_MEDIA in 55ms</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.206902 [INFO] ftmod_zt.c:656 Setting echo cancel to 64 taps for 1:1</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.206902 [WARNING] ftmod_zt.c:661 Echo cancel not available for 1:1</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.206902 [DEBUG] switch_core_session.c:729 Send signal FreeTDM/1:1/5530 [BREAK]</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.206902 [NOTICE] switch_ivr_originate.c:1115 Pre-Answer FreeTDM/1:1/5530!</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.206902 [DEBUG]
 switch_channel.c:2930 (FreeTDM/1:1/5530) Callstate Change RINGING -&gt; EARLY</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.206902 [DEBUG] switch_ivr_originate.c:1164 Raw Codec Activation Success L16@8000hz 1 channel 20ms</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.206902 [DEBUG] switch_core_codec.c:116 FreeTDM/1:1/5530 Push codec L16:70</div><div class="yiv1932920488MsoNormal">2012-01-08 18:04:55.206902 [DEBUG] switch_ivr_originate.c:1227 Play Ringback Tone [%(2000,4000,440,480)]</div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.226909 [DEBUG] ftmod_libpri.c:1065 -- Hangup REQ on channel 1:1</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.226909 [DEBUG] ftmod_libpri.c:1078 [s1c1][1:1] Changed state from PROGRESS_MEDIA to TERMINATING</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08
 18:04:55.226909 [DEBUG] ftdm_state.c:511 [s1c1][1:1] Executing state processor for TERMINATING</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.226909 [DEBUG] ftmod_libpri.c:679 -- 1:1 STATE [TERMINATING]</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.226909 [DEBUG] ftmod_libpri.c:687 [s1c1][1:1] Completed state change from PROGRESS_MEDIA to TERMINATING in 0ms</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.226909 [DEBUG] ftdm_io.c:5565 [s1c1][1:1] Scheduling safety hangup timer</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.226909 [DEBUG] mod_freetdm.c:2416 got clear channel sig [STOP]</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.226909 [DEBUG] switch_channel.c:2846 (FreeTDM/1:1/5530) Callstate Change EARLY
 -&gt; HANGUP</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.226909 [NOTICE] mod_freetdm.c:2441 Hangup FreeTDM/1:1/5530 [CS_EXECUTE] [MANDATORY_IE_MISSING]</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.226909 [DEBUG] switch_channel.c:2869 Send signal FreeTDM/1:1/5530 [KILL]</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.226909 [DEBUG] switch_core_session.c:1180 Send signal FreeTDM/1:1/5530 [BREAK]</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_codec.c:141 FreeTDM/1:1/5530 Restore previous codec PCMU:0.</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_channel.c:2846 (sofia/internal/sip:1001@xx.xx.xx.xxx:52564) Callstate Change RINGING -&gt;
 HANGUP</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [NOTICE] switch_ivr_originate.c:3182 Hangup sofia/internal/sip:1001@xx.xx.xx.xxx:52564 [CS_CONSUME_MEDIA] [ORIGINATOR_CANCEL]</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_channel.c:2869 Send signal sofia/internal/sip:1001@xx.xx.xx.xxx:52564 [KILL]</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_session.c:1180 Send signal sofia/internal/sip:1001@xx.xx.xx.xxx:52564 [BREAK]</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_state_machine.c:362 (sofia/internal/sip:1001@xx.xx.xx.xxx:52564) Running State Change CS_HANGUP</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG]
 switch_ivr_originate.c:3358 Originate Cancelled by originator termination Cause: 487 [ORIGINATOR_CANCEL]</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [NOTICE] switch_ivr_originate.c:2459 Cannot create outgoing channel of type [user] cause: [ORIGINATOR_CANCEL]</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_ivr_originate.c:3364 Originate Resulted in Error Cause: 487 [ORIGINATOR_CANCEL]</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [INFO] mod_dptools.c:2900 Originate Failed.&nbsp; Cause: ORIGINATOR_CANCEL</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_session.c:2285 FreeTDM/1:1/5530 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)</span></div><div
 class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_state_machine.c:417 (FreeTDM/1:1/5530) State EXECUTE going to sleep</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_state_machine.c:362 (FreeTDM/1:1/5530) Running State Change CS_HANGUP</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_state_machine.c:602 (sofia/internal/sip:1001@xx.xx.xx.xxx:52564) State HANGUP</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] mod_sofia.c:469 Channel sofia/internal/sip:1001@xx.xx.xx.xxx:52564 hanging up, cause: ORIGINATOR_CANCEL</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_state_machine.c:602 (FreeTDM/1:1/5530) State
 HANGUP</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] mod_freetdm.c:530 [1:1] FreeTDM/1:1/5530 CHANNEL HANGUP ENTER</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] mod_freetdm.c:605 [s1c1][1:1] Changed state from TERMINATING to HANGUP</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] mod_sofia.c:523 Sending CANCEL to sofia/internal/sip:1001@xx.xx.xx.xxx:52564</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_state_machine.c:47 sofia/internal/sip:1001@xx.xx.xx.xxx:52564 Standard HANGUP, cause: ORIGINATOR_CANCEL</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_state_machine.c:602
 (sofia/internal/sip:1001@xx.xx.xx.xxx:52564) State HANGUP going to sleep</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_state_machine.c:393 (sofia/internal/sip:1001@xx.xx.xx.xxx:52564) State Change CS_HANGUP -&gt; CS_REPORTING</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_session.c:1180 Send signal sofia/internal/sip:1001@xx.xx.xx.xxx:52564 [BREAK]</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_state_machine.c:362 (sofia/internal/sip:1001@xx.xx.xx.xxx:52564) Running State Change CS_REPORTING</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/sip:1001@xx.xx.xx.xxx:52564) State REPORTING</span></div><div
 class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_state_machine.c:79 sofia/internal/sip:1001@xx.xx.xx.xxx:52564 Standard REPORTING, cause: ORIGINATOR_CANCEL</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/sip:1001@xx.xx.xx.xxx:52564) State REPORTING going to sleep</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_state_machine.c:387 (sofia/internal/sip:1001@xx.xx.xx.xxx:52564) State Change CS_REPORTING -&gt; CS_DESTROY</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_session.c:1180 Send signal sofia/internal/sip:1001@xx.xx.xx.xxx:52564 [BREAK]</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08
 18:04:55.246902 [DEBUG] switch_core_session.c:1380 Session 2 (sofia/internal/sip:1001@xx.xx.xx.xxx:52564) Locked, Waiting on external entities</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [NOTICE] switch_core_session.c:1398 Session 2 (sofia/internal/sip:1001@xx.xx.xx.xxx:52564) Ended</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [NOTICE] switch_core_session.c:1400 Close Channel sofia/internal/sip:1001@xx.xx.xx.xxx:52564 [CS_DESTROY]</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_state_machine.c:491 (sofia/internal/sip:1001@xx.xx.xx.xxx:52564) Callstate Change HANGUP -&gt; DOWN</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_state_machine.c:494 (sofia/internal/sip:1001@xx.xx.xx.xxx:52564)
 Running State Change CS_DESTROY</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_state_machine.c:504 (sofia/internal/sip:1001@xx.xx.xx.xxx:52564) State DESTROY</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] mod_sofia.c:374 sofia/internal/sip:1001@xx.xx.xx.xxx:52564 SOFIA DESTROY</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_state_machine.c:86 sofia/internal/sip:1001@xx.xx.xx.xxx:52564 Standard DESTROY</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_state_machine.c:504 (sofia/internal/sip:1001@xx.xx.xx.xxx:52564) State DESTROY going to sleep</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG]
 ftdm_state.c:511 [s1c1][1:1] Executing state processor for HANGUP</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] ftmod_libpri.c:679 -- 1:1 STATE [HANGUP]</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] ftmod_libpri.c:687 [s1c1][1:1] Completed state change from TERMINATING to HANGUP in 15ms</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] ftmod_libpri.c:929 [s1c1][1:1] Changed state from HANGUP to HANGUP_COMPLETE</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] ftdm_state.c:511 [s1c1][1:1] Executing state processor for HANGUP_COMPLETE</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] ftmod_libpri.c:679 -- 1:1 STATE
 [HANGUP_COMPLETE]</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] ftmod_libpri.c:687 [s1c1][1:1] Completed state change from HANGUP to HANGUP_COMPLETE in 0ms</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] ftmod_libpri.c:939 [s1c1][1:1] Changed state from HANGUP_COMPLETE to DOWN</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] ftdm_state.c:511 [s1c1][1:1] Executing state processor for DOWN</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] ftmod_libpri.c:679 -- 1:1 STATE [DOWN]</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] ftmod_libpri.c:687 [s1c1][1:1] Completed state change from HANGUP_COMPLETE to DOWN in 0ms</span></div><div
 class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] ftdm_io.c:2930 [s1c1][1:1] DTMF debug is already disabled</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] ftdm_io.c:2962 [s1c1][1:1] No need to disable input dump</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] ftdm_io.c:2993 [s1c1][1:1] No need to disable output dump</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] mod_freetdm.c:2416 got clear channel sig [RELEASED]</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] ftdm_io.c:6185 Cleared call with id 1</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] ftdm_io.c:2735 [s1c1][1:1] channel
 done</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] ftmod_libpri.c:704 -- Closed channel 1:1</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] mod_freetdm.c:624 [1:1] FreeTDM/1:1/5530 CHANNEL HANGUP EXIT</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_state_machine.c:47 FreeTDM/1:1/5530 Standard HANGUP, cause: MANDATORY_IE_MISSING</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_state_machine.c:602 (FreeTDM/1:1/5530) State HANGUP going to sleep</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_state_machine.c:393 (FreeTDM/1:1/5530) State Change CS_HANGUP -&gt; CS_REPORTING</span></div><div
 class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_session.c:1180 Send signal FreeTDM/1:1/5530 [BREAK]</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_state_machine.c:362 (FreeTDM/1:1/5530) Running State Change CS_REPORTING</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_state_machine.c:662 (FreeTDM/1:1/5530) State REPORTING</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_state_machine.c:79 FreeTDM/1:1/5530 Standard REPORTING, cause: MANDATORY_IE_MISSING</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_state_machine.c:662 (FreeTDM/1:1/5530) State REPORTING going to sleep</span></div><div
 class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_state_machine.c:387 (FreeTDM/1:1/5530) State Change CS_REPORTING -&gt; CS_DESTROY</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_session.c:1180 Send signal FreeTDM/1:1/5530 [BREAK]</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_session.c:1380 Session 1 (FreeTDM/1:1/5530) Locked, Waiting on external entities</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [NOTICE] switch_core_session.c:1398 Session 1 (FreeTDM/1:1/5530) Ended</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [NOTICE] switch_core_session.c:1400 Close Channel FreeTDM/1:1/5530 [CS_DESTROY]</span></div><div
 class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_state_machine.c:491 (FreeTDM/1:1/5530) Callstate Change HANGUP -&gt; DOWN</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_state_machine.c:494 (FreeTDM/1:1/5530) Running State Change CS_DESTROY</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_state_machine.c:504 (FreeTDM/1:1/5530) State DESTROY</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_state_machine.c:86 FreeTDM/1:1/5530 Standard DESTROY</span></div><div class="yiv1932920488MsoNormal"><span style="color:#C00000;">2012-01-08 18:04:55.246902 [DEBUG] switch_core_state_machine.c:504 (FreeTDM/1:1/5530) State DESTROY going to sleep</span></div><div
 class="yiv1932920488MsoNormal"> &nbsp;</div><div class="yiv1932920488MsoNormal">Full log (including loading FreeSWITCH) at <a rel="nofollow" target="_blank" href="http://pastebin.com/vQUHu0pR">http://pastebin.com/vQUHu0pR</a></div><div class="yiv1932920488MsoNormal"> &nbsp;</div><div class="yiv1932920488MsoNormal">freeswitch/conf/freetdm.conf – </div><div class="yiv1932920488MsoNormal">[span zt PRI]</div><div class="yiv1932920488MsoNormal">trunk_type =&gt; T1</div><div class="yiv1932920488MsoNormal">b-channel=1-23</div><div class="yiv1932920488MsoNormal">d-channel=24</div><div class="yiv1932920488MsoNormal"> &nbsp;</div><div class="yiv1932920488MsoNormal">freeswitch/conf/autoload_confg/freetdm.conf.xml –</div><div class="yiv1932920488MsoNormal">&lt;configuration name="freetdm.conf" description="FreeTDM Configuration"&gt;</div><div class="yiv1932920488MsoNormal">&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;settings&gt;</div><div
 class="yiv1932920488MsoNormal">&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;param name="debug" value="1"/&gt;</div><div class="yiv1932920488MsoNormal">&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;/settings&gt;</div><div class="yiv1932920488MsoNormal">&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;libpri_spans&gt;</div><div class="yiv1932920488MsoNormal">&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;span name="PRI"&gt;</div><div class="yiv1932920488MsoNormal">&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;param name="node" value="cpe"/&gt;</div><div class="yiv1932920488MsoNormal">&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;param name="switch"
 value="ni2"/&gt;</div><div class="yiv1932920488MsoNormal">&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;param name="dialplan" value="XML"/&gt;</div><div class="yiv1932920488MsoNormal">&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;param name="context" value="public"/&gt;</div><div class="yiv1932920488MsoNormal">&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;param name="l1" value="ulaw"/&gt;</div><div class="yiv1932920488MsoNormal">&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;/span&gt;</div><div class="yiv1932920488MsoNormal">&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;/libpri_spans&gt;</div><div
 class="yiv1932920488MsoNormal">&lt;/configuration&gt;</div><div class="yiv1932920488MsoNormal"> &nbsp;</div><div class="yiv1932920488MsoNormal">/etc/dahdi/system.conf –</div><div class="yiv1932920488MsoNormal">loadzone = us</div><div class="yiv1932920488MsoNormal">defaultzone=us</div><div class="yiv1932920488MsoNormal">dynamic=ethmf,eth0/00:50:c2:65:d7:59/0,24,1</div><div class="yiv1932920488MsoNormal">bchan=1-23</div><div class="yiv1932920488MsoNormal">dchan=24</div><div class="yiv1932920488MsoNormal"> &nbsp;</div><div class="yiv1932920488MsoNormal"> &nbsp;</div><div class="yiv1932920488MsoNormal">I am guessing it is a configuration issue, though this same config is currently working in production with FreeSWITCH 1.0.6 + OpenZAP + Libpri + DAHDI + foneBridge2.</div><div class="yiv1932920488MsoNormal"> &nbsp;</div><div class="yiv1932920488MsoNormal">Any help is greatly appreciated.</div><div class="yiv1932920488MsoNormal"> &nbsp;</div><div
 class="yiv1932920488MsoNormal">-Adam</div><div class="yiv1932920488MsoNormal"> &nbsp;</div><div class="yiv1932920488MsoNormal"> &nbsp;</div></div></div></div><br>_______________________________________________<br>FreeSWITCH-users mailing list<br><a ymailto="mailto:FreeSWITCH-users@lists.freeswitch.org" 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><br> </div> </div>  </div></body></html>