<!DOCTYPE HTML PUBLIC "-//W3C//DTD HTML 4.0 Transitional//EN">
<HTML><HEAD>
<META content="text/html; charset=us-ascii" http-equiv=Content-Type>
<META name=GENERATOR content="MSHTML 8.00.6001.18852"></HEAD>
<BODY>
<DIV dir=ltr align=left><SPAN class=355095623-21122009><FONT color=#0000ff 
size=2 face=Arial>Okay, I upgraded to 1.0.5pre9 and tried this test again and I 
do not see the WARNING in the Freeswitch log.&nbsp; However, it still behaves 
the same way.&nbsp; That is, the internal callee rings for about 12 seconds, 
then stops ringing, and the PSTN caller just hears ringback for about 60 seconds 
and is not given the opportunity to leave voice mail.&nbsp; In contrast, an 
internal-to-internal call will go to voice mail after 30 
seconds.</FONT></SPAN></DIV>
<DIV dir=ltr align=left><SPAN class=355095623-21122009><FONT color=#0000ff 
size=2 face=Arial></FONT></SPAN>&nbsp;</DIV>
<DIV dir=ltr align=left><SPAN class=355095623-21122009><FONT color=#0000ff 
size=2 face=Arial>I put a new 11595 log into the pastebin.&nbsp; Is there some 
Sangoma Wanpipe driver (or Freeswitch)&nbsp;setting that would correct 
this?&nbsp;</FONT></SPAN></DIV>
<DIV dir=ltr align=left><SPAN class=355095623-21122009><FONT color=#0000ff 
size=2 face=Arial></FONT></SPAN>&nbsp;</DIV>
<DIV dir=ltr align=left><SPAN class=355095623-21122009><FONT color=#0000ff 
size=2 face=Arial>Best Regards,</FONT></SPAN></DIV>
<DIV dir=ltr align=left><SPAN class=355095623-21122009><FONT color=#0000ff 
size=2 face=Arial>Jerry</FONT></SPAN></DIV>
<DIV dir=ltr align=left><SPAN class=355095623-21122009><FONT color=#0000ff 
size=2 face=Arial></FONT></SPAN>&nbsp;</DIV><FONT color=#0000ff size=2 
face=Arial></FONT><BR>
<BLOCKQUOTE style="MARGIN-RIGHT: 0px">
  <DIV dir=ltr lang=en-us class=OutlookMessageHeader align=left>
  <HR tabIndex=-1>
  <FONT size=2 face=Tahoma><B>From:</B> Anthony Minessale 
  [mailto:anthony.minessale@gmail.com] <BR><B>Sent:</B> Tuesday, November 03, 
  2009 2:23 PM<BR><B>To:</B> 
  freeswitch-users@lists.freeswitch.org<BR><B>Subject:</B> Re: 
  [Freeswitch-users] WARNING On Inbound Call Question<BR></FONT><BR></DIV>
  <DIV></DIV>can you try the same thing with the latest trunk or pre-release 
  tarball.<BR><BR><BR>
  <DIV class=gmail_quote>On Tue, Nov 3, 2009 at 3:35 PM, Jerry Richards <SPAN 
  dir=ltr>&lt;<A 
  href="mailto:jerry.richards@teotech.com">jerry.richards@teotech.com</A>&gt;</SPAN> 
  wrote:<BR>
  <BLOCKQUOTE 
  style="BORDER-LEFT: rgb(204,204,204) 1px solid; MARGIN: 0pt 0pt 0pt 0.8ex; PADDING-LEFT: 1ex" 
  class=gmail_quote><BR>I have my Freeswitch server with an installed Sangoma 
    A101D card. &nbsp;Most<BR>everything works okay, however, when I get an 
    inbound call from the PSTN, I<BR>see the following warning show up in the 
    log. &nbsp;Additionally, the caller (on<BR>the PSTN) does not hear ringback, 
    and if the call is not answered within<BR>about 12 seconds, the call ends 
    (so it doesn't go to voice mail). &nbsp;If I make<BR>a call from one 
    internal phone to another, then it will go to voice mail<BR>after 30 
    seconds.<BR><BR><BR>Here are the two warnings:<BR><BR>[WARNING] 
    ss7_boost_client.c:218 TX EVENT (N): CALL_START_ACK:(81) [w1g1]<BR>Rc=0 
    CSid=0 Seq=11<BR>[WARNING] mod_openzap.c:761 VETO Changing state on 1:1 from 
    PROGRESS to<BR>PROGRESS_MEDIA<BR><BR><BR>Here is the log of the warning upon 
    an inbound call:<BR><BR><A 
    href="mailto:freeswitch@TeoProxy.greyhawk.tonecommander.com">freeswitch@TeoProxy.greyhawk.tonecommander.com</A>&gt;<BR><A 
    href="mailto:freeswitch@TeoProxy.greyhawk.tonecommander.com">freeswitch@TeoProxy.greyhawk.tonecommander.com</A>&gt;<BR><A 
    href="mailto:freeswitch@TeoProxy.greyhawk.tonecommander.com">freeswitch@TeoProxy.greyhawk.tonecommander.com</A>&gt;<BR><A 
    href="mailto:freeswitch@TeoProxy.greyhawk.tonecommander.com">freeswitch@TeoProxy.greyhawk.tonecommander.com</A>&gt;<BR><A 
    href="mailto:freeswitch@TeoProxy.greyhawk.tonecommander.com">freeswitch@TeoProxy.greyhawk.tonecommander.com</A>&gt;<BR><A 
    href="mailto:freeswitch@TeoProxy.greyhawk.tonecommander.com">freeswitch@TeoProxy.greyhawk.tonecommander.com</A>&gt;<BR><A 
    href="mailto:freeswitch@TeoProxy.greyhawk.tonecommander.com">freeswitch@TeoProxy.greyhawk.tonecommander.com</A>&gt; 
    2009-11-02 09:06:01.664835<BR>[WARNING] ozmod_ss7_boost.c:1141 RX EVENT: 
    CALL_START:(80) [w1g1] CSid=0<BR>Seq=12 Cn=[N/A] Cd=[5384] 
    Ci=[4253813176]<BR>2009-11-02 09:06:01.665824 [DEBUG] ozmod_ss7_boost.c:655 
    Changing state on<BR>1:1 from DOWN to RING<BR>2009-11-02 09:06:01.665824 
    [DEBUG] ozmod_ss7_boost.c:841 1:1 STATE [RING]<BR>2009-11-02 09:06:01.665824 
    [DEBUG] mod_openzap.c:1481 got clear channel sig<BR>[START]<BR>2009-11-02 
    09:06:01.665824 [DEBUG] mod_openzap.c:344 Set codec PCMU 20ms<BR>2009-11-02 
    09:06:01.665824 [DEBUG] mod_openzap.c:1184 Connect inbound<BR>channel 
    OpenZAP/1:1/5384<BR>2009-11-02 09:06:01.665824 [NOTICE] switch_channel.c:602 
    New Channel<BR>OpenZAP/1:1/5384 
    [b678f311-ab74-4cc1-afac-b83d89a53132]<BR>2009-11-02 09:06:01.665824 [DEBUG] 
    mod_openzap.c:1192 (OpenZAP/1:1/5384)<BR>State Change CS_NEW -&gt; 
    CS_INIT<BR>2009-11-02 09:06:01.665824 [DEBUG] switch_core_session.c:932 Send 
    signal<BR>OpenZAP/1:1/5384 [BREAK]<BR>2009-11-02 09:06:01.665824 [DEBUG] 
    switch_core_state_machine.c:398<BR>(OpenZAP/1:1/5384) Running State Change 
    CS_INIT<BR>2009-11-02 09:06:01.665824 [DEBUG] 
    switch_core_state_machine.c:481<BR>(OpenZAP/1:1/5384) State 
    INIT<BR>2009-11-02 09:06:01.665824 [DEBUG] mod_openzap.c:368 
    (OpenZAP/1:1/5384)<BR>State Change CS_INIT -&gt; CS_ROUTING<BR>2009-11-02 
    09:06:01.665824 [DEBUG] switch_core_session.c:932 Send 
    signal<BR>OpenZAP/1:1/5384 [BREAK]<BR>2009-11-02 09:06:01.665824 [DEBUG] 
    switch_core_state_machine.c:481<BR>(OpenZAP/1:1/5384) State INIT going to 
    sleep<BR>2009-11-02 09:06:01.665824 [DEBUG] 
    switch_core_state_machine.c:398<BR>(OpenZAP/1:1/5384) Running State Change 
    CS_ROUTING<BR>2009-11-02 09:06:01.665824 [DEBUG] 
    switch_core_state_machine.c:484<BR>(OpenZAP/1:1/5384) State 
    ROUTING<BR>2009-11-02 09:06:01.665824 [DEBUG] mod_openzap.c:391 
    OpenZAP/1:1/5384<BR>CHANNEL ROUTING<BR>2009-11-02 09:06:01.665824 [DEBUG] 
    switch_core_state_machine.c:78<BR>OpenZAP/1:1/5384 Standard 
    ROUTING<BR>2009-11-02 09:06:01.665824 [INFO] mod_dialplan_xml.c:315 
    Processing<BR>4253813176-&gt;5384 in context default<BR>Dialplan: 
    OpenZAP/1:1/5384 parsing [default-&gt;unloop] continue=false<BR>Dialplan: 
    OpenZAP/1:1/5384 Regex (PASS) [unloop] ${unroll_loops}(true) =~<BR>/^true$/ 
    break=on-false<BR>Dialplan: OpenZAP/1:1/5384 Regex (FAIL) [unloop] 
    ${sip_looped_call}() =~<BR>/^true$/ break=on-false<BR>Dialplan: 
    OpenZAP/1:1/5384 parsing [default-&gt;tod_example] 
    continue=true<BR>Dialplan: OpenZAP/1:1/5384 Absolute Condition 
    [tod_example]<BR>Dialplan: OpenZAP/1:1/5384 Action 
    set(open=true)<BR>Dialplan: OpenZAP/1:1/5384 parsing 
    [default-&gt;SangomaPRI] continue=false<BR>Dialplan: OpenZAP/1:1/5384 Regex 
    (FAIL) [SangomaPRI]<BR>destination_number(5384) =~ /^9(\d+)$/ 
    break=on-false<BR>Dialplan: OpenZAP/1:1/5384 parsing 
    [default-&gt;global-intercept]<BR>continue=false<BR>Dialplan: 
    OpenZAP/1:1/5384 Regex (FAIL) [global-intercept]<BR>destination_number(5384) 
    =~ /^(5380)$/ break=on-false<BR>Dialplan: OpenZAP/1:1/5384 parsing 
    [default-&gt;group-intercept] continue=false<BR>Dialplan: OpenZAP/1:1/5384 
    Regex (FAIL) [group-intercept]<BR>destination_number(5384) =~ /^\*8$/ 
    break=on-false<BR>Dialplan: OpenZAP/1:1/5384 parsing 
    [default-&gt;intercept-ext] continue=false<BR>Dialplan: OpenZAP/1:1/5384 
    Regex (FAIL) [intercept-ext]<BR>destination_number(5384) =~ /^\*\*(\d+)$/ 
    break=on-false<BR>Dialplan: OpenZAP/1:1/5384 parsing [default-&gt;redial] 
    continue=false<BR>Dialplan: OpenZAP/1:1/5384 Regex (FAIL) [redial] 
    destination_number(5384) =~<BR>/^870$/ break=on-false<BR>Dialplan: 
    OpenZAP/1:1/5384 parsing [default-&gt;global] continue=true<BR>Dialplan: 
    OpenZAP/1:1/5384 Regex (FAIL) [global] ${call_debug}(false) =~<BR>/^true$/ 
    break=never<BR>Dialplan: OpenZAP/1:1/5384 Regex (FAIL) [global] 
    ${sip_has_crypto}() 
    =~<BR>/^(AES_CM_128_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_80)$/ 
    break=never<BR>Dialplan: OpenZAP/1:1/5384 Absolute Condition 
    [global]<BR>Dialplan: OpenZAP/1:1/5384 
    Action<BR>hash(insert/${domain_name}-spymap/${caller_id_number}/${uuid})<BR>Dialplan: 
    OpenZAP/1:1/5384 
    Action<BR>hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_numbe<BR>r})<BR>Dialplan: 
    OpenZAP/1:1/5384 
    Action<BR>hash(insert/${domain_name}-last_dial/global/${uuid})<BR>Dialplan: 
    OpenZAP/1:1/5384 parsing [default-&gt;snom-demo-2] 
    continue=false<BR>Dialplan: OpenZAP/1:1/5384 Regex (FAIL) 
    [snom-demo-2]<BR>destination_number(5384) =~ /^9001$/ 
    break=on-false<BR>Dialplan: OpenZAP/1:1/5384 parsing 
    [default-&gt;snom-demo-1] continue=false<BR>Dialplan: OpenZAP/1:1/5384 Regex 
    (FAIL) [snom-demo-1]<BR>destination_number(5384) =~ /^9000$/ 
    break=on-false<BR>Dialplan: OpenZAP/1:1/5384 parsing [default-&gt;eavesdrop] 
    continue=false<BR>Dialplan: OpenZAP/1:1/5384 Regex (FAIL) [eavesdrop] 
    destination_number(5384)<BR>=~ /^88(.*)$|^\*0(.*)$/ 
    break=on-false<BR>Dialplan: OpenZAP/1:1/5384 parsing [default-&gt;eavesdrop] 
    continue=false<BR>Dialplan: OpenZAP/1:1/5384 Regex (FAIL) [eavesdrop] 
    destination_number(5384)<BR>=~ /^779$/ break=on-false<BR>Dialplan: 
    OpenZAP/1:1/5384 parsing [default-&gt;call_return] 
    continue=false<BR>Dialplan: OpenZAP/1:1/5384 Regex (FAIL) 
    [call_return]<BR>destination_number(5384) =~ /^\*69$|^869$|^lcr$/ 
    break=on-false<BR>Dialplan: OpenZAP/1:1/5384 parsing [default-&gt;del-group] 
    continue=false<BR>Dialplan: OpenZAP/1:1/5384 Regex (FAIL) [del-group] 
    destination_number(5384)<BR>=~ /^80(\d{2})$/ break=on-false<BR>Dialplan: 
    OpenZAP/1:1/5384 parsing [default-&gt;add-group] continue=false<BR>Dialplan: 
    OpenZAP/1:1/5384 Regex (FAIL) [add-group] destination_number(5384)<BR>=~ 
    /^81(\d{2})$/ break=on-false<BR>Dialplan: OpenZAP/1:1/5384 parsing 
    [default-&gt;call-group-simo] continue=false<BR>Dialplan: OpenZAP/1:1/5384 
    Regex (FAIL) [call-group-simo]<BR>destination_number(5384) =~ /^82(\d{2})$/ 
    break=on-false<BR>Dialplan: OpenZAP/1:1/5384 parsing 
    [default-&gt;call-group-order]<BR>continue=false<BR>Dialplan: 
    OpenZAP/1:1/5384 Regex (FAIL) [call-group-order]<BR>destination_number(5384) 
    =~ /^83(\d{2})$/ break=on-false<BR>Dialplan: OpenZAP/1:1/5384 parsing 
    [default-&gt;extension-intercom]<BR>continue=false<BR>Dialplan: 
    OpenZAP/1:1/5384 Regex (FAIL) 
    [extension-intercom]<BR>destination_number(5384) =~ /^8(5[34][8901][0-9])$/ 
    break=on-false<BR>Dialplan: OpenZAP/1:1/5384 parsing 
    [default-&gt;Local_Extension] continue=false<BR>Dialplan: OpenZAP/1:1/5384 
    Regex (PASS) [Local_Extension]<BR>destination_number(5384) =~ 
    /^(5[34][8901][0-9])$/ break=on-false<BR>Dialplan: OpenZAP/1:1/5384 Action 
    set(dialed_extension=5384)<BR>Dialplan: OpenZAP/1:1/5384 Action 
    export(dialed_extension=5384)<BR>Dialplan: OpenZAP/1:1/5384 Action 
    bind_meta_app(1 b s execute_extension::dx<BR>XML features)<BR>Dialplan: 
    OpenZAP/1:1/5384 Action bind_meta_app(2 b 
    s<BR>record_session::/usr/local/freeswitch/recordings/${caller_id_number}.${strft<BR>ime(%Y-%m-%d-%H-%M-%S)}.wav)<BR>Dialplan: 
    OpenZAP/1:1/5384 Action bind_meta_app(3 b s execute_extension::cf<BR>XML 
    features)<BR>Dialplan: OpenZAP/1:1/5384 Action 
    set(ringback=${us-ring})<BR>Dialplan: OpenZAP/1:1/5384 Action 
    set(transfer_ringback=local_stream://moh)<BR>Dialplan: OpenZAP/1:1/5384 
    Action set(call_timeout=30)<BR>Dialplan: OpenZAP/1:1/5384 Action 
    set(hangup_after_bridge=true)<BR>Dialplan: OpenZAP/1:1/5384 Action 
    set(continue_on_fail=true)<BR>Dialplan: OpenZAP/1:1/5384 
    Action<BR>hash(insert/${domain_name}-call_return/${dialed_extension}/${caller_id_numbe<BR>r})<BR>Dialplan: 
    OpenZAP/1:1/5384 
    Action<BR>hash(insert/${domain_name}-last_dial_ext/${dialed_extension}/${uuid})<BR>Dialplan: 
    OpenZAP/1:1/5384 
    Action<BR>set(called_party_callgroup=${user_data(${dialed_extension}@${domain_name}<BR>var 
    callgroup)})<BR>Dialplan: OpenZAP/1:1/5384 
    Action<BR>hash(insert/${domain_name}-last_dial/${called_party_callgroup}/${uuid})<BR>Dialplan: 
    OpenZAP/1:1/5384 
    Action<BR>bridge(user/${dialed_extension}@${domain_name})<BR>Dialplan: 
    OpenZAP/1:1/5384 Action answer()<BR>Dialplan: OpenZAP/1:1/5384 Action 
    sleep(1000)<BR>Dialplan: OpenZAP/1:1/5384 Action voicemail(default 
    ${domain_name}<BR>${dialed_extension})<BR>2009-11-02 09:06:01.666685 [DEBUG] 
    switch_core_state_machine.c:114<BR>(OpenZAP/1:1/5384) State Change 
    CS_ROUTING -&gt; CS_EXECUTE<BR>2009-11-02 09:06:01.666685 [DEBUG] 
    switch_core_session.c:932 Send signal<BR>OpenZAP/1:1/5384 
    [BREAK]<BR>2009-11-02 09:06:01.666685 [DEBUG] 
    switch_core_state_machine.c:484<BR>(OpenZAP/1:1/5384) State ROUTING going to 
    sleep<BR>2009-11-02 09:06:01.666685 [DEBUG] 
    switch_core_state_machine.c:398<BR>(OpenZAP/1:1/5384) Running State Change 
    CS_EXECUTE<BR>2009-11-02 09:06:01.666685 [DEBUG] 
    switch_core_state_machine.c:491<BR>(OpenZAP/1:1/5384) State 
    EXECUTE<BR>2009-11-02 09:06:01.666685 [DEBUG] mod_openzap.c:408 
    OpenZAP/1:1/5384<BR>CHANNEL EXECUTE<BR>2009-11-02 09:06:01.666685 [DEBUG] 
    switch_core_state_machine.c:151<BR>OpenZAP/1:1/5384 Standard 
    EXECUTE<BR>EXECUTE OpenZAP/1:1/5384 set(open=true)<BR>2009-11-02 
    09:06:01.666685 [DEBUG] mod_dptools.c:748 OpenZAP/1:1/5384 
    SET<BR>[open]=[true]<BR>EXECUTE 
    OpenZAP/1:1/5384<BR>hash(insert/192.168.72.141-spymap/4253813176/b678f311-ab74-4cc1-afac-b83d89a<BR>53132)<BR>EXECUTE 
    OpenZAP/1:1/5384<BR>hash(insert/192.168.72.141-last_dial/4253813176/5384)<BR>EXECUTE 
    OpenZAP/1:1/5384<BR>hash(insert/192.168.72.141-last_dial/global/b678f311-ab74-4cc1-afac-b83d89a5<BR>3132)<BR>EXECUTE 
    OpenZAP/1:1/5384 set(dialed_extension=5384)<BR>2009-11-02 09:06:01.667682 
    [DEBUG] mod_dptools.c:748 OpenZAP/1:1/5384 
    SET<BR>[dialed_extension]=[5384]<BR>EXECUTE OpenZAP/1:1/5384 
    export(dialed_extension=5384)<BR>2009-11-02 09:06:01.667682 [DEBUG] 
    mod_dptools.c:886 EXPORT<BR>[dialed_extension]=[5384]<BR>EXECUTE 
    OpenZAP/1:1/5384 bind_meta_app(1 b s execute_extension::dx 
    XML<BR>features)<BR>2009-11-02 09:06:01.667682 [INFO] 
    switch_ivr_async.c:1795 Bound B-Leg: 1<BR>execute_extension::dx XML 
    features<BR>EXECUTE OpenZAP/1:1/5384 bind_meta_app(2 b 
    s<BR>record_session::/usr/local/freeswitch/recordings/4253813176.2009-11-02-09-06<BR>-01.wav)<BR>2009-11-02 
    09:06:01.668708 [INFO] switch_ivr_async.c:1795 Bound B-Leg: 
    2<BR>record_session::/usr/local/freeswitch/recordings/4253813176.2009-11-02-09-06<BR>-01.wav<BR>EXECUTE 
    OpenZAP/1:1/5384 bind_meta_app(3 b s execute_extension::cf 
    XML<BR>features)<BR>2009-11-02 09:06:01.668708 [INFO] 
    switch_ivr_async.c:1795 Bound B-Leg: 3<BR>execute_extension::cf XML 
    features<BR>EXECUTE OpenZAP/1:1/5384 
    set(ringback=%(2000,4000,440.0,480.0))<BR>2009-11-02 09:06:01.668708 [DEBUG] 
    mod_dptools.c:748 OpenZAP/1:1/5384 
    SET<BR>[ringback]=[%(2000,4000,440.0,480.0)]<BR>EXECUTE OpenZAP/1:1/5384 
    set(transfer_ringback=local_stream://moh)<BR>2009-11-02 09:06:01.668708 
    [DEBUG] mod_dptools.c:748 OpenZAP/1:1/5384 
    SET<BR>[transfer_ringback]=[local_stream://moh]<BR>EXECUTE OpenZAP/1:1/5384 
    set(call_timeout=30)<BR>2009-11-02 09:06:01.668708 [DEBUG] mod_dptools.c:748 
    OpenZAP/1:1/5384 SET<BR>[call_timeout]=[30]<BR>EXECUTE OpenZAP/1:1/5384 
    set(hangup_after_bridge=true)<BR>2009-11-02 09:06:01.669681 [DEBUG] 
    mod_dptools.c:748 OpenZAP/1:1/5384 
    SET<BR>[hangup_after_bridge]=[true]<BR>EXECUTE OpenZAP/1:1/5384 
    set(continue_on_fail=true)<BR>2009-11-02 09:06:01.669681 [DEBUG] 
    mod_dptools.c:748 OpenZAP/1:1/5384 
    SET<BR>[continue_on_fail]=[true]<BR>EXECUTE 
    OpenZAP/1:1/5384<BR>hash(insert/192.168.72.141-call_return/5384/4253813176)<BR>EXECUTE 
    OpenZAP/1:1/5384<BR>hash(insert/192.168.72.141-last_dial_ext/5384/b678f311-ab74-4cc1-afac-b83d89<BR>a53132)<BR>EXECUTE 
    OpenZAP/1:1/5384 set(called_party_callgroup=techsupport)<BR>2009-11-02 
    09:06:01.670679 [DEBUG] mod_dptools.c:748 OpenZAP/1:1/5384 
    SET<BR>[called_party_callgroup]=[techsupport]<BR>EXECUTE 
    OpenZAP/1:1/5384<BR>hash(insert/192.168.72.141-last_dial/techsupport/b678f311-ab74-4cc1-afac-b83<BR>d89a53132)<BR>EXECUTE 
    OpenZAP/1:1/5384 bridge(user/<A 
    href="mailto:5384@192.168.72.141">5384@192.168.72.141</A>)<BR>2009-11-02 
    09:06:01.671683 [DEBUG] switch_ivr_originate.c:1027 variable<BR>string 0 = 
    [presence_id=<A 
    href="mailto:5384@192.168.72.141">5384@192.168.72.141</A>]<BR>2009-11-02 
    09:06:01.671683 [NOTICE] switch_channel.c:602 New 
    Channel<BR>sofia/internal/<A href="http://sip:5384@192.168.72.163:5060" 
    target=_blank>sip:5384@192.168.72.163:5060</A><BR>[9e7b8fae-6194-430c-951b-948ebd2c2a3b]<BR>2009-11-02 
    09:06:01.671683 [DEBUG] mod_sofia.c:2811<BR>(sofia/internal/<A 
    href="http://sip:5384@192.168.72.163:5060" 
    target=_blank>sip:5384@192.168.72.163:5060</A>) State Change CS_NEW -&gt; 
    CS_INIT<BR>2009-11-02 09:06:01.672688 [DEBUG] switch_core_session.c:932 Send 
    signal<BR>sofia/internal/<A href="http://sip:5384@192.168.72.163:5060" 
    target=_blank>sip:5384@192.168.72.163:5060</A> [BREAK]<BR>2009-11-02 
    09:06:01.672688 [DEBUG] 
    switch_core_state_machine.c:398<BR>(sofia/internal/<A 
    href="http://sip:5384@192.168.72.163:5060" 
    target=_blank>sip:5384@192.168.72.163:5060</A>) Running State Change 
    CS_INIT<BR>2009-11-02 09:06:01.672688 [DEBUG] 
    switch_core_state_machine.c:481<BR>(sofia/internal/<A 
    href="http://sip:5384@192.168.72.163:5060" 
    target=_blank>sip:5384@192.168.72.163:5060</A>) State INIT<BR>2009-11-02 
    09:06:01.672688 [DEBUG] mod_sofia.c:83<BR>sofia/internal/<A 
    href="http://sip:5384@192.168.72.163:5060" 
    target=_blank>sip:5384@192.168.72.163:5060</A> SOFIA INIT<BR>2009-11-02 
    09:06:01.672688 [DEBUG] mod_sofia.c:111<BR>(sofia/internal/<A 
    href="http://sip:5384@192.168.72.163:5060" 
    target=_blank>sip:5384@192.168.72.163:5060</A>) State Change CS_INIT 
    -&gt;<BR>CS_ROUTING<BR>2009-11-02 09:06:01.672688 [DEBUG] 
    switch_core_session.c:932 Send signal<BR>sofia/internal/<A 
    href="http://sip:5384@192.168.72.163:5060" 
    target=_blank>sip:5384@192.168.72.163:5060</A> [BREAK]<BR>2009-11-02 
    09:06:01.672688 [DEBUG] 
    switch_core_state_machine.c:481<BR>(sofia/internal/<A 
    href="http://sip:5384@192.168.72.163:5060" 
    target=_blank>sip:5384@192.168.72.163:5060</A>) State INIT going to 
    sleep<BR>2009-11-02 09:06:01.672688 [DEBUG] 
    switch_core_state_machine.c:398<BR>(sofia/internal/<A 
    href="http://sip:5384@192.168.72.163:5060" 
    target=_blank>sip:5384@192.168.72.163:5060</A>) Running State 
    Change<BR>CS_ROUTING<BR>2009-11-02 09:06:01.672688 [DEBUG] 
    switch_core_state_machine.c:484<BR>(sofia/internal/<A 
    href="http://sip:5384@192.168.72.163:5060" 
    target=_blank>sip:5384@192.168.72.163:5060</A>) State ROUTING<BR>2009-11-02 
    09:06:01.672688 [DEBUG] mod_sofia.c:130<BR>sofia/internal/<A 
    href="http://sip:5384@192.168.72.163:5060" 
    target=_blank>sip:5384@192.168.72.163:5060</A> SOFIA ROUTING<BR>2009-11-02 
    09:06:01.672688 [DEBUG] switch_ivr_originate.c:63<BR>(sofia/internal/<A 
    href="http://sip:5384@192.168.72.163:5060" 
    target=_blank>sip:5384@192.168.72.163:5060</A>) State Change CS_ROUTING 
    -&gt;<BR>CS_CONSUME_MEDIA<BR>2009-11-02 09:06:01.672688 [DEBUG] 
    switch_core_session.c:932 Send signal<BR>sofia/internal/<A 
    href="http://sip:5384@192.168.72.163:5060" 
    target=_blank>sip:5384@192.168.72.163:5060</A> [BREAK]<BR>2009-11-02 
    09:06:01.672688 [DEBUG] 
    switch_core_state_machine.c:484<BR>(sofia/internal/<A 
    href="http://sip:5384@192.168.72.163:5060" 
    target=_blank>sip:5384@192.168.72.163:5060</A>) State ROUTING going to 
    sleep<BR>2009-11-02 09:06:01.672688 [DEBUG] 
    switch_core_state_machine.c:398<BR>(sofia/internal/<A 
    href="http://sip:5384@192.168.72.163:5060" 
    target=_blank>sip:5384@192.168.72.163:5060</A>) Running State 
    Change<BR>CS_CONSUME_MEDIA<BR>2009-11-02 09:06:01.672688 [DEBUG] 
    sofia.c:3289 Channel<BR>sofia/internal/<A 
    href="http://sip:5384@192.168.72.163:5060" 
    target=_blank>sip:5384@192.168.72.163:5060</A> entering state 
    [calling][0]<BR>2009-11-02 09:06:01.672688 [DEBUG] 
    switch_core_state_machine.c:503<BR>(sofia/internal/<A 
    href="http://sip:5384@192.168.72.163:5060" 
    target=_blank>sip:5384@192.168.72.163:5060</A>) State 
    CONSUME_MEDIA<BR>2009-11-02 09:06:01.672688 [DEBUG] 
    switch_ivr_originate.c:1701<BR>OpenZAP/1:1/5384 receive message 
    [PROGRESS]<BR>2009-11-02 09:06:01.673742 [DEBUG] mod_openzap.c:759 Changing 
    state on 1:1<BR>from RING to PROGRESS<BR>2009-11-02 09:06:01.674787 [DEBUG] 
    ozmod_ss7_boost.c:841 1:1 STATE<BR>[PROGRESS]<BR>2009-11-02 09:06:01.675844 
    [WARNING] ss7_boost_client.c:218 TX EVENT (N):<BR>CALL_START_ACK:(81) [w1g1] 
    Rc=0 CSid=0 Seq=11<BR>2009-11-02 09:06:01.684776 [WARNING] mod_openzap.c:761 
    VETO Changing state<BR>on 1:1 from PROGRESS to PROGRESS_MEDIA<BR>2009-11-02 
    09:06:01.684776 [DEBUG] switch_core_session.c:630 Send 
    signal<BR>OpenZAP/1:1/5384 [BREAK]<BR>2009-11-02 09:06:01.684776 [NOTICE] 
    switch_ivr_originate.c:1701 Pre-Answer<BR>OpenZAP/1:1/5384!<BR>2009-11-02 
    09:06:01.684776 [DEBUG] switch_ivr_originate.c:1718 Raw Codec<BR>Activation 
    Success L16@8000hz 1 channel 20ms<BR>2009-11-02 09:06:01.684776 [DEBUG] 
    switch_ivr_originate.c:1777 Play Ringback<BR>Tone 
    [%(2000,4000,440.0,480.0)]<BR>2009-11-02 09:06:01.693835 [DEBUG] 
    sofia.c:3289 Channel<BR>sofia/internal/<A 
    href="http://sip:5384@192.168.72.163:5060" 
    target=_blank>sip:5384@192.168.72.163:5060</A> entering state 
    [proceeding][180]<BR>2009-11-02 09:06:01.693835 [NOTICE] sofia.c:3353 
    Ring-Ready<BR>sofia/internal/<A href="http://sip:5384@192.168.72.163:5060" 
    target=_blank>sip:5384@192.168.72.163:5060</A>!<BR>2009-11-02 
    09:06:01.705777 [DEBUG] switch_core_io.c:649 OpenZAP/1:1/5384<BR>receive 
    message [TRANSCODING_NECESSARY]<BR><BR><A 
    href="mailto:freeswitch@TeoProxy.greyhawk.tonecommander.com">freeswitch@TeoProxy.greyhawk.tonecommander.com</A>&gt;<BR><A 
    href="mailto:freeswitch@TeoProxy.greyhawk.tonecommander.com">freeswitch@TeoProxy.greyhawk.tonecommander.com</A>&gt;<BR><A 
    href="mailto:freeswitch@TeoProxy.greyhawk.tonecommander.com">freeswitch@TeoProxy.greyhawk.tonecommander.com</A>&gt;<BR><A 
    href="mailto:freeswitch@TeoProxy.greyhawk.tonecommander.com">freeswitch@TeoProxy.greyhawk.tonecommander.com</A>&gt;<BR><A 
    href="mailto:freeswitch@TeoProxy.greyhawk.tonecommander.com">freeswitch@TeoProxy.greyhawk.tonecommander.com</A>&gt;<BR><A 
    href="mailto:freeswitch@TeoProxy.greyhawk.tonecommander.com">freeswitch@TeoProxy.greyhawk.tonecommander.com</A>&gt;<BR><A 
    href="mailto:freeswitch@TeoProxy.greyhawk.tonecommander.com">freeswitch@TeoProxy.greyhawk.tonecommander.com</A>&gt;<BR><A 
    href="mailto:freeswitch@TeoProxy.greyhawk.tonecommander.com">freeswitch@TeoProxy.greyhawk.tonecommander.com</A>&gt;<BR><A 
    href="mailto:freeswitch@TeoProxy.greyhawk.tonecommander.com">freeswitch@TeoProxy.greyhawk.tonecommander.com</A>&gt;<BR><A 
    href="mailto:freeswitch@TeoProxy.greyhawk.tonecommander.com">freeswitch@TeoProxy.greyhawk.tonecommander.com</A>&gt;<BR><A 
    href="mailto:freeswitch@TeoProxy.greyhawk.tonecommander.com">freeswitch@TeoProxy.greyhawk.tonecommander.com</A>&gt;<BR><BR><BR>Best 
    Regards,<BR>Jerry<BR><BR><BR>_______________________________________________<BR>FreeSWITCH-users 
    mailing list<BR><A 
    href="mailto:FreeSWITCH-users@lists.freeswitch.org">FreeSWITCH-users@lists.freeswitch.org</A><BR><A 
    href="http://lists.freeswitch.org/mailman/listinfo/freeswitch-users" 
    target=_blank>http://lists.freeswitch.org/mailman/listinfo/freeswitch-users</A><BR>UNSUBSCRIBE:<A 
    href="http://lists.freeswitch.org/mailman/options/freeswitch-users" 
    target=_blank>http://lists.freeswitch.org/mailman/options/freeswitch-users</A><BR><A 
    href="http://www.freeswitch.org" 
    target=_blank>http://www.freeswitch.org</A><BR></BLOCKQUOTE></DIV><BR><BR 
  clear=all><BR>-- <BR>Anthony Minessale II<BR><BR>FreeSWITCH <A 
  href="http://www.freeswitch.org/">http://www.freeswitch.org/</A><BR>ClueCon <A 
  href="http://www.cluecon.com/">http://www.cluecon.com/</A><BR>Twitter: <A 
  href="http://twitter.com/FreeSWITCH_wire">http://twitter.com/FreeSWITCH_wire</A><BR><BR>AIM: 
  anthm<BR><A 
  href="mailto:MSN%3Aanthony_minessale@hotmail.com">MSN:anthony_minessale@hotmail.com</A><BR>GTALK/JABBER/<A 
  href="mailto:PAYPAL%3Aanthony.minessale@gmail.com">PAYPAL:anthony.minessale@gmail.com</A><BR>IRC: 
  <A href="http://irc.freenode.net">irc.freenode.net</A> 
  #freeswitch<BR><BR>FreeSWITCH Developer Conference<BR><A 
  href="mailto:sip%3A888@conference.freeswitch.org">sip:888@conference.freeswitch.org</A><BR><A 
  href="http://iax:guest@conference.freeswitch.org/888">iax:guest@conference.freeswitch.org/888</A><BR><A 
  href="mailto:googletalk%3Aconf%2B888@conference.freeswitch.org">googletalk:conf+888@conference.freeswitch.org</A><BR>pstn:213-799-1400<BR></BLOCKQUOTE></BODY></HTML>