the value is dB already -7dB but for the detection section you do not specify anything but the list of frequencies needed to detect. detect-ring => 440,480 this means it needs to detect a 440+480 to know there is a dialtone, the generate value has nothing to do with it. openzap does not currently do busy detection to detect a hangup, but up in freeswitch you can use the tone_detect app to do this. On Sun, Feb 1, 2009 at 3:17 AM, Nandy Dagondon <gcd@i.ph> wrote:
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
_______________________________________________ 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