[Freeswitch-users] TDM400 FXO can dialout only once

Raul Fragoso raul at etellicom.com
Mon Jan 26 10:16:09 PST 2009


You may want to define the conf/tones.conf file with the proper tone
definitions for your country, then specify that tone group (tonegroup=XX
where XX is the 2 letters code for your country). For example, this is
the definition for my country (Brazil) and I also have tonegroup=br in
my openzap configuration file:

[br]
generate-busy => v=-7;%(250,250,425)
generate-dial => v=-7;%(1000,0,425)
generate-ring => v=-7;%(1000,4000,425)
generate-callwaiting-sas => v=0;%(300,10000,425)
detect-busy => 425
detect-dial => 425
detect-ring => 425 
detect-callwaiting-sas => 425

Regards,

Raul Fragoso

On Mon, 2009-01-26 at 21:32 +0800, Nandy Dagondon wrote:
> that's great. yes, i'm in the philippines. there's a difference in
> dialtone - it's 425 Hz.
>  -nandy
> 
> 
> On Mon, Jan 26, 2009 at 6:01 PM, Michael Collins <msc at freeswitch.org>
> wrote:
>         I have a TDM400 clone and I will see if I can reproduce these
>         symptoms. BTW, are you in the Philippines? Is there any
>         difference in
>         the dial tone there than in the US?
>         -MC
>         
>         
>         On Sun, Jan 25, 2009 at 11:05 PM, Nandy Dagondon <gcd at i.ph>
>         wrote:
>         > i monitored the line using another phone. there's indeed
>         dialtone in all
>         > attempts.
>         > i see TONE_DETECTED in the first call but i wonder there's a
>         WARNING message
>         > immediately following [WARNING] mod_openzap.c:1196
>         on_fxo_signal() Unhandled
>         > type for channel 2:1.
>         > the dialtone freq should be okay since it's detected in the
>         first call.could
>         > the WARNING message gives us a hint of a possible problem
>         other than the
>         > dialtone freq?
>         >
>         > okay, i'll try the SVN version next.
>         >
>         >
>         > On Mon, Jan 26, 2009 at 10:18 AM, Anthony Minessale
>         > <anthony.minessale at gmail.com> wrote:
>         >>
>         >> Its not detecting a dial tone on the failure case.
>         >> Before dialing it waits until it picks up dialtone.
>         >> Try the svn trunk version to see if it works any better or
>         verify there is
>         >> a dialtone on the line.
>         >>
>         >> On Jan 25, 2009 6:19 PM, "Nandy Dagondon" <gcd at i.ph> wrote:
>         >>
>         >> hi everybody,
>         >>
>         >> i installed FS 1.0.2 to an Atom mobo (Intel D945GCLF2).
>         it's working using
>         >> IP phones, softphones and digium FXS port. but there'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.
>         >>
>         >> before i place any call,  i checked >oz dump 2 1 (show
>         current state =
>         >> DOWN, last state = DOWN)
>         >>
>         >> in the first call, there's this message:
>         >> [WARNING] mod_openzap.c:1196 on_fxo_signal() Unhandled type
>         for channel
>         >> 2:1
>         >> but
>         >>
>         >> then i hangup. checked >oz dump 21 (show current
>         state=DOWN, last
>         >> state=HANGUP)
>         >>
>         >> in the 2nd (and subsequent) attempts, the fxo just goes
>         off-hook but
>         >> doesn't send the dtmf tones.
>         >> >oz dump 2 1 (shows current state = DIALING, last state =
>         DOWN)
>         >>
>         >> has anyone encountered this problem before? i appreciate
>         for any help to
>         >> correct this problem.
>         >>
>         >> tks,
>         >> nandy
>         >>
>         >>
>         >> Environment:
>         >> ==================
>         >> kernel 2.6.18-92.1.22.el5
>         >> FS 1.0.2
>         >> zaptel 1.4.11
>         >> oslec
>         >> digium TDM400P Rev. I (1-FXS, 2-FXO,3-4 vacant)
>         >>
>         >> zaptel.conf
>         >> ========
>         >> loadzone = us
>         >> defaultzone=us
>         >> channels=1-2
>         >> alaw=1-4
>         >> fxsks=2
>         >> fxoks=1
>         >>
>         >>
>         >> openzap.conf.xml:
>         >> ===============
>         >> <configuration name="openzap.conf" description="OpenZAP
>         Configuration">
>         >>   <settings>
>         >>     <param name="debug" value="9"/>
>         >>     <!-- <param name="hold-music" value="$${moh_uri}"/> -->
>         >>     <!-- <param name="enable-analog-option"
>         value="call-swap"/> -->
>         >>     <!-- <param name="enable-analog-option" value="3-way"/>
>         -->
>         >>   </settings>
>         >>   <!-- one entry here per openzap span -->
>         >>   <analog_spans>
>         >>     <span id="1">
>         >>       <!--<param name="hold-music" value="$${moh_uri}"/>-->
>         >>       <!--<param name="enable-analog-option"
>         value="call-swap"/>-->
>         >>       <!--<param name="enable-analog-option"
>         value="3-way"/>-->
>         >>       <param name="tonegroup" value="us"/>
>         >>       <param name="digit-timeout" value="2000"/>
>         >>       <param name="max-digits" value="15"/>
>         >>       <param name="dialplan" value="XML"/>
>         >>       <param name="context" value="default"/>
>         >>       <param name="enable-callerid" value="false"/>
>         >>       <!-- regex to stop dialing when it matches -->
>         >>       <!--<param name="dial-regex" value="5555"/>-->
>         >>       <!-- regex to stop dialing when it does not match -->
>         >>       <!--<param name="fail-dial-regex" value="^5"/>-->
>         >>     </span>
>         >>     <span id="2">
>         >>       <!--<param name="hold-music" value="$${moh_uri}"/>-->
>         >>       <!--<param name="enable-analog-option"
>         value="call-swap"/>-->
>         >>       <!--<param name="enable-analog-option"
>         value="3-way"/>-->
>         >>       <param name="tonegroup" value="us"/>
>         >>       <param name="digit-timeout" value="2000"/>
>         >>       <param name="max-digits" value="11"/>
>         >>       <param name="dialplan" value="XML"/>
>         >>       <param name="context" value="default"/>
>         >>       <param name="enable-callerid" value=""false/>
>         >>       <!-- regex to stop dialing when it matches -->
>         >>       <!--<param name="dial-regex" value="5555"/>-->
>         >>       <!-- regex to stop dialing when it does not match -->
>         >>       <!--<param name="fail-dial-regex" value="^5"/>-->
>         >>     </span>
>         >>   </analog_spans>
>         >> </configuration>
>         >>
>         >> openzap.conf
>         >> ==========
>         >> [span zt]
>         >> name => OpenZAP FXS
>         >> number => 1
>         >> fxs-channel => 1
>         >>
>         >> [span zt]
>         >> name => OpenZAP FXO
>         >> number => 2
>         >> fxo-channel => 2
>         >>
>         >> tones.conf  (the dialtone and ring tone is set to
>         Philipping tones)
>         >> ========
>         >> [us]
>         >> generate-dial => v=-7;%(1000,0,425)
>         >> detect-dial => 425
>         >>
>         >> generate-ring => v=-7;%(1000,4000,425,480)
>         >> detect-ring => 425,480
>         >>
>         >> generate-busy => v=-7;%(500,500,480,620)
>         >> detect-busy => 480,620
>         >>
>         >> generate-attn => v=0;%(200,300,1400,1800)
>         >> detect-attn => 1400,1800
>         >>
>         >> generate-callwaiting-sas => v=0;%(300,10000,440)
>         >> detect-callwaiting-sas => 440
>         >>
>         >> generate-callwaiting-cas => v=0;%(80,0,2750,2130)
>         >> detect-callwaiting-cas => 2750,2130
>         >>
>         >> detect-fail1 => 913.8
>         >> detect-fail2 => 1370.6
>         >> detect-fail3 => 776.7
>         >>
>         >> LOG OF FIRST CALL (OK)
>         >> ====================
>         >> 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)
>         >> 2009-01-25 10:35:58 [DEBUG] mod_openzap.c:340 tech_init()
>         Set codec PCMU
>         >> 20ms
>         >> 2009-01-25 10:35:58 [DEBUG] mod_openzap.c:1017
>         channel_outgoing_channel()
>         >> Connect outbound channel OpenZAP/2:1/3400534
>         >> 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]
>         >> 2009-01-25 10:35:58 [DEBUG] mod_openzap.c:1026
>         channel_outgoing_channel()
>         >> (OpenZAP/2:1/3400534) State Change CS_NEW -> CS_INIT
>         >> 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]
>         >> 2009-01-25 10:35:58 [DEBUG] ozmod_analog.c:52
>         analog_fxo_outgoing_call()
>         >> Changing state on 2:1 from DOWN to DIALING
>         >> 2009-01-25 10:35:58 [DEBUG] ozmod_analog.c:239
>         zap_analog_channel_run()
>         >> ANALOG CHANNEL thread starting.
>         >> 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
>         >> 2009-01-25 10:35:58 [DEBUG] ozmod_analog.c:410
>         zap_analog_channel_run()
>         >> Executing state handler on 2:1 for DIALING
>         >> 2009-01-25 10:35:58 [DEBUG] switch_core_state_machine.c:444
>         >> switch_core_session_run() (OpenZAP/2:1/3400534) State INIT
>         >> 2009-01-25 10:35:58 [DEBUG] mod_openzap.c:364
>         channel_on_init()
>         >> (OpenZAP/2:1/3400534) State Change CS_INIT -> CS_ROUTING
>         >> 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]
>         >> 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
>         >> 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
>         >> 2009-01-25 10:35:58 [DEBUG] switch_core_state_machine.c:447
>         >> switch_core_session_run() (OpenZAP/2:1/3400534) State
>         ROUTING
>         >> 2009-01-25 10:35:58 [DEBUG] mod_openzap.c:387
>         channel_on_routing()
>         >> OpenZAP/2:1/3400534 CHANNEL ROUTING
>         >> 2009-01-25 10:35:58 [DEBUG] switch_ivr_originate.c:58
>         >> originate_on_routing() (OpenZAP/2:1/3400534) State Change
>         CS_ROUTING ->
>         >> CS_CONSUME_MEDIA
>         >> 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]
>         >> 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
>         >> 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
>         >> 2009-01-25 10:35:58 [DEBUG] switch_core_state_machine.c:466
>         >> switch_core_session_run() (OpenZAP/2:1/3400534) State
>         CONSUME_MEDIA
>         >> 2009-01-25 10:35:59 [DEBUG] ozmod_analog.c:615
>         zap_analog_channel_run()
>         >> Detected tone DIAL on 2:1
>         >> 2009-01-25 10:35:59 [DEBUG] mod_openzap.c:1153
>         on_fxo_signal() got FXO sig
>         >> 2:1 [TONE_DETECTED]
>         >> 2009-01-25 10:35:59 [WARNING] mod_openzap.c:1196
>         on_fxo_signal() Unhandled
>         >> type for channel 2:1
>         >> 2009-01-25 10:35:59 [DEBUG] zap_io.c:1179
>         zchan_activate_dtmf_buffer()
>         >> Created DTMF Buffer!
>         >> 2009-01-25 10:35:59 [DEBUG] zap_io.c:1715 handle_dtmf() 2:1
>         GENERATE DTMF
>         >> [3400534]
>         >> 2009-01-25 10:36:03 [DEBUG] ozmod_analog.c:302
>         zap_analog_channel_run()
>         >> Changing state on 2:1 from DIALING to UP
>         >> 2009-01-25 10:36:03 [DEBUG] ozmod_analog.c:410
>         zap_analog_channel_run()
>         >> Executing state handler on 2:1 for UP
>         >> 2009-01-25 10:36:03 [DEBUG] mod_openzap.c:1153
>         on_fxo_signal() got FXO sig
>         >> 2:1 [UP]
>         >> 2009-01-25 10:36:03 [DEBUG] switch_channel.c:1710
>         >> switch_channel_perform_mark_answered() Send signal
>         OpenZAP/1:1/93400534
>         >> [BREAK]
>         >> 2009-01-25 10:36:03 [NOTICE] mod_openzap.c:1180
>         on_fxo_signal() Channel
>         >> [OpenZAP/2:1/3400534] has been answered
>         >> 2009-01-25 10:36:03 [DEBUG] switch_channel.c:177
>         >> switch_channel_audio_sync() OpenZAP/2:1/3400534 receive
>         message [AUDIO_SYNC]
>         >> 2009-01-25 10:36:03 [DEBUG] switch_channel.c:1768
>         >> switch_channel_perform_answer() OpenZAP/1:1/93400534
>         receive message
>         >> [ANSWER]
>         >> 2009-01-25 10:36:03 [DEBUG] mod_openzap.c:813
>         >> channel_receive_message_fxs() Changing state on 1:1 from
>         IDLE to UP
>         >> 2009-01-25 10:36:03 [NOTICE] mod_openzap.c:814
>         >> channel_receive_message_fxs() Channel
>         [OpenZAP/1:1/93400534] has been
>         >> answered
>         >> 2009-01-25 10:36:03 [DEBUG] switch_channel.c:177
>         >> switch_channel_audio_sync() OpenZAP/1:1/93400534 receive
>         message
>         >> [AUDIO_SYNC]
>         >> 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]
>         >> 2009-01-25 10:36:03 [DEBUG] switch_ivr_originate.c:1627
>         >> switch_ivr_originate() Originate Resulted in Success:
>         [OpenZAP/2:1/3400534]
>         >> 2009-01-25 10:36:03 [DEBUG] switch_channel.c:177
>         >> switch_channel_audio_sync() OpenZAP/2:1/3400534 receive
>         message [AUDIO_SYNC]
>         >> 2009-01-25 10:36:03 [DEBUG] switch_channel.c:177
>         >> switch_channel_audio_sync() OpenZAP/1:1/93400534 receive
>         message
>         >> [AUDIO_SYNC]
>         >> 2009-01-25 10:36:03 [DEBUG] switch_ivr_bridge.c:862
>         >> switch_ivr_multi_threaded_bridge() OpenZAP/2:1/3400534
>         receive message
>         >> [BRIDGE]
>         >> 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]
>         >> 2009-01-25 10:36:03 [DEBUG] switch_ivr_bridge.c:869
>         >> switch_ivr_multi_threaded_bridge() OpenZAP/1:1/93400534
>         receive message
>         >> [BRIDGE]
>         >> 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]
>         >> 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 -> CS_EXCHANGE_MEDIA
>         >> 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]
>         >> 2009-01-25 10:36:03 [DEBUG] ozmod_analog.c:410
>         zap_analog_channel_run()
>         >> Executing state handler on 1:1 for UP
>         >> 2009-01-25 10:36:03 [DEBUG] mod_openzap.c:1212
>         on_fxs_signal() got FXS sig
>         >> [UP]
>         >> 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
>         >> 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
>         >> 2009-01-25 10:36:03 [DEBUG] switch_core_state_machine.c:457
>         >> switch_core_session_run() (OpenZAP/2:1/3400534) State
>         EXCHANGE_MEDIA
>         >> 2009-01-25 10:36:03 [DEBUG] mod_openzap.c:511
>         channel_on_exchange_media()
>         >> CHANNEL EXCHANGE_MEDIA
>         >> 2009-01-25 10:36:16 [DEBUG] ozmod_analog.c:744
>         process_event() EVENT
>         >> [ONHOOK][1:1] STATE [UP]
>         >> 2009-01-25 10:36:16 [DEBUG] ozmod_analog.c:780
>         process_event() Changing
>         >> state on 1:1 from UP to DOWN
>         >> 2009-01-25 10:36:16 [DEBUG] ozmod_analog.c:410
>         zap_analog_channel_run()
>         >> Executing state handler on 1:1 for DOWN
>         >> 2009-01-25 10:36:16 [DEBUG] mod_openzap.c:1212
>         on_fxs_signal() got FXS sig
>         >> [STOP]
>         >> 2009-01-25 10:36:16 [NOTICE] mod_openzap.c:1300
>         on_fxs_signal() Hangup
>         >> OpenZAP/1:1/93400534 [CS_EXECUTE] [NORMAL_CLEARING]
>         >> 2009-01-25 10:36:16 [DEBUG] switch_channel.c:1494
>         >> switch_channel_perform_hangup() Send signal
>         OpenZAP/1:1/93400534 [KILL]
>         >> 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]
>         >> 2009-01-25 10:36:16 [DEBUG] zap_io.c:1125
>         zap_channel_done() channel done
>         >> 1:1
>         >> 2009-01-25 10:36:16 [DEBUG] ozmod_analog.c:726
>         zap_analog_channel_run()
>         >> ANALOG CHANNEL 1:1 thread ended.
>         >> 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
>         >> 2009-01-25 10:36:16 [DEBUG] switch_ivr_bridge.c:435
>         audio_bridge_thread()
>         >> BRIDGE THREAD DONE [OpenZAP/1:1/93400534]
>         >> 2009-01-25 10:36:16 [DEBUG] switch_ivr_bridge.c:439
>         audio_bridge_thread()
>         >> Send signal OpenZAP/2:1/3400534 [BREAK]
>         >> 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
>         >> 2009-01-25 10:36:16 [DEBUG] switch_ivr_bridge.c:409
>         audio_bridge_thread()
>         >> OpenZAP/2:1/3400534 receive message [UNBRIDGE]
>         >> 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]
>         >> 2009-01-25 10:36:16 [DEBUG] switch_ivr_bridge.c:435
>         audio_bridge_thread()
>         >> BRIDGE THREAD DONE [OpenZAP/2:1/3400534]
>         >> 2009-01-25 10:36:16 [DEBUG] switch_ivr_bridge.c:439
>         audio_bridge_thread()
>         >> Send signal OpenZAP/1:1/93400534 [BREAK]
>         >> 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]
>         >> 2009-01-25 10:36:16 [DEBUG] switch_channel.c:1494
>         >> switch_channel_perform_hangup() Send signal
>         OpenZAP/2:1/3400534 [KILL]
>         >> 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]
>         >> 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
>         >> 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
>         >> 2009-01-25 10:36:16 [DEBUG] switch_core_state_machine.c:410
>         >> switch_core_session_run() (OpenZAP/2:1/3400534) State
>         HANGUP
>         >> 2009-01-25 10:36:16 [DEBUG] mod_openzap.c:429
>         channel_on_hangup() Changing
>         >> state on 2:1 from UP to HANGUP
>         >> 2009-01-25 10:36:16 [DEBUG] mod_openzap.c:472
>         channel_on_hangup()
>         >> OpenZAP/2:1/3400534 CHANNEL HANGUP
>         >> 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
>         >> 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
>         >> 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
>         >> 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
>         >> 2009-01-25 10:36:16 [NOTICE] switch_core_session.c:957
>         >> switch_core_session_thread() Session 2
>         (OpenZAP/2:1/3400534) Ended
>         >> 2009-01-25 10:36:16 [NOTICE] switch_core_session.c:959
>         >> switch_core_session_thread() Close Channel
>         OpenZAP/2:1/3400534 [CS_HANGUP]
>         >> 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
>         >> 2009-01-25 10:36:16 [DEBUG] switch_core_state_machine.c:410
>         >> switch_core_session_run() (OpenZAP/1:1/93400534) State
>         HANGUP
>         >> 2009-01-25 10:36:16 [DEBUG] mod_openzap.c:472
>         channel_on_hangup()
>         >> OpenZAP/1:1/93400534 CHANNEL HANGUP
>         >> 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
>         >> 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
>         >> 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
>         >> 2009-01-25 10:36:16 [NOTICE] switch_core_session.c:957
>         >> switch_core_session_thread() Session 1
>         (OpenZAP/1:1/93400534) Ended
>         >> 2009-01-25 10:36:16 [NOTICE] switch_core_session.c:959
>         >> switch_core_session_thread() Close Channel
>         OpenZAP/1:1/93400534 [CS_HANGUP]
>         >> 2009-01-25 10:36:16 [DEBUG] ozmod_analog.c:410
>         zap_analog_channel_run()
>         >> Executing state handler on 2:1 for HANGUP
>         >> 2009-01-25 10:36:17 [DEBUG] ozmod_analog.c:351
>         zap_analog_channel_run()
>         >> Changing state on 2:1 from HANGUP to DOWN
>         >> 2009-01-25 10:36:17 [DEBUG] ozmod_analog.c:410
>         zap_analog_channel_run()
>         >> Executing state handler on 2:1 for DOWN
>         >> 2009-01-25 10:36:17 [DEBUG] mod_openzap.c:1153
>         on_fxo_signal() got FXO sig
>         >> 2:1 [STOP]
>         >> 2009-01-25 10:36:17 [DEBUG] zap_io.c:1125
>         zap_channel_done() channel done
>         >> 2:1
>         >> 2009-01-25 10:36:17 [DEBUG] ozmod_analog.c:726
>         zap_analog_channel_run()
>         >> ANALOG CHANNEL 2:1 thread ended.
>         >>
>         >> LOG OF FAILED CALLS
>         >> ==================
>         >> 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)
>         >> 2009-01-25 10:36:55 [DEBUG] mod_openzap.c:340 tech_init()
>         Set codec PCMU
>         >> 20ms
>         >> 2009-01-25 10:36:55 [DEBUG] mod_openzap.c:1017
>         channel_outgoing_channel()
>         >> Connect outbound channel OpenZAP/2:1/3400534
>         >> 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]
>         >> 2009-01-25 10:36:55 [DEBUG] mod_openzap.c:1026
>         channel_outgoing_channel()
>         >> (OpenZAP/2:1/3400534) State Change CS_NEW -> CS_INIT
>         >> 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]
>         >> 2009-01-25 10:36:55 [DEBUG] ozmod_analog.c:52
>         analog_fxo_outgoing_call()
>         >> Changing state on 2:1 from DOWN to DIALING
>         >> 2009-01-25 10:36:55 [DEBUG] ozmod_analog.c:239
>         zap_analog_channel_run()
>         >> ANALOG CHANNEL thread starting.
>         >> 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
>         >> 2009-01-25 10:36:55 [DEBUG] ozmod_analog.c:410
>         zap_analog_channel_run()
>         >> Executing state handler on 2:1 for DIALING
>         >> 2009-01-25 10:36:55 [DEBUG] switch_core_state_machine.c:444
>         >> switch_core_session_run() (OpenZAP/2:1/3400534) State INIT
>         >> 2009-01-25 10:36:55 [DEBUG] mod_openzap.c:364
>         channel_on_init()
>         >> (OpenZAP/2:1/3400534) State Change CS_INIT -> CS_ROUTING
>         >> 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]
>         >> 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
>         >> 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
>         >> 2009-01-25 10:36:55 [DEBUG] switch_core_state_machine.c:447
>         >> switch_core_session_run() (OpenZAP/2:1/3400534) State
>         ROUTING
>         >> 2009-01-25 10:36:55 [DEBUG] mod_openzap.c:387
>         channel_on_routing()
>         >> OpenZAP/2:1/3400534 CHANNEL ROUTING
>         >> 2009-01-25 10:36:55 [DEBUG] switch_ivr_originate.c:58
>         >> originate_on_routing() (OpenZAP/2:1/3400534) State Change
>         CS_ROUTING ->
>         >> CS_CONSUME_MEDIA
>         >> 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]
>         >> 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
>         >> 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
>         >> 2009-01-25 10:36:55 [DEBUG] switch_core_state_machine.c:466
>         >> switch_core_session_run() (OpenZAP/2:1/3400534) State
>         CONSUME_MEDIA
>         >> 2009-01-25 10:37:08 [DEBUG] ozmod_analog.c:744
>         process_event() EVENT
>         >> [ONHOOK][1:1] STATE [IDLE]
>         >> 2009-01-25 10:37:08 [DEBUG] ozmod_analog.c:780
>         process_event() Changing
>         >> state on 1:1 from IDLE to DOWN
>         >> 2009-01-25 10:37:08 [DEBUG] ozmod_analog.c:410
>         zap_analog_channel_run()
>         >> Executing state handler on 1:1 for DOWN
>         >> 2009-01-25 10:37:08 [DEBUG] mod_openzap.c:1212
>         on_fxs_signal() got FXS sig
>         >> [STOP]
>         >> 2009-01-25 10:37:08 [NOTICE] mod_openzap.c:1300
>         on_fxs_signal() Hangup
>         >> OpenZAP/1:1/93400534 [CS_EXECUTE] [NORMAL_CLEARING]
>         >> 2009-01-25 10:37:08 [DEBUG] switch_channel.c:1494
>         >> switch_channel_perform_hangup() Send signal
>         OpenZAP/1:1/93400534 [KILL]
>         >> 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]
>         >> 2009-01-25 10:37:08 [DEBUG] zap_io.c:1125
>         zap_channel_done() channel done
>         >> 1:1
>         >> 2009-01-25 10:37:08 [DEBUG] ozmod_analog.c:726
>         zap_analog_channel_run()
>         >> ANALOG CHANNEL 1:1 thread ended.
>         >> 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]
>         >> 2009-01-25 10:37:08 [DEBUG] switch_channel.c:1494
>         >> switch_channel_perform_hangup() Send signal
>         OpenZAP/2:1/3400534 [KILL]
>         >> 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]
>         >> 2009-01-25 10:37:08 [DEBUG] switch_ivr_originate.c:1691
>         >> switch_ivr_originate() Originate Cancelled by originator
>         termination Cause:
>         >> 487 [ORIGINATOR_CANCEL]
>         >> 2009-01-25 10:37:08 [INFO] mod_dptools.c:1909
>         audio_bridge_function()
>         >> Originate Failed.  Cause: ORIGINATOR_CANCEL
>         >> 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
>         >> 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
>         >> 2009-01-25 10:37:08 [DEBUG] switch_core_state_machine.c:410
>         >> switch_core_session_run() (OpenZAP/1:1/93400534) State
>         HANGUP
>         >> 2009-01-25 10:37:08 [DEBUG] mod_openzap.c:472
>         channel_on_hangup()
>         >> OpenZAP/1:1/93400534 CHANNEL HANGUP
>         >> 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
>         >> 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
>         >> 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
>         >> 2009-01-25 10:37:08 [NOTICE] switch_core_session.c:957
>         >> switch_core_session_thread() Session 3
>         (OpenZAP/1:1/93400534) Ended
>         >> 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
>         >> 2009-01-25 10:37:08 [NOTICE] switch_core_session.c:959
>         >> switch_core_session_thread() Close Channel
>         OpenZAP/1:1/93400534 [CS_HANGUP]
>         >> 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
>         >> 2009-01-25 10:37:08 [DEBUG] switch_core_state_machine.c:410
>         >> switch_core_session_run() (OpenZAP/2:1/3400534) State
>         HANGUP
>         >> 2009-01-25 10:37:08 [DEBUG] mod_openzap.c:429
>         channel_on_hangup() Changing
>         >> state on 2:1 from DIALING to HANGUP
>         >> 2009-01-25 10:37:08 [DEBUG] mod_openzap.c:472
>         channel_on_hangup()
>         >> OpenZAP/2:1/3400534 CHANNEL HANGUP
>         >> 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
>         >> 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
>         >> 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
>         >> 2009-01-25 10:37:08 [NOTICE] switch_core_session.c:957
>         >> switch_core_session_thread() Session 4
>         (OpenZAP/2:1/3400534) Ended
>         >> 2009-01-25 10:37:08 [NOTICE] switch_core_session.c:959
>         >> switch_core_session_thread() Close Channel
>         OpenZAP/2:1/3400534 [CS_HANGUP]
>         >> 2009-01-25 10:37:08 [DEBUG] ozmod_analog.c:410
>         zap_analog_channel_run()
>         >> Executing state handler on 2:1 for HANGUP
>         >> 2009-01-25 10:37:09 [DEBUG] ozmod_analog.c:351
>         zap_analog_channel_run()
>         >> Changing state on 2:1 from HANGUP to DOWN
>         >> 2009-01-25 10:37:09 [DEBUG] ozmod_analog.c:410
>         zap_analog_channel_run()
>         >> Executing state handler on 2:1 for DOWN
>         >> 2009-01-25 10:37:09 [DEBUG] mod_openzap.c:1153
>         on_fxo_signal() got FXO sig
>         >> 2:1 [STOP]
>         >> 2009-01-25 10:37:09 [DEBUG] zap_io.c:1125
>         zap_channel_done() channel done
>         >> 2:1
>         >> 2009-01-25 10:37:09 [DEBUG] ozmod_analog.c:726
>         zap_analog_channel_run()
>         >> ANALOG CHANNEL 2:1 thread ended.
>         >>
>         >>
>         >>
>         >>
>         >>
>         >>
>         >> _______________________________________________
>         >> Freeswitch-users mailing list
>         >> Freeswitch-users at lists.freeswitch.org
>         >>
>         http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
>         >>
>         UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
>         >> http://www.freeswitch.org
>         >>
>         >>
>         >> _______________________________________________
>         >> Freeswitch-users mailing list
>         >> Freeswitch-users at lists.freeswitch.org
>         >>
>         http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
>         >>
>         UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
>         >> http://www.freeswitch.org
>         >>
>         >
>         >
>         > _______________________________________________
>         > Freeswitch-users mailing list
>         > Freeswitch-users at lists.freeswitch.org
>         >
>         http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
>         >
>         UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
>         > http://www.freeswitch.org
>         >
>         >
>         
>         _______________________________________________
>         Freeswitch-users mailing list
>         Freeswitch-users at lists.freeswitch.org
>         http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
>         UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
>         http://www.freeswitch.org
>         
> 
> _______________________________________________
> Freeswitch-users mailing list
> Freeswitch-users at lists.freeswitch.org
> http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
> UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
> http://www.freeswitch.org





More information about the FreeSWITCH-users mailing list