hi, i found a major one. this time i deliberately set the dialtone freq to US std on my PH definition. i expect FS wont dial at all. but to my surprise, the problem is gone!! i checked the log. it indicates successful detection of DIALTONE. going on further. i noticed FXO wont hangup on busy tone. one possibility is the volume settings. the default is -7. how many dBm is this? and what is the dB equivalent per increment? tks n rgds, nandy On Sun, Feb 1, 2009 at 4:30 PM, Nandy Dagondon <gcd@i.ph> wrote:
hi everybody,
i created [ph] tone definition per raul's suggestion and changed /etc/zaptel.conf entries to: tonezone=ph defaultzone=ph
but it didn't solve the problem. i captured the console log during start-up and shutdown. i noticed openzap related errors during shutdown. here's the snippet of the log:
STARTUP --------------- 2009-02-01 15:58:10 [NOTICE] zap_io.c:2517 zap_global_init() Modules configured: 1 2009-02-01 15:58:10 [INFO] zap_io.c:2341 zap_load_module() Loading IO from /opt/freeswitch/mod/ozmod_zt.so 2009-02-01 15:58:10 [INFO] zap_io.c:2127 load_config() auto-loaded 'zt' 2009-02-01 15:58:10 [INFO] ozmod_zt.c:186 zt_open_range() configuring device /dev/zap/channel channel 1 as OpenZAP device 1:1 fd:39 2009-02-01 15:58:10 [INFO] ozmod_zt.c:186 zt_open_range() configuring device /dev/zap/channel channel 2 as OpenZAP device 2:1 fd:40 2009-02-01 15:58:10 [INFO] zap_io.c:2265 load_config() Configured 2 channel(s) 2009-02-01 15:58:10 [INFO] zap_io.c:2358 zap_load_module() Loading SIG from /opt/freeswitch/mod/ozmod_analog.so 2009-02-01 15:58:10 [INFO] zap_io.c:2474 zap_configure_span() auto-loaded 'analog' 2009-02-01 15:58:10 [CONSOLE] switch_loadable_module.c:857 switch_loadable_module_load_file() Successfully Loaded [mod_openzap]
--- DIDN'T MAKE ANY CALL ---
SHUTDOWN ------------------ 2009-02-01 15:59:07 [NOTICE] switch_loadable_module.c:536 switch_loadable_module_unprocess() Deleting API Function 'oz' 2009-02-01 15:59:07 [CONSOLE] switch_loadable_module.c:1231 do_shutdown() Stopping: mod_openzap 2009-02-01 15:59:07 [INFO] zap_io.c:256 zap_channel_destroy() Closing channel zt:1:1 fd:39 2009-02-01 15:59:07 [INFO] zap_io.c:256 zap_channel_destroy() Closing channel zt:2:1 fd:40 2009-02-01 15:59:08 [ERR] ozmod_analog.c:899 zap_analog_run() Failure Polling event! [no matching descriptor] 2009-02-01 15:59:08 [ERR] ozmod_analog.c:899 zap_analog_run() Failure Polling event! [no matching descriptor] 2009-02-01 15:59:08 [INFO] zap_io.c:2456 zap_unload_modules() Unloading /opt/freeswitch/mod/ozmod_analog.so 2009-02-01 15:59:08 [INFO] zap_io.c:2441 zap_unload_modules() Unloading IO zt 2009-02-01 15:59:08 [INFO] zap_io.c:2456 zap_unload_modules() Unloading /opt/freeswitch/mod/ozmod_zt.so
i also notice the same ERR flag during shutdown after making test calls.
any suggestion what to do next?
tks for your assistance.
rgds, -nandy
On Tue, Jan 27, 2009 at 8:39 AM, Nandy Dagondon <gcd@i.ph> wrote:
i tested the SVN trunk version. still the same behaviour. -nandy
On Tue, Jan 27, 2009 at 12:33 AM, Anthony Minessale < anthony.minessale@gmail.com> wrote:
The unhanded type message just means that mod_openzap does not do anything with the TONE_DETECTED event that was passed up from the ozmod_analog.
On Mon, Jan 26, 2009 at 7:32 AM, Nandy Dagondon <gcd@i.ph> 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@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@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@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@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@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@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@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@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@lists.freeswitch.org http://lists.freeswitch.org/mailman/listinfo/freeswitch-users UNSUBSCRIBE: http://lists.freeswitch.org/mailman/options/freeswitch-users http://www.freeswitch.org
-- Anthony Minessale II
FreeSWITCH http://www.freeswitch.org/ ClueCon http://www.cluecon.com/
AIM: anthm MSN:anthony_minessale@hotmail.com <MSN%3Aanthony_minessale@hotmail.com> GTALK/JABBER/PAYPAL:anthony.minessale@gmail.com<PAYPAL%3Aanthony.minessale@gmail.com> IRC: irc.freenode.net #freeswitch
FreeSWITCH Developer Conference sip:888@conference.freeswitch.org <sip%3A888@conference.freeswitch.org> iax:guest@conference.freeswitch.org/888 googletalk:conf+888@conference.freeswitch.org<googletalk%3Aconf%2B888@conference.freeswitch.org> pstn:213-799-1400
_______________________________________________ Freeswitch-users mailing list Freeswitch-users@lists.freeswitch.org http://lists.freeswitch.org/mailman/listinfo/freeswitch-users UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users http://www.freeswitch.org