[Freeswitch-users] TDM400 FXO can dialout only once
Nandy Dagondon
gcd at i.ph
Sun Jan 25 00:21:45 PST 2009
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.
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20090125/42bdb64a/attachment-0002.html
More information about the FreeSWITCH-users
mailing list