<html><body style="word-wrap: break-word; -webkit-nbsp-mode: space; -webkit-line-break: after-white-space; "><div> <!--<param name="apply-nat-acl" value="rfc1918"/>--> </div><div> <!--<param name="aggressive-nat-detection" value="true"/>--></div><div><br></div><div>Comment out those two lines in internal.xml, clear your sofia_* from the db directory in /usr/local/freeswitch/db</div><div><br></div><div>Restart FS and try again.</div><div><br></div><div>/b</div><div><br></div><div><div>On Oct 10, 2008, at 12:41 PM, gary wrote:</div><br class="Apple-interchange-newline"><blockquote type="cite"><span class="Apple-style-span" style="border-collapse: separate; color: rgb(0, 0, 0); font-family: Helvetica; font-size: 12px; font-style: normal; font-variant: normal; font-weight: normal; letter-spacing: normal; line-height: normal; orphans: 2; text-align: auto; text-indent: 0px; text-transform: none; white-space: normal; widows: 2; word-spacing: 0px; -webkit-border-horizontal-spacing: 0px; -webkit-border-vertical-spacing: 0px; -webkit-text-decorations-in-effect: none; -webkit-text-size-adjust: auto; -webkit-text-stroke-width: 0; "><div bgcolor="#ffffff" style="word-wrap: break-word; -webkit-nbsp-mode: space; -webkit-line-break: after-white-space; "><div><font face="Arial" size="2">Here is the debug info after press F8:</font></div><div><font face="Arial" size="2"></font> </div><div><font face="Arial" size="2">2008-10-10 13:33:00 [DEBUG] sofia.c:3134 sofia_handle_sip_i_invite() IP 10.1.1.129 Rejected by acl domains. Falling back to Digest auth.<br>2008-10-10 13:33:00 [DEBUG] sofia.c:3134 sofia_handle_sip_i_invite() IP 10.1.1.129 Rejected by acl domains. Falling back to Digest auth.<br>2008-10-10 13:33:00 [NOTICE] switch_channel.c:534 switch_channel_set_name() New Channel<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>[41067ebd-0e4a-46e2-942c-f2a953819333]<br>2008-10-10 13:33:00 [DEBUG] sofia.c:3624 sofia_handle_sip_i_invite() Setting NAT mode based on via port<br>2008-10-10 13:33:00 [DEBUG] sofia.c:2129 sofia_handle_sip_i_state() Channel<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>entering state [received]<br>2008-10-10 13:33:00 [DEBUG] sofia.c:2133 sofia_handle_sip_i_state() Remote SDP:<br>v=0<br>o=Cisco-SIPUA 11819 0 IN IP4 10.1.1.129<br>s=SIP Call<br>t=0 0<br>m=audio 23142 RTP/AVP 0 8 18 101<br>c=IN IP4 10.1.1.129<br>a=rtpmap:0 PCMU/8000<br>a=rtpmap:8 PCMA/8000<br>a=rtpmap:18 G729/8000<br>a=fmtp:18 annexb=no<br>a=rtpmap:101 telephone-event/8000<br>a=fmtp:101 0-15</font></div><div> </div><div><font face="Arial" size="2">2008-10-10 13:33:00 [DEBUG] sofia_glue.c:2280 sofia_glue_negotiate_sdp() Audio Codec Compare [PCMU:0:8000]/[G722:9:8000]<br>2008-10-10 13:33:00 [DEBUG] sofia_glue.c:2280 sofia_glue_negotiate_sdp() Audio Codec Compare [PCMU:0:8000]/[PCMU:0:8000]<br>2008-10-10 13:33:00 [DEBUG] sofia_glue.c:1530 sofia_glue_tech_set_codec() Set Codec<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>PCMU/8000 20 ms 160 samples<br>2008-10-10 13:33:00 [DEBUG] sofia_glue.c:2243 sofia_glue_negotiate_sdp() Set 2833 dtmf payload to 101<br>2008-10-10 13:33:00 [DEBUG] sofia.c:2270 sofia_handle_sip_i_state()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>State Change CS_NEW -> CS_INIT<br>2008-10-10 13:33:00 [DEBUG] switch_core_session.c:722 switch_core_session_signal_state_change() Kill<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>[BREAK]<br>2008-10-10 13:33:00 [DEBUG] switch_core_state_machine.c:365 switch_core_session_run()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>Running State Change CS_INIT<br>2008-10-10 13:33:00 [DEBUG] switch_core_state_machine.c:415 switch_core_session_run() (<a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a>) State INIT<br>2008-10-10 13:33:00 [DEBUG] mod_sofia.c:80 sofia_on_init()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>SOFIA INIT<br>2008-10-10 13:33:00 [DEBUG] mod_sofia.c:107 sofia_on_init()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>State Change CS_INIT -> CS_ROUTING<br>2008-10-10 13:33:00 [DEBUG] switch_core_session.c:722 switch_core_session_signal_state_change() Kill<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>[BREAK]<br>2008-10-10 13:33:00 [DEBUG] switch_core_state_machine.c:415 switch_core_session_run() (<a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a>) State INIT going to sleep<br>2008-10-10 13:33:00 [DEBUG] switch_core_state_machine.c:365 switch_core_session_run()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>Running State Change CS_ROUTING<br>2008-10-10 13:33:00 [DEBUG] switch_core_state_machine.c:420 switch_core_session_run() (<a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a>) State ROUTING<br>2008-10-10 13:33:00 [DEBUG] mod_sofia.c:119 sofia_on_routing()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>SOFIA ROUTING<br>2008-10-10 13:33:00 [DEBUG] switch_core_state_machine.c:64 switch_core_standard_on_routing() Standard ROUTING<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><br>2008-10-10 13:33:00 [INFO] mod_dialplan_xml.c:222 dialplan_hunt() Processing Line1->1001@default<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test conditions ${unroll_loops}(true) =~ /^true$/<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test conditions ${sip_looped_call}() =~ /^true$/<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:109 parse_exten() Regex mismatch<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test conditions ${strftime(%H%M)}(1333) =~ /^((09|1[0-7])[0-5][0-9]|1800)$/<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test conditions destination_number(1001) =~ /^886$/<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:109 parse_exten() Regex mismatch<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test conditions destination_number(1001) =~ /^\*\*(\d+)$/<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:109 parse_exten() Regex mismatch<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test conditions destination_number(1001) =~ /^870$/<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:109 parse_exten() Regex mismatch<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test conditions ${network_addr}(10.1.1.129) =~ /^$/<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:109 parse_exten() Regex mismatch<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test conditions ${numbering_plan}() =~ /^$/<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test conditions ${call_debug}(false) =~ /^true$/<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:109 parse_exten() Regex mismatch<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test conditions ${sip_has_crypto}() =~ /^(AES_CM_128_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_80)$/<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:109 parse_exten() Regex mismatch<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test conditions destination_number(1001) =~ /^9001$/<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:109 parse_exten() Regex mismatch<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test conditions destination_number(1001) =~ /^9000$/<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:109 parse_exten() Regex mismatch<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test conditions destination_number(1001) =~ /^88(.*)$|^\*0(.*)$/<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:109 parse_exten() Regex mismatch<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test conditions destination_number(1001) =~ /^779$/<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:109 parse_exten() Regex mismatch<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test conditions destination_number(1001) =~ /^\*69$|^869$/<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:109 parse_exten() Regex mismatch<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test conditions destination_number(1001) =~ /^80(\d{2})$/<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:109 parse_exten() Regex mismatch<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test conditions destination_number(1001) =~ /^81(\d{2})$/<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:109 parse_exten() Regex mismatch<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test conditions destination_number(1001) =~ /^82(\d{2})$/<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:109 parse_exten() Regex mismatch<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test conditions destination_number(1001) =~ /^83(\d{2})$/<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:109 parse_exten() Regex mismatch<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test conditions destination_number(1001) =~ /^8(10[01][0-9])$/<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:109 parse_exten() Regex mismatch<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test conditions destination_number(1001) =~ /^(10[01][0-9])$/<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test conditions destination_number(1001) =~ /^1007$/<br>2008-10-10 13:33:00 [DEBUG] mod_dialplan_xml.c:109 parse_exten() Regex mismatch<br>2008-10-10 13:33:00 [DEBUG] switch_core_state_machine.c:97 switch_core_standard_on_routing()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>State Change CS_ROUTING -> CS_EXECUTE<br>2008-10-10 13:33:00 [DEBUG] switch_core_session.c:722 switch_core_session_signal_state_change() Kill<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>[BREAK]<br>2008-10-10 13:33:00 [DEBUG] switch_core_state_machine.c:420 switch_core_session_run() (<a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a>) State ROUTING going to sleep<br>2008-10-10 13:33:00 [DEBUG] switch_core_state_machine.c:365 switch_core_session_run()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>Running State Change CS_EXECUTE<br>2008-10-10 13:33:00 [DEBUG] switch_core_state_machine.c:430 switch_core_session_run() (<a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a>) State EXECUTE<br>2008-10-10 13:33:00 [DEBUG] mod_sofia.c:156 sofia_on_execute()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>SOFIA EXECUTE<br>2008-10-10 13:33:00 [DEBUG] switch_core_state_machine.c:129 switch_core_standard_on_execute() Standard EXECUTE<br>2008-10-10 13:33:00 [DEBUG] switch_core_state_machine.c:140 switch_core_standard_on_execute()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>Execute set(open=true)<br>2008-10-10 13:33:00 [DEBUG] mod_dptools.c:678 set_function() SET [open]=[true]<br>2008-10-10 13:33:00 [DEBUG] switch_core_state_machine.c:140 switch_core_standard_on_execute()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>Execute set(use_profile=${cond(${acl(${network_addr} rfc1918)} == true ? nat : default)})<br>2008-10-10 13:33:00 [DEBUG] switch_core_session.c:1045 switch_core_session_execute_application()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>Expanded String set(use_profile=default)<br>2008-10-10 13:33:00 [DEBUG] mod_dptools.c:678 set_function() SET [use_profile]=[default]<br>2008-10-10 13:33:00 [DEBUG] switch_core_state_machine.c:140 switch_core_standard_on_execute()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>Execute set_user(<a href="mailto:default@${domain">default@${domain</a>})<br>2008-10-10 13:33:00 [DEBUG] switch_core_session.c:1045 switch_core_session_execute_application()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>Expanded String set_user(<a href="mailto:default@10.1.1.177">default@10.1.1.177</a>)<br>2008-10-10 13:33:00 [DEBUG] switch_core_state_machine.c:140 switch_core_standard_on_execute()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>Execute db(insert/spymap/${caller_id_number}/${uuid})<br>2008-10-10 13:33:00 [DEBUG] switch_core_session.c:1045 switch_core_session_execute_application()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>Expanded String db(insert/spymap/1007/41067ebd-0e4a-46e2-942c-f2a953819333)<br>2008-10-10 13:33:00 [DEBUG] switch_core_state_machine.c:140 switch_core_standard_on_execute()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>Execute db(insert/last_dial/${caller_id_number}/${destination_number})<br>2008-10-10 13:33:00 [DEBUG] switch_core_session.c:1045 switch_core_session_execute_application()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>Expanded String db(insert/last_dial/1007/1001)<br>2008-10-10 13:33:01 [DEBUG] switch_core_state_machine.c:140 switch_core_standard_on_execute()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>Execute db(insert/last_dial/global/${uuid})<br>2008-10-10 13:33:01 [DEBUG] switch_core_session.c:1045 switch_core_session_execute_application()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>Expanded String db(insert/last_dial/global/41067ebd-0e4a-46e2-942c-f2a953819333)<br>2008-10-10 13:33:01 [DEBUG] switch_core_state_machine.c:140 switch_core_standard_on_execute()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>Execute set(dialed_ext=1001)<br>2008-10-10 13:33:01 [DEBUG] mod_dptools.c:678 set_function() SET [dialed_ext]=[1001]<br>2008-10-10 13:33:01 [DEBUG] switch_core_state_machine.c:140 switch_core_standard_on_execute()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>Execute export(dialed_ext=1001)<br>2008-10-10 13:33:01 [DEBUG] mod_dptools.c:816 export_function() EXPORT [dialed_ext]=[1001]<br>2008-10-10 13:33:01 [DEBUG] switch_core_state_machine.c:140 switch_core_standard_on_execute()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>Execute set(transfer_ringback=${us-ring})<br>2008-10-10 13:33:01 [DEBUG] switch_core_session.c:1045 switch_core_session_execute_application()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>Expanded String set(transfer_ringback=%(2000, 4000, 440.0, 480.0))<br>2008-10-10 13:33:01 [DEBUG] mod_dptools.c:678 set_function() SET [transfer_ringback]=[%(2000, 4000, 440.0, 480.0)]<br>2008-10-10 13:33:01 [DEBUG] switch_core_state_machine.c:140 switch_core_standard_on_execute()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>Execute set(call_timeout=30)<br>2008-10-10 13:33:01 [DEBUG] mod_dptools.c:678 set_function() SET [call_timeout]=[30]<br>2008-10-10 13:33:01 [DEBUG] switch_core_state_machine.c:140 switch_core_standard_on_execute()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>Execute set(hangup_after_bridge=true)<br>2008-10-10 13:33:01 [DEBUG] mod_dptools.c:678 set_function() SET [hangup_after_bridge]=[true]<br>2008-10-10 13:33:01 [DEBUG] switch_core_state_machine.c:140 switch_core_standard_on_execute()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>Execute set(continue_on_fail=true)<br>2008-10-10 13:33:01 [DEBUG] mod_dptools.c:678 set_function() SET [continue_on_fail]=[true]<br>2008-10-10 13:33:01 [DEBUG] switch_core_state_machine.c:140 switch_core_standard_on_execute()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>Execute db(insert/call_return/${dialed_ext}/${caller_id_number})<br>2008-10-10 13:33:01 [DEBUG] switch_core_session.c:1045 switch_core_session_execute_application()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>Expanded String db(insert/call_return/1001/1007)<br>2008-10-10 13:33:01 [DEBUG] switch_core_state_machine.c:140 switch_core_standard_on_execute()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>Execute db(insert/last_dial_ext/${dialed_ext}/${uuid})<br>2008-10-10 13:33:01 [DEBUG] switch_core_session.c:1045 switch_core_session_execute_application()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>Expanded String db(insert/last_dial_ext/1001/41067ebd-0e4a-46e2-942c-f2a953819333)<br>2008-10-10 13:33:02 [DEBUG] switch_core_state_machine.c:140 switch_core_standard_on_execute()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>Execute bridge(<a href="mailto:user/${dialed_ext}@10.1.1.177">user/${dialed_ext}@10.1.1.177</a>)<br>2008-10-10 13:33:02 [DEBUG] switch_core_session.c:1045 switch_core_session_execute_application()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>Expanded String bridge(<a href="mailto:user/1001@10.1.1.177">user/1001@10.1.1.177</a>)<br>2008-10-10 13:33:02 [DEBUG] switch_ivr_originate.c:652 switch_ivr_originate() variable string 0 = [<a href="mailto:presence_id=1001@10.1.1.177">presence_id=1001@10.1.1.177</a>]<br>2008-10-10 13:33:02 [DEBUG] switch_ivr_originate.c:652 switch_ivr_originate() variable string 1 = [transfer_fallback_extension=1001]<br>2008-10-10 13:33:02 [NOTICE] switch_channel.c:534 switch_channel_set_name() New Channel<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes">sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes</a><span class="Apple-converted-space"> </span>[1cd3e927-4dd5-413c-98f0-40312774ee02]<br>2008-10-10 13:33:02 [DEBUG] mod_sofia.c:2001 sofia_outgoing_channel()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes">sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes</a><span class="Apple-converted-space"> </span>State Change CS_NEW -> CS_INIT<br>2008-10-10 13:33:02 [DEBUG] switch_core_session.c:722 switch_core_session_signal_state_change() Kill<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes">sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes</a><span class="Apple-converted-space"> </span>[BREAK]<br>2008-10-10 13:33:02 [DEBUG] switch_core_state_machine.c:365 switch_core_session_run()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes">sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes</a><span class="Apple-converted-space"> </span>Running State Change CS_INIT<br>2008-10-10 13:33:02 [DEBUG] switch_core_state_machine.c:415 switch_core_session_run() (<a href="mailto:sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes">sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes</a>) State INIT<br>2008-10-10 13:33:02 [DEBUG] mod_sofia.c:80 sofia_on_init()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes">sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes</a><span class="Apple-converted-space"> </span>SOFIA INIT<br>2008-10-10 13:33:02 [DEBUG] sofia.c:197 sofia_event_callback() event [nua_i_state] status [0][INVITE sent] session:<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes">sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes</a><br>2008-10-10 13:33:02 [DEBUG] mod_sofia.c:107 sofia_on_init()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes">sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes</a><span class="Apple-converted-space"> </span>State Change CS_INIT -> CS_ROUTING<br>2008-10-10 13:33:02 [DEBUG] switch_core_session.c:722 switch_core_session_signal_state_change() Kill<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes">sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes</a><span class="Apple-converted-space"> </span>[BREAK]<br>2008-10-10 13:33:02 [DEBUG] switch_core_state_machine.c:415 switch_core_session_run() (<a href="mailto:sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes">sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes</a>) State INIT going to sleep<br>2008-10-10 13:33:02 [DEBUG] switch_core_state_machine.c:365 switch_core_session_run()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes">sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes</a><span class="Apple-converted-space"> </span>Running State Change CS_ROUTING<br>2008-10-10 13:33:02 [DEBUG] sofia.c:2129 sofia_handle_sip_i_state() Channel<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes">sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes</a><span class="Apple-converted-space"> </span>entering state [calling]<br>2008-10-10 13:33:02 [DEBUG] switch_core_state_machine.c:420 switch_core_session_run() (<a href="mailto:sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes">sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes</a>) State ROUTING<br>2008-10-10 13:33:02 [DEBUG] mod_sofia.c:119 sofia_on_routing()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes">sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes</a><span class="Apple-converted-space"> </span>SOFIA ROUTING<br>2008-10-10 13:33:02 [DEBUG] switch_ivr_originate.c:57 originate_on_routing()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes">sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes</a><span class="Apple-converted-space"> </span>State Change CS_ROUTING -> CS_CONSUME_MEDIA<br>2008-10-10 13:33:02 [DEBUG] switch_core_session.c:722 switch_core_session_signal_state_change() Kill<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes">sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes</a><span class="Apple-converted-space"> </span>[BREAK]<br>2008-10-10 13:33:02 [DEBUG] switch_core_state_machine.c:420 switch_core_session_run() (<a href="mailto:sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes">sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes</a>) State ROUTING going to sleep<br>2008-10-10 13:33:02 [DEBUG] switch_core_state_machine.c:365 switch_core_session_run()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes">sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes</a><span class="Apple-converted-space"> </span>Running State Change CS_CONSUME_MEDIA<br>2008-10-10 13:33:02 [DEBUG] switch_core_state_machine.c:442 switch_core_session_run() (<a href="mailto:sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes">sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes</a>) State CONSUME_MEDIA<br>2008-10-10 13:33:02 [DEBUG] sofia.c:197 sofia_event_callback() event [nua_r_invite] status [503][Service Unavailable] session:<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes">sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes</a><br>2008-10-10 13:33:02 [DEBUG] sofia.c:197 sofia_event_callback() event [nua_i_state] status [503][Service Unavailable] session:<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes">sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes</a><br>2008-10-10 13:33:02 [DEBUG] sofia.c:2129 sofia_handle_sip_i_state() Channel<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes">sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes</a><span class="Apple-converted-space"> </span>entering state [terminated]<br>2008-10-10 13:33:02 [NOTICE] sofia.c:2545 sofia_handle_sip_i_state() Hangup<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes">sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes</a><span class="Apple-converted-space"> </span>[CS_CONSUME_MEDIA] [NORMAL_TEMPORARY_FAILURE]<br>2008-10-10 13:33:02 [DEBUG] switch_channel.c:1361 switch_channel_perform_hangup() Kill<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes">sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes</a><span class="Apple-converted-space"> </span>[KILL]<br>2008-10-10 13:33:02 [DEBUG] switch_core_session.c:722 switch_core_session_signal_state_change() Kill<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes">sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes</a><span class="Apple-converted-space"> </span>[BREAK]<br>2008-10-10 13:33:02 [DEBUG] switch_core_state_machine.c:442 switch_core_session_run() (<a href="mailto:sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes">sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes</a>) State CONSUME_MEDIA going to sleep<br>2008-10-10 13:33:02 [DEBUG] switch_core_state_machine.c:365 switch_core_session_run()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes">sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes</a><span class="Apple-converted-space"> </span>Running State Change CS_HANGUP<br>2008-10-10 13:33:02 [DEBUG] switch_core_state_machine.c:393 switch_core_session_run() (<a href="mailto:sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes">sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes</a>) State HANGUP<br>2008-10-10 13:33:02 [DEBUG] mod_sofia.c:264 sofia_on_hangup() Channel<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes">sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes</a><span class="Apple-converted-space"> </span>hanging up, cause: NORMAL_TEMPORARY_FAILURE<br>2008-10-10 13:33:02 [DEBUG] switch_core_state_machine.c:46 switch_core_standard_on_hangup() Standard HANGUP<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes">sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes</a>, cause: NORMAL_TEMPORARY_FAILURE<br>2008-10-10 13:33:02 [DEBUG] switch_core_state_machine.c:393 switch_core_session_run() (<a href="mailto:sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes">sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes</a>) State HANGUP going to sleep<br>2008-10-10 13:33:02 [DEBUG] switch_core_session.c:789 switch_core_session_thread() Session 11 (<a href="mailto:sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes">sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes</a>) Locked, Waiting on external entities<br>2008-10-10 13:33:02 [DEBUG] switch_ivr_originate.c:1404 switch_ivr_originate() Originate Resulted in Error Cause: 41 [NORMAL_TEMPORARY_FAILURE]<br>2008-10-10 13:33:02 [NOTICE] switch_core_session.c:807 switch_core_session_thread() Session 11 (<a href="mailto:sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes">sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes</a>) Ended<br>2008-10-10 13:33:02 [NOTICE] switch_core_session.c:809 switch_core_session_thread() Close Channel<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes">sofia/internal/1001@10.1.1.117:51054;transport=udp;fs_nat=yes</a><span class="Apple-converted-space"> </span>[CS_HANGUP]<br>2008-10-10 13:33:02 [ERR] switch_ivr_originate.c:926 switch_ivr_originate() Cannot create outgoing channel of type [user] cause: [NORMAL_TEMPORARY_FAILURE]<br>2008-10-10 13:33:02 [DEBUG] switch_ivr_originate.c:1404 switch_ivr_originate() Originate Resulted in Error Cause: 41 [NORMAL_TEMPORARY_FAILURE]<br>2008-10-10 13:33:02 [INFO] mod_dptools.c:1789 audio_bridge_function() Originate Failed. Cause: NORMAL_TEMPORARY_FAILURE<br>2008-10-10 13:33:02 [DEBUG] mod_dptools.c:1810 audio_bridge_function() Continue on fail [true]: Cause: NORMAL_TEMPORARY_FAILURE<br>2008-10-10 13:33:02 [DEBUG] switch_core_state_machine.c:140 switch_core_standard_on_execute()<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a><span class="Apple-converted-space"> </span>Execute answer()<br>2008-10-10 13:33:02 [DEBUG] sofia_glue.c:1739 sofia_glue_activate_rtp() AUDIO RTP [<a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a>] 10.1.1.177 port 17974 -> 10.1.1.129 port 23142 codec: 0 ms: 20<br>2008-10-10 13:33:02 [DEBUG] switch_rtp.c:813 switch_rtp_create() Starting timer [soft] 160 bytes per 20000ms<br>2008-10-10 13:33:02 [DEBUG] mod_sofia.c:430 sofia_answer_channel() Local SDP<span class="Apple-converted-space"> </span><a href="mailto:sofia/internal/1007@10.1.1.177">sofia/internal/1007@10.1.1.177</a>:<br>v=0</font></div><div><font face="Arial" size="2"></font> </div><div><font face="Arial" size="2">Gary</font></div>_______________________________________________<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">http://lists.freeswitch.org/mailman/listinfo/freeswitch-users</a><br>UNSUBSCRIBE:<a href="http://lists.freeswitch.org/mailman/options/freeswitch-users">http://lists.freeswitch.org/mailman/options/freeswitch-users</a><br><a href="http://www.freeswitch.org">http://www.freeswitch.org</a><br></div></span></blockquote></div><br></body></html>