i monitored the line using another phone. there&#39;s indeed dialtone in all attempts.<br>i see TONE_DETECTED in the first call but i wonder there&#39;s a WARNING message immediately following [WARNING] mod_openzap.c:1196 on_fxo_signal() Unhandled type for channel 2:1.<br>


the dialtone freq should be okay since it&#39;s detected in the first call.could the WARNING message gives us a hint of a possible problem other than the dialtone freq?<br><br>okay, i&#39;ll try the SVN version next.<br>

<br><br><div class="gmail_quote">On Mon, Jan 26, 2009 at 10:18 AM, Anthony Minessale <span dir="ltr">&lt;<a href="mailto:anthony.minessale@gmail.com">anthony.minessale@gmail.com</a>&gt;</span> wrote:<br><blockquote class="gmail_quote" style="border-left: 1px solid rgb(204, 204, 204); margin: 0pt 0pt 0pt 0.8ex; padding-left: 1ex;">
<p>Its not detecting a dial tone on the failure case.<br>
Before dialing it waits until it picks up dialtone.<br>
Try the svn trunk version to see if it works any better or verify there is a dialtone on the line.</p>
<p></p><blockquote><div><div></div><div class="Wj3C7c">On Jan 25, 2009 6:19 PM, &quot;Nandy Dagondon&quot; &lt;<a href="mailto:gcd@i.ph" target="_blank">gcd@i.ph</a>&gt; wrote:<br><br>hi everybody,<br><br>i installed FS 1.0.2 to an Atom mobo (Intel D945GCLF2). it&#39;s working using IP phones, softphones and digium FXS port. but there&#39;s a problem in dialing out to PSTN using digium tdm400 fxo - it works fine on the first attempt (after starting FS) but it fails on the subsequent attempts. i tested to call using the FXS port and IP phone. same problem.<br>


<br>before i place any call,&nbsp; i checked &gt;oz dump 2 1 (show current state = DOWN, last state = DOWN)<br><br>in the first call, there&#39;s this message:<br>[WARNING] mod_openzap.c:1196 on_fxo_signal() Unhandled type for channel 2:1<br>


but <br><br>then i hangup. checked &gt;oz dump 21 (show current state=DOWN, last state=HANGUP)<br><br>in the 2nd (and subsequent) attempts, the fxo just goes off-hook but doesn&#39;t send the dtmf tones. <br>&gt;oz dump 2 1 (shows current state = DIALING, last state = DOWN)<br>


<br>has anyone encountered this problem before? i appreciate for any help to correct this problem.<br><br>tks,<br>nandy<br><br><br>Environment:<br>==================<br>kernel 2.6.18-92.1.22.el5<br>FS 1.0.2<br>zaptel 1.4.11<br>


oslec<br>digium TDM400P Rev. I (1-FXS, 2-FXO,3-4 vacant)<br><br>zaptel.conf<br>========<br>loadzone = us<br>defaultzone=us<br>channels=1-2<br>alaw=1-4<br>fxsks=2<br>fxoks=1<br><br><br>openzap.conf.xml:<br>===============<br>


&lt;configuration name=&quot;openzap.conf&quot; description=&quot;OpenZAP Configuration&quot;&gt;<br>&nbsp; &lt;settings&gt;<br>&nbsp;&nbsp;&nbsp; &lt;param name=&quot;debug&quot; value=&quot;9&quot;/&gt;<br>&nbsp;&nbsp;&nbsp; &lt;!-- &lt;param name=&quot;hold-music&quot; value=&quot;$${moh_uri}&quot;/&gt; --&gt;<br>


&nbsp;&nbsp;&nbsp; &lt;!-- &lt;param name=&quot;enable-analog-option&quot; value=&quot;call-swap&quot;/&gt; --&gt; <br>&nbsp;&nbsp;&nbsp; &lt;!-- &lt;param name=&quot;enable-analog-option&quot; value=&quot;3-way&quot;/&gt; --&gt;<br>&nbsp; &lt;/settings&gt;<br>


&nbsp; &lt;!-- one entry here per openzap span --&gt;<br>&nbsp; &lt;analog_spans&gt;<br>&nbsp;&nbsp;&nbsp; &lt;span id=&quot;1&quot;&gt;<br>&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;!--&lt;param name=&quot;hold-music&quot; value=&quot;$${moh_uri}&quot;/&gt;--&gt;<br>&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;!--&lt;param name=&quot;enable-analog-option&quot; value=&quot;call-swap&quot;/&gt;--&gt;<br>


&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;!--&lt;param name=&quot;enable-analog-option&quot; value=&quot;3-way&quot;/&gt;--&gt;<br>&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;param name=&quot;tonegroup&quot; value=&quot;us&quot;/&gt;<br>&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;param name=&quot;digit-timeout&quot; value=&quot;2000&quot;/&gt;<br>


&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;param name=&quot;max-digits&quot; value=&quot;15&quot;/&gt;<br>&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;param name=&quot;dialplan&quot; value=&quot;XML&quot;/&gt;<br>&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;param name=&quot;context&quot; value=&quot;default&quot;/&gt;<br>

&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;param name=&quot;enable-callerid&quot; value=&quot;false&quot;/&gt;<br>
&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;!-- regex to stop dialing when it matches --&gt;<br>&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;!--&lt;param name=&quot;dial-regex&quot; value=&quot;5555&quot;/&gt;--&gt;<br>&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;!-- regex to stop dialing when it does not match --&gt;<br>&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;!--&lt;param name=&quot;fail-dial-regex&quot; value=&quot;^5&quot;/&gt;--&gt;<br>


&nbsp;&nbsp;&nbsp; &lt;/span&gt;<br>&nbsp;&nbsp;&nbsp; &lt;span id=&quot;2&quot;&gt;<br>&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;!--&lt;param name=&quot;hold-music&quot; value=&quot;$${moh_uri}&quot;/&gt;--&gt;<br>&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;!--&lt;param name=&quot;enable-analog-option&quot; value=&quot;call-swap&quot;/&gt;--&gt;<br>


&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;!--&lt;param name=&quot;enable-analog-option&quot; value=&quot;3-way&quot;/&gt;--&gt;<br>&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;param name=&quot;tonegroup&quot; value=&quot;us&quot;/&gt;<br>&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;param name=&quot;digit-timeout&quot; value=&quot;2000&quot;/&gt;<br>


&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;param name=&quot;max-digits&quot; value=&quot;11&quot;/&gt;<br>&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;param name=&quot;dialplan&quot; value=&quot;XML&quot;/&gt;<br>&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;param name=&quot;context&quot; value=&quot;default&quot;/&gt;<br>

&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;param name=&quot;enable-callerid&quot; value=&quot;&quot;false/&gt;<br>
&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;!-- regex to stop dialing when it matches --&gt;<br>&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;!--&lt;param name=&quot;dial-regex&quot; value=&quot;5555&quot;/&gt;--&gt;<br>&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;!-- regex to stop dialing when it does not match --&gt;<br>&nbsp;&nbsp;&nbsp;&nbsp;&nbsp; &lt;!--&lt;param name=&quot;fail-dial-regex&quot; value=&quot;^5&quot;/&gt;--&gt;<br>


&nbsp;&nbsp;&nbsp; &lt;/span&gt;<br>&nbsp; &lt;/analog_spans&gt;<br>&lt;/configuration&gt;<br><br>openzap.conf<br>==========<br>[span zt]<br>name =&gt; OpenZAP FXS<br>number =&gt; 1<br>fxs-channel =&gt; 1<br><br>[span zt]<br>name =&gt; OpenZAP FXO<br>


number =&gt; 2<br>fxo-channel =&gt; 2<br><br>tones.conf&nbsp; (the dialtone and ring tone is set to Philipping tones)<br>========<br>[us]<br>generate-dial =&gt; v=-7;%(1000,0,425)<br>detect-dial =&gt; 425<br><br>generate-ring =&gt; v=-7;%(1000,4000,425,480)<br>


detect-ring =&gt; 425,480<br><br>generate-busy =&gt; v=-7;%(500,500,480,620)<br>detect-busy =&gt; 480,620<br><br>generate-attn =&gt; v=0;%(200,300,1400,1800)<br>detect-attn =&gt; 1400,1800<br><br>generate-callwaiting-sas =&gt; v=0;%(300,10000,440)<br>


detect-callwaiting-sas =&gt; 440<br><br>generate-callwaiting-cas =&gt; v=0;%(80,0,2750,2130)<br>detect-callwaiting-cas =&gt; 2750,2130<br><br>detect-fail1 =&gt; 913.8<br>detect-fail2 =&gt; 1370.6<br>detect-fail3 =&gt; 776.7<br>


<br>LOG OF FIRST CALL (OK)<br>====================<br>2009-01-25 10:35:58 [DEBUG] switch_core_state_machine.c:152 switch_core_standard_on_execute() OpenZAP/1:1/93400534 Execute bridge(openzap/2/1/3400534)<br>2009-01-25 10:35:58 [DEBUG] mod_openzap.c:340 tech_init() Set codec PCMU 20ms<br>


2009-01-25 10:35:58 [DEBUG] mod_openzap.c:1017 channel_outgoing_channel() Connect outbound channel OpenZAP/2:1/3400534<br>2009-01-25 10:35:58 [NOTICE] switch_channel.c:565 switch_channel_set_name() New Channel OpenZAP/2:1/3400534 [e5f12114-ea88-11dd-9f5c-290fb4a527a4]<br>


2009-01-25 10:35:58 [DEBUG] mod_openzap.c:1026 channel_outgoing_channel() (OpenZAP/2:1/3400534) State Change CS_NEW -&gt; CS_INIT<br>2009-01-25 10:35:58 [DEBUG] switch_core_session.c:807 switch_core_session_signal_state_change() Send signal OpenZAP/2:1/3400534 [BREAK]<br>


2009-01-25 10:35:58 [DEBUG] ozmod_analog.c:52 analog_fxo_outgoing_call() Changing state on 2:1 from DOWN to DIALING<br>2009-01-25 10:35:58 [DEBUG] ozmod_analog.c:239 zap_analog_channel_run() ANALOG CHANNEL thread starting.<br>


2009-01-25 10:35:58 [DEBUG] switch_core_state_machine.c:379 switch_core_session_run() (OpenZAP/2:1/3400534) Running State Change CS_INIT<br>2009-01-25 10:35:58 [DEBUG] ozmod_analog.c:410 zap_analog_channel_run() Executing state handler on 2:1 for DIALING<br>


2009-01-25 10:35:58 [DEBUG] switch_core_state_machine.c:444 switch_core_session_run() (OpenZAP/2:1/3400534) State INIT<br>2009-01-25 10:35:58 [DEBUG] mod_openzap.c:364 channel_on_init() (OpenZAP/2:1/3400534) State Change CS_INIT -&gt; CS_ROUTING<br>


2009-01-25 10:35:58 [DEBUG] switch_core_session.c:807 switch_core_session_signal_state_change() Send signal OpenZAP/2:1/3400534 [BREAK]<br>2009-01-25 10:35:58 [DEBUG] switch_core_state_machine.c:444 switch_core_session_run() (OpenZAP/2:1/3400534) State INIT going to sleep<br>


2009-01-25 10:35:58 [DEBUG] switch_core_state_machine.c:379 switch_core_session_run() (OpenZAP/2:1/3400534) Running State Change CS_ROUTING<br>2009-01-25 10:35:58 [DEBUG] switch_core_state_machine.c:447 switch_core_session_run() (OpenZAP/2:1/3400534) State ROUTING<br>


2009-01-25 10:35:58 [DEBUG] mod_openzap.c:387 channel_on_routing() OpenZAP/2:1/3400534 CHANNEL ROUTING<br>2009-01-25 10:35:58 [DEBUG] switch_ivr_originate.c:58 originate_on_routing() (OpenZAP/2:1/3400534) State Change CS_ROUTING -&gt; CS_CONSUME_MEDIA<br>


2009-01-25 10:35:58 [DEBUG] switch_core_session.c:807 switch_core_session_signal_state_change() Send signal OpenZAP/2:1/3400534 [BREAK]<br>2009-01-25 10:35:58 [DEBUG] switch_core_state_machine.c:447 switch_core_session_run() (OpenZAP/2:1/3400534) State ROUTING going to sleep<br>


2009-01-25 10:35:58 [DEBUG] switch_core_state_machine.c:379 switch_core_session_run() (OpenZAP/2:1/3400534) Running State Change CS_CONSUME_MEDIA<br>2009-01-25 10:35:58 [DEBUG] switch_core_state_machine.c:466 switch_core_session_run() (OpenZAP/2:1/3400534) State CONSUME_MEDIA<br>


2009-01-25 10:35:59 [DEBUG] ozmod_analog.c:615 zap_analog_channel_run() Detected tone DIAL on 2:1<br>2009-01-25 10:35:59 [DEBUG] mod_openzap.c:1153 on_fxo_signal() got FXO sig 2:1 [TONE_DETECTED]<br>2009-01-25 10:35:59 [WARNING] mod_openzap.c:1196 on_fxo_signal() Unhandled type for channel 2:1<br>


2009-01-25 10:35:59 [DEBUG] zap_io.c:1179 zchan_activate_dtmf_buffer() Created DTMF Buffer!<br>2009-01-25 10:35:59 [DEBUG] zap_io.c:1715 handle_dtmf() 2:1 GENERATE DTMF [3400534]<br>2009-01-25 10:36:03 [DEBUG] ozmod_analog.c:302 zap_analog_channel_run() Changing state on 2:1 from DIALING to UP<br>


2009-01-25 10:36:03 [DEBUG] ozmod_analog.c:410 zap_analog_channel_run() Executing state handler on 2:1 for UP<br>2009-01-25 10:36:03 [DEBUG] mod_openzap.c:1153 on_fxo_signal() got FXO sig 2:1 [UP]<br>2009-01-25 10:36:03 [DEBUG] switch_channel.c:1710 switch_channel_perform_mark_answered() Send signal OpenZAP/1:1/93400534 [BREAK]<br>


2009-01-25 10:36:03 [NOTICE] mod_openzap.c:1180 on_fxo_signal() Channel [OpenZAP/2:1/3400534] has been answered<br>2009-01-25 10:36:03 [DEBUG] switch_channel.c:177 switch_channel_audio_sync() OpenZAP/2:1/3400534 receive message [AUDIO_SYNC]<br>


2009-01-25 10:36:03 [DEBUG] switch_channel.c:1768 switch_channel_perform_answer() OpenZAP/1:1/93400534 receive message [ANSWER]<br>2009-01-25 10:36:03 [DEBUG] mod_openzap.c:813 channel_receive_message_fxs() Changing state on 1:1 from IDLE to UP<br>


2009-01-25 10:36:03 [NOTICE] mod_openzap.c:814 channel_receive_message_fxs() Channel [OpenZAP/1:1/93400534] has been answered<br>2009-01-25 10:36:03 [DEBUG] switch_channel.c:177 switch_channel_audio_sync() OpenZAP/1:1/93400534 receive message [AUDIO_SYNC]<br>


2009-01-25 10:36:03 [DEBUG] switch_core_session.c:511 switch_core_session_perform_receive_message() Send signal OpenZAP/1:1/93400534 [BREAK]<br>2009-01-25 10:36:03 [DEBUG] switch_ivr_originate.c:1627 switch_ivr_originate() Originate Resulted in Success: [OpenZAP/2:1/3400534]<br>


2009-01-25 10:36:03 [DEBUG] switch_channel.c:177 switch_channel_audio_sync() OpenZAP/2:1/3400534 receive message [AUDIO_SYNC]<br>2009-01-25 10:36:03 [DEBUG] switch_channel.c:177 switch_channel_audio_sync() OpenZAP/1:1/93400534 receive message [AUDIO_SYNC]<br>


2009-01-25 10:36:03 [DEBUG] switch_ivr_bridge.c:862 switch_ivr_multi_threaded_bridge() OpenZAP/2:1/3400534 receive message [BRIDGE]<br>2009-01-25 10:36:03 [DEBUG] switch_core_session.c:511 switch_core_session_perform_receive_message() Send signal OpenZAP/2:1/3400534 [BREAK]<br>


2009-01-25 10:36:03 [DEBUG] switch_ivr_bridge.c:869 switch_ivr_multi_threaded_bridge() OpenZAP/1:1/93400534 receive message [BRIDGE]<br>2009-01-25 10:36:03 [DEBUG] switch_core_session.c:511 switch_core_session_perform_receive_message() Send signal OpenZAP/1:1/93400534 [BREAK]<br>


2009-01-25 10:36:03 [DEBUG] switch_ivr_bridge.c:913 switch_ivr_multi_threaded_bridge() (OpenZAP/2:1/3400534) State Change CS_CONSUME_MEDIA -&gt; CS_EXCHANGE_MEDIA<br>2009-01-25 10:36:03 [DEBUG] switch_core_session.c:807 switch_core_session_signal_state_change() Send signal OpenZAP/2:1/3400534 [BREAK]<br>


2009-01-25 10:36:03 [DEBUG] ozmod_analog.c:410 zap_analog_channel_run() Executing state handler on 1:1 for UP<br>2009-01-25 10:36:03 [DEBUG] mod_openzap.c:1212 on_fxs_signal() got FXS sig [UP]<br>2009-01-25 10:36:03 [DEBUG] switch_core_state_machine.c:466 switch_core_session_run() (OpenZAP/2:1/3400534) State CONSUME_MEDIA going to sleep<br>


2009-01-25 10:36:03 [DEBUG] switch_core_state_machine.c:379 switch_core_session_run() (OpenZAP/2:1/3400534) Running State Change CS_EXCHANGE_MEDIA<br>2009-01-25 10:36:03 [DEBUG] switch_core_state_machine.c:457 switch_core_session_run() (OpenZAP/2:1/3400534) State EXCHANGE_MEDIA<br>


2009-01-25 10:36:03 [DEBUG] mod_openzap.c:511 channel_on_exchange_media() CHANNEL EXCHANGE_MEDIA<br>2009-01-25 10:36:16 [DEBUG] ozmod_analog.c:744 process_event() EVENT [ONHOOK][1:1] STATE [UP]<br>2009-01-25 10:36:16 [DEBUG] ozmod_analog.c:780 process_event() Changing state on 1:1 from UP to DOWN<br>


2009-01-25 10:36:16 [DEBUG] ozmod_analog.c:410 zap_analog_channel_run() Executing state handler on 1:1 for DOWN<br>2009-01-25 10:36:16 [DEBUG] mod_openzap.c:1212 on_fxs_signal() got FXS sig [STOP]<br>2009-01-25 10:36:16 [NOTICE] mod_openzap.c:1300 on_fxs_signal() Hangup OpenZAP/1:1/93400534 [CS_EXECUTE] [NORMAL_CLEARING]<br>


2009-01-25 10:36:16 [DEBUG] switch_channel.c:1494 switch_channel_perform_hangup() Send signal OpenZAP/1:1/93400534 [KILL]<br>2009-01-25 10:36:16 [DEBUG] switch_core_session.c:807 switch_core_session_signal_state_change() Send signal OpenZAP/1:1/93400534 [BREAK]<br>


2009-01-25 10:36:16 [DEBUG] zap_io.c:1125 zap_channel_done() channel done 1:1<br>2009-01-25 10:36:16 [DEBUG] ozmod_analog.c:726 zap_analog_channel_run() ANALOG CHANNEL 1:1 thread ended.<br>2009-01-25 10:36:16 [DEBUG] switch_ivr_bridge.c:360 audio_bridge_thread() OpenZAP/1:1/93400534 ending bridge by request from read function<br>


2009-01-25 10:36:16 [DEBUG] switch_ivr_bridge.c:435 audio_bridge_thread() BRIDGE THREAD DONE [OpenZAP/1:1/93400534]<br>2009-01-25 10:36:16 [DEBUG] switch_ivr_bridge.c:439 audio_bridge_thread() Send signal OpenZAP/2:1/3400534 [BREAK]<br>


2009-01-25 10:36:16 [DEBUG] switch_ivr_bridge.c:354 audio_bridge_thread() OpenZAP/1:1/93400534 ending bridge by request from write function<br>2009-01-25 10:36:16 [DEBUG] switch_ivr_bridge.c:409 audio_bridge_thread() OpenZAP/2:1/3400534 receive message [UNBRIDGE]<br>


2009-01-25 10:36:16 [DEBUG] switch_core_session.c:511 switch_core_session_perform_receive_message() Send signal OpenZAP/2:1/3400534 [BREAK]<br>2009-01-25 10:36:16 [DEBUG] switch_ivr_bridge.c:435 audio_bridge_thread() BRIDGE THREAD DONE [OpenZAP/2:1/3400534]<br>


2009-01-25 10:36:16 [DEBUG] switch_ivr_bridge.c:439 audio_bridge_thread() Send signal OpenZAP/1:1/93400534 [BREAK]<br>2009-01-25 10:36:16 [NOTICE] switch_ivr_bridge.c:470 audio_bridge_on_exchange_media() Hangup OpenZAP/2:1/3400534 [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]<br>


2009-01-25 10:36:16 [DEBUG] switch_channel.c:1494 switch_channel_perform_hangup() Send signal OpenZAP/2:1/3400534 [KILL]<br>2009-01-25 10:36:16 [DEBUG] switch_core_session.c:807 switch_core_session_signal_state_change() Send signal OpenZAP/2:1/3400534 [BREAK]<br>


2009-01-25 10:36:16 [DEBUG] switch_core_state_machine.c:457 switch_core_session_run() (OpenZAP/2:1/3400534) State EXCHANGE_MEDIA going to sleep<br>2009-01-25 10:36:16 [DEBUG] switch_core_state_machine.c:379 switch_core_session_run() (OpenZAP/2:1/3400534) Running State Change CS_HANGUP<br>


2009-01-25 10:36:16 [DEBUG] switch_core_state_machine.c:410 switch_core_session_run() (OpenZAP/2:1/3400534) State HANGUP<br>2009-01-25 10:36:16 [DEBUG] mod_openzap.c:429 channel_on_hangup() Changing state on 2:1 from UP to HANGUP<br>


2009-01-25 10:36:16 [DEBUG] mod_openzap.c:472 channel_on_hangup() OpenZAP/2:1/3400534 CHANNEL HANGUP<br>2009-01-25 10:36:16 [DEBUG] switch_core_state_machine.c:46 switch_core_standard_on_hangup() OpenZAP/2:1/3400534 Standard HANGUP, cause: NORMAL_CLEARING<br>


2009-01-25 10:36:16 [DEBUG] switch_core_state_machine.c:410 switch_core_session_run() (OpenZAP/2:1/3400534) State HANGUP going to sleep<br>2009-01-25 10:36:16 [DEBUG] switch_core_session.c:939 switch_core_session_thread() Session 2 (OpenZAP/2:1/3400534) Locked, Waiting on external entities<br>


2009-01-25 10:36:16 [DEBUG] switch_core_state_machine.c:454 switch_core_session_run() (OpenZAP/1:1/93400534) State EXECUTE going to sleep<br>2009-01-25 10:36:16 [NOTICE] switch_core_session.c:957 switch_core_session_thread() Session 2 (OpenZAP/2:1/3400534) Ended<br>


2009-01-25 10:36:16 [NOTICE] switch_core_session.c:959 switch_core_session_thread() Close Channel OpenZAP/2:1/3400534 [CS_HANGUP]<br>2009-01-25 10:36:16 [DEBUG] switch_core_state_machine.c:379 switch_core_session_run() (OpenZAP/1:1/93400534) Running State Change CS_HANGUP<br>


2009-01-25 10:36:16 [DEBUG] switch_core_state_machine.c:410 switch_core_session_run() (OpenZAP/1:1/93400534) State HANGUP<br>2009-01-25 10:36:16 [DEBUG] mod_openzap.c:472 channel_on_hangup() OpenZAP/1:1/93400534 CHANNEL HANGUP<br>


2009-01-25 10:36:16 [DEBUG] switch_core_state_machine.c:46 switch_core_standard_on_hangup() OpenZAP/1:1/93400534 Standard HANGUP, cause: NORMAL_CLEARING<br>2009-01-25 10:36:16 [DEBUG] switch_core_state_machine.c:410 switch_core_session_run() (OpenZAP/1:1/93400534) State HANGUP going to sleep<br>


2009-01-25 10:36:16 [DEBUG] switch_core_session.c:939 switch_core_session_thread() Session 1 (OpenZAP/1:1/93400534) Locked, Waiting on external entities<br>2009-01-25 10:36:16 [NOTICE] switch_core_session.c:957 switch_core_session_thread() Session 1 (OpenZAP/1:1/93400534) Ended<br>


2009-01-25 10:36:16 [NOTICE] switch_core_session.c:959 switch_core_session_thread() Close Channel OpenZAP/1:1/93400534 [CS_HANGUP]<br>2009-01-25 10:36:16 [DEBUG] ozmod_analog.c:410 zap_analog_channel_run() Executing state handler on 2:1 for HANGUP<br>


2009-01-25 10:36:17 [DEBUG] ozmod_analog.c:351 zap_analog_channel_run() Changing state on 2:1 from HANGUP to DOWN<br>2009-01-25 10:36:17 [DEBUG] ozmod_analog.c:410 zap_analog_channel_run() Executing state handler on 2:1 for DOWN<br>


2009-01-25 10:36:17 [DEBUG] mod_openzap.c:1153 on_fxo_signal() got FXO sig 2:1 [STOP]<br>2009-01-25 10:36:17 [DEBUG] zap_io.c:1125 zap_channel_done() channel done 2:1<br>2009-01-25 10:36:17 [DEBUG] ozmod_analog.c:726 zap_analog_channel_run() ANALOG CHANNEL 2:1 thread ended.<br>


<br>LOG OF FAILED CALLS<br>==================<br>2009-01-25 10:36:55 [DEBUG] switch_core_state_machine.c:152 switch_core_standard_on_execute() OpenZAP/1:1/93400534 Execute bridge(openzap/2/1/3400534)<br>2009-01-25 10:36:55 [DEBUG] mod_openzap.c:340 tech_init() Set codec PCMU 20ms<br>


2009-01-25 10:36:55 [DEBUG] mod_openzap.c:1017 channel_outgoing_channel() Connect outbound channel OpenZAP/2:1/3400534<br>2009-01-25 10:36:55 [NOTICE] switch_channel.c:565 switch_channel_set_name() New Channel OpenZAP/2:1/3400534 [079f5420-ea89-11dd-9f5c-290fb4a527a4]<br>


2009-01-25 10:36:55 [DEBUG] mod_openzap.c:1026 channel_outgoing_channel() (OpenZAP/2:1/3400534) State Change CS_NEW -&gt; CS_INIT<br>2009-01-25 10:36:55 [DEBUG] switch_core_session.c:807 switch_core_session_signal_state_change() Send signal OpenZAP/2:1/3400534 [BREAK]<br>


2009-01-25 10:36:55 [DEBUG] ozmod_analog.c:52 analog_fxo_outgoing_call() Changing state on 2:1 from DOWN to DIALING<br>2009-01-25 10:36:55 [DEBUG] ozmod_analog.c:239 zap_analog_channel_run() ANALOG CHANNEL thread starting.<br>


2009-01-25 10:36:55 [DEBUG] switch_core_state_machine.c:379 switch_core_session_run() (OpenZAP/2:1/3400534) Running State Change CS_INIT<br>2009-01-25 10:36:55 [DEBUG] ozmod_analog.c:410 zap_analog_channel_run() Executing state handler on 2:1 for DIALING<br>


2009-01-25 10:36:55 [DEBUG] switch_core_state_machine.c:444 switch_core_session_run() (OpenZAP/2:1/3400534) State INIT<br>2009-01-25 10:36:55 [DEBUG] mod_openzap.c:364 channel_on_init() (OpenZAP/2:1/3400534) State Change CS_INIT -&gt; CS_ROUTING<br>


2009-01-25 10:36:55 [DEBUG] switch_core_session.c:807 switch_core_session_signal_state_change() Send signal OpenZAP/2:1/3400534 [BREAK]<br>2009-01-25 10:36:55 [DEBUG] switch_core_state_machine.c:444 switch_core_session_run() (OpenZAP/2:1/3400534) State INIT going to sleep<br>


2009-01-25 10:36:55 [DEBUG] switch_core_state_machine.c:379 switch_core_session_run() (OpenZAP/2:1/3400534) Running State Change CS_ROUTING<br>2009-01-25 10:36:55 [DEBUG] switch_core_state_machine.c:447 switch_core_session_run() (OpenZAP/2:1/3400534) State ROUTING<br>


2009-01-25 10:36:55 [DEBUG] mod_openzap.c:387 channel_on_routing() OpenZAP/2:1/3400534 CHANNEL ROUTING<br>2009-01-25 10:36:55 [DEBUG] switch_ivr_originate.c:58 originate_on_routing() (OpenZAP/2:1/3400534) State Change CS_ROUTING -&gt; CS_CONSUME_MEDIA<br>


2009-01-25 10:36:55 [DEBUG] switch_core_session.c:807 switch_core_session_signal_state_change() Send signal OpenZAP/2:1/3400534 [BREAK]<br>2009-01-25 10:36:55 [DEBUG] switch_core_state_machine.c:447 switch_core_session_run() (OpenZAP/2:1/3400534) State ROUTING going to sleep<br>


2009-01-25 10:36:55 [DEBUG] switch_core_state_machine.c:379 switch_core_session_run() (OpenZAP/2:1/3400534) Running State Change CS_CONSUME_MEDIA<br>2009-01-25 10:36:55 [DEBUG] switch_core_state_machine.c:466 switch_core_session_run() (OpenZAP/2:1/3400534) State CONSUME_MEDIA<br>


2009-01-25 10:37:08 [DEBUG] ozmod_analog.c:744 process_event() EVENT [ONHOOK][1:1] STATE [IDLE]<br>2009-01-25 10:37:08 [DEBUG] ozmod_analog.c:780 process_event() Changing state on 1:1 from IDLE to DOWN<br>2009-01-25 10:37:08 [DEBUG] ozmod_analog.c:410 zap_analog_channel_run() Executing state handler on 1:1 for DOWN<br>


2009-01-25 10:37:08 [DEBUG] mod_openzap.c:1212 on_fxs_signal() got FXS sig [STOP]<br>2009-01-25 10:37:08 [NOTICE] mod_openzap.c:1300 on_fxs_signal() Hangup OpenZAP/1:1/93400534 [CS_EXECUTE] [NORMAL_CLEARING]<br>2009-01-25 10:37:08 [DEBUG] switch_channel.c:1494 switch_channel_perform_hangup() Send signal OpenZAP/1:1/93400534 [KILL]<br>


2009-01-25 10:37:08 [DEBUG] switch_core_session.c:807 switch_core_session_signal_state_change() Send signal OpenZAP/1:1/93400534 [BREAK]<br>2009-01-25 10:37:08 [DEBUG] zap_io.c:1125 zap_channel_done() channel done 1:1<br>


2009-01-25 10:37:08 [DEBUG] ozmod_analog.c:726 zap_analog_channel_run() ANALOG CHANNEL 1:1 thread ended.<br>2009-01-25 10:37:08 [NOTICE] switch_ivr_originate.c:1566 switch_ivr_originate() Hangup OpenZAP/2:1/3400534 [CS_CONSUME_MEDIA] [ORIGINATOR_CANCEL]<br>


2009-01-25 10:37:08 [DEBUG] switch_channel.c:1494 switch_channel_perform_hangup() Send signal OpenZAP/2:1/3400534 [KILL]<br>2009-01-25 10:37:08 [DEBUG] switch_core_session.c:807 switch_core_session_signal_state_change() Send signal OpenZAP/2:1/3400534 [BREAK]<br>


2009-01-25 10:37:08 [DEBUG] switch_ivr_originate.c:1691 switch_ivr_originate() Originate Cancelled by originator termination Cause: 487 [ORIGINATOR_CANCEL]<br>2009-01-25 10:37:08 [INFO] mod_dptools.c:1909 audio_bridge_function() Originate Failed.&nbsp; Cause: ORIGINATOR_CANCEL<br>


2009-01-25 10:37:08 [DEBUG] switch_core_state_machine.c:454 switch_core_session_run() (OpenZAP/1:1/93400534) State EXECUTE going to sleep<br>2009-01-25 10:37:08 [DEBUG] switch_core_state_machine.c:379 switch_core_session_run() (OpenZAP/1:1/93400534) Running State Change CS_HANGUP<br>


2009-01-25 10:37:08 [DEBUG] switch_core_state_machine.c:410 switch_core_session_run() (OpenZAP/1:1/93400534) State HANGUP<br>2009-01-25 10:37:08 [DEBUG] mod_openzap.c:472 channel_on_hangup() OpenZAP/1:1/93400534 CHANNEL HANGUP<br>


2009-01-25 10:37:08 [DEBUG] switch_core_state_machine.c:46 switch_core_standard_on_hangup() OpenZAP/1:1/93400534 Standard HANGUP, cause: NORMAL_CLEARING<br>2009-01-25 10:37:08 [DEBUG] switch_core_state_machine.c:410 switch_core_session_run() (OpenZAP/1:1/93400534) State HANGUP going to sleep<br>


2009-01-25 10:37:08 [DEBUG] switch_core_session.c:939 switch_core_session_thread() Session 3 (OpenZAP/1:1/93400534) Locked, Waiting on external entities<br>2009-01-25 10:37:08 [NOTICE] switch_core_session.c:957 switch_core_session_thread() Session 3 (OpenZAP/1:1/93400534) Ended<br>


2009-01-25 10:37:08 [DEBUG] switch_core_state_machine.c:466 switch_core_session_run() (OpenZAP/2:1/3400534) State CONSUME_MEDIA going to sleep<br>2009-01-25 10:37:08 [NOTICE] switch_core_session.c:959 switch_core_session_thread() Close Channel OpenZAP/1:1/93400534 [CS_HANGUP]<br>


2009-01-25 10:37:08 [DEBUG] switch_core_state_machine.c:379 switch_core_session_run() (OpenZAP/2:1/3400534) Running State Change CS_HANGUP<br>2009-01-25 10:37:08 [DEBUG] switch_core_state_machine.c:410 switch_core_session_run() (OpenZAP/2:1/3400534) State HANGUP<br>


2009-01-25 10:37:08 [DEBUG] mod_openzap.c:429 channel_on_hangup() Changing state on 2:1 from DIALING to HANGUP<br>2009-01-25 10:37:08 [DEBUG] mod_openzap.c:472 channel_on_hangup() OpenZAP/2:1/3400534 CHANNEL HANGUP<br>2009-01-25 10:37:08 [DEBUG] switch_core_state_machine.c:46 switch_core_standard_on_hangup() OpenZAP/2:1/3400534 Standard HANGUP, cause: ORIGINATOR_CANCEL<br>


2009-01-25 10:37:08 [DEBUG] switch_core_state_machine.c:410 switch_core_session_run() (OpenZAP/2:1/3400534) State HANGUP going to sleep<br>2009-01-25 10:37:08 [DEBUG] switch_core_session.c:939 switch_core_session_thread() Session 4 (OpenZAP/2:1/3400534) Locked, Waiting on external entities<br>


2009-01-25 10:37:08 [NOTICE] switch_core_session.c:957 switch_core_session_thread() Session 4 (OpenZAP/2:1/3400534) Ended<br>2009-01-25 10:37:08 [NOTICE] switch_core_session.c:959 switch_core_session_thread() Close Channel OpenZAP/2:1/3400534 [CS_HANGUP]<br>


2009-01-25 10:37:08 [DEBUG] ozmod_analog.c:410 zap_analog_channel_run() Executing state handler on 2:1 for HANGUP<br>2009-01-25 10:37:09 [DEBUG] ozmod_analog.c:351 zap_analog_channel_run() Changing state on 2:1 from HANGUP to DOWN<br>


2009-01-25 10:37:09 [DEBUG] ozmod_analog.c:410 zap_analog_channel_run() Executing state handler on 2:1 for DOWN<br>2009-01-25 10:37:09 [DEBUG] mod_openzap.c:1153 on_fxo_signal() got FXO sig 2:1 [STOP]<br>2009-01-25 10:37:09 [DEBUG] zap_io.c:1125 zap_channel_done() channel done 2:1<br>


2009-01-25 10:37:09 [DEBUG] ozmod_analog.c:726 zap_analog_channel_run() ANALOG CHANNEL 2:1 thread ended.<br><br><br><br><br clear="all"><br>
<br></div></div>_______________________________________________<br>
Freeswitch-users mailing list<br>
<a href="mailto:Freeswitch-users@lists.freeswitch.org" target="_blank">Freeswitch-users@lists.freeswitch.org</a><br>
<a href="http://lists.freeswitch.org/mailman/listinfo/freeswitch-users" target="_blank">http://lists.freeswitch.org/mailman/listinfo/freeswitch-users</a><br>
UNSUBSCRIBE:<a href="http://lists.freeswitch.org/mailman/options/freeswitch-users" target="_blank">http://lists.freeswitch.org/mailman/options/freeswitch-users</a><br>
<a href="http://www.freeswitch.org" target="_blank">http://www.freeswitch.org</a><br>
<br></blockquote>
<br>_______________________________________________<br>
Freeswitch-users mailing list<br>
<a href="mailto:Freeswitch-users@lists.freeswitch.org">Freeswitch-users@lists.freeswitch.org</a><br>
<a href="http://lists.freeswitch.org/mailman/listinfo/freeswitch-users" target="_blank">http://lists.freeswitch.org/mailman/listinfo/freeswitch-users</a><br>
UNSUBSCRIBE:<a href="http://lists.freeswitch.org/mailman/options/freeswitch-users" target="_blank">http://lists.freeswitch.org/mailman/options/freeswitch-users</a><br>
<a href="http://www.freeswitch.org" target="_blank">http://www.freeswitch.org</a><br>
<br></blockquote></div><br>