[Freeswitch-users] Sangoma A200 FXO Problem Outgoing

Deya M deya787 at gmail.com
Thu Jul 1 15:53:27 PDT 2010 

Hi,

I posted this problem early today, but haven't got any reply.

Problem is I cannot dial outside, I get no ring, and in the logs it ends up
with a No Answer.
I tried to dial, and configured an extension, and I was able to receive the
call.

Conf:
openzap.conf:

[span wanpipe FXO]
name => OpenZAP
fxo-channel => 1:1
fxo-channel => 1:2
fxo-channel => 1:3
fxo-channel => 1:4


openzap.conf.xml:

<configuration name="openzap.conf" description="OpenZAP Configuration">
  <settings>
    <param name="debug" value="0"/>
    <!--<param name="hold-music" value="$${moh_uri}"/>-->
    <!--<param name="enable-analog-option" value="call-swap"/>-->
    <!--<param name="enable-analog-option" value="3-way"/>-->
  </settings>
  <boost_spans>


  </boost_spans>

  <analog_spans>
          <span id="FXO">
        <!--<param name="hold-music" value="$${moh_uri}"/>-->
        <param name="dialplan" value="XML"/>
        <param name="context" value="default"/>
         <!-- 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>

#================================================
# WANPIPE1 Configuration File
#================================================
#
# Date: Mon Jul 31 17:10:23 EDT 2006
#
# Note: This file was generated automatically
#       by /usr/local/sbin/setup-sangoma program.
#
#       If you want to edit this file, it is
#       recommended that you use wancfg program
#       to do so.
#================================================
# Sangoma Technologies Inc.
#================================================

[devices]
wanpipe1 = WAN_AFT_ANALOG, Comment

[interfaces]
w1g1 = wanpipe1, , TDM_VOICE_API, Comment

[wanpipe1]
CARD_TYPE       = AFT
S514CPU         = A
CommPort        = PRI
AUTO_PCISLOT    = NO
PCISLOT         = 4
PCIBUS          = 4
FE_MEDIA        = FXO/FXS
TDMV_LAW        = ALAW
TDMV_OPERMODE   = FCC
RM_BATTTHRESH   = 3
RM_BATTDEBOUNCE = 16
FE_NETWORK_SYNC = NO
MTU             = 1500
UDPPORT         = 9000
TTL             = 255
IGNORE_FRONT_END = NO
TDMV_SPAN       = 1
TDMV_HW_DTMF    = YES
TDMV_HW_FAX_DETECT = YES

[w1g1]
ACTIVE_CH       = ALL
MTU             = 8
TDMV_HWEC       = YES


Logs:

Dialplan: sofia/internal/1001 at 196.202.51.44 parsing
[default->outgoing-sangoma] continue=false
Dialplan: sofia/internal/1001 at 196.202.51.44 Regex (PASS) [outgoing-sangoma]
destination_number(1234567890) =~
/^([0-9][0-9][0-9][0-9][0-9][0-9][0-9][0-9][0-9][0-9])$/ b
reak=on-false
Dialplan: sofia/internal/1001 at 196.202.51.44 Action
set(dialed_ext=1234567890)
Dialplan: sofia/internal/1001 at 196.202.51.44 Action
bridge(openzap/1/1/${dialed_ext})
2010-07-02 03:46:45.515582 [DEBUG] switch_core_state_machine.c:119
(sofia/internal/1001 at 196.202.51.44) State Change CS_ROUTING -> CS_EXECUTE
2010-07-02 03:46:45.515582 [DEBUG] switch_core_session.c:1027 Send signal
sofia/internal/1001 at 196.202.51.44 [BREAK]
2010-07-02 03:46:45.515582 [DEBUG] switch_core_state_machine.c:341
(sofia/internal/1001 at 196.202.51.44) State ROUTING going to sleep
2010-07-02 03:46:45.515582 [DEBUG] switch_core_state_machine.c:314
(sofia/internal/1001 at 196.202.51.44) Running State Change CS_EXECUTE
2010-07-02 03:46:45.515582 [DEBUG] switch_core_state_machine.c:348
(sofia/internal/1001 at 196.202.51.44) State EXECUTE
2010-07-02 03:46:45.515582 [DEBUG] mod_sofia.c:235 sofia/internal/
1001 at 196.202.51.44 SOFIA EXECUTE
2010-07-02 03:46:45.515582 [DEBUG] switch_core_state_machine.c:157
sofia/internal/1001 at 196.202.51.44 Standard EXECUTE
EXECUTE sofia/internal/1001 at 196.202.51.44hash(insert/196.202.51.44-spymap/1001/4da2a91b-6c21-43e2-9591-ebba049e3488)
EXECUTE sofia/internal/1001 at 196.202.51.44hash(insert/196.202.51.44-last_dial/1001/1234567890)
EXECUTE sofia/internal/1001 at 196.202.51.44hash(insert/196.202.51.44-last_dial/global/4da2a91b-6c21-43e2-9591-ebba049e3488)
EXECUTE sofia/internal/1001 at 196.202.51.44 set(dialed_ext=1234567890)
2010-07-02 03:46:45.516581 [DEBUG] mod_dptools.c:843 sofia/internal/
1001 at 196.202.51.44 SET [dialed_ext]=[1234567890]
EXECUTE sofia/internal/1001 at 196.202.51.44 bridge(openzap/1/1/1234567890)
2010-07-02 03:46:45.517583 [DEBUG] mod_openzap.c:403 Set codec PCMA 20ms
2010-07-02 03:46:45.517583 [DEBUG] mod_openzap.c:1317 Connect outbound
channel OpenZAP/1:1/1234567890
2010-07-02 03:46:45.517583 [NOTICE] switch_channel.c:776 New Channel
OpenZAP/1:1/1234567890 [6d5e43c8-39b9-45d4-9a52-4e17d4aa90d1]
2010-07-02 03:46:45.517583 [DEBUG] mod_openzap.c:1331
(OpenZAP/1:1/1234567890) State Change CS_NEW -> CS_INIT
2010-07-02 03:46:45.517583 [DEBUG] switch_core_session.c:1027 Send signal
OpenZAP/1:1/1234567890 [BREAK]
2010-07-02 03:46:45.517583 [DEBUG] ozmod_analog.c:59 Changing state on 1:1
from DOWN to DIALING
2010-07-02 03:46:45.517583 [DEBUG] ozmod_analog.c:293 ANALOG CHANNEL thread
starting.
2010-07-02 03:46:45.517583 [DEBUG] ozmod_wanpipe.c:608 Enabled DTMF events
on chan 1:1
2010-07-02 03:46:45.517583 [DEBUG] ozmod_analog.c:464 Executing state
handler on 1:1 for DIALING
2010-07-02 03:46:45.517583 [DEBUG] switch_core_state_machine.c:314
(OpenZAP/1:1/1234567890) Running State Change CS_INIT
2010-07-02 03:46:45.517583 [DEBUG] switch_core_state_machine.c:338
(OpenZAP/1:1/1234567890) State INIT
2010-07-02 03:46:45.517583 [DEBUG] mod_openzap.c:431
(OpenZAP/1:1/1234567890) State Change CS_INIT -> CS_ROUTING
2010-07-02 03:46:45.517583 [DEBUG] switch_core_session.c:1027 Send signal
OpenZAP/1:1/1234567890 [BREAK]
2010-07-02 03:46:45.517583 [DEBUG] switch_core_state_machine.c:338
(OpenZAP/1:1/1234567890) State INIT going to sleep
2010-07-02 03:46:45.517583 [DEBUG] switch_core_state_machine.c:314
(OpenZAP/1:1/1234567890) Running State Change CS_ROUTING
2010-07-02 03:46:45.517583 [DEBUG] switch_channel.c:1471
(OpenZAP/1:1/1234567890) Callstate Change DOWN -> RINGING
2010-07-02 03:46:45.518582 [DEBUG] switch_core_state_machine.c:341
(OpenZAP/1:1/1234567890) State ROUTING
2010-07-02 03:46:45.518582 [DEBUG] mod_openzap.c:454 OpenZAP/1:1/1234567890
CHANNEL ROUTING
2010-07-02 03:46:45.518582 [DEBUG] switch_ivr_originate.c:64
(OpenZAP/1:1/1234567890) State Change CS_ROUTING -> CS_CONSUME_MEDIA
2010-07-02 03:46:45.518582 [DEBUG] switch_core_session.c:1027 Send signal
OpenZAP/1:1/1234567890 [BREAK]
2010-07-02 03:46:45.518582 [DEBUG] switch_core_state_machine.c:341
(OpenZAP/1:1/1234567890) State ROUTING going to sleep
2010-07-02 03:46:45.518582 [DEBUG] switch_core_state_machine.c:314
(OpenZAP/1:1/1234567890) Running State Change CS_CONSUME_MEDIA
2010-07-02 03:46:45.518582 [DEBUG] switch_core_state_machine.c:360
(OpenZAP/1:1/1234567890) State CONSUME_MEDIA
2010-07-02 03:46:45.518582 [DEBUG] switch_core_state_machine.c:360
(OpenZAP/1:1/1234567890) State CONSUME_MEDIA going to sleep

2010-07-02 03:47:01.278384 [DEBUG] ozmod_wanpipe.c:1036 1:1 wanpipe returned
event 5
2010-07-02 03:47:01.278384 [DEBUG] ozmod_wanpipe.c:1061 1:1 rxhook, state 2
2010-07-02 03:47:02.094372 [DEBUG] ozmod_wanpipe.c:1036 1:1 wanpipe returned
event 5
2010-07-02 03:47:02.094372 [DEBUG] ozmod_wanpipe.c:1061 1:1 rxhook, state 1
2010-07-02 03:47:02.094372 [DEBUG] ozmod_analog.c:802 EVENT [ONHOOK][1:1]
STATE [DIALING]
2010-07-02 03:47:02.094372 [DEBUG] ozmod_analog.c:838 Changing state on 1:1
from DIALING to DOWN
2010-07-02 03:47:02.096373 [DEBUG] ozmod_analog.c:464 Executing state
handler on 1:1 for DOWN
2010-07-02 03:47:02.096373 [DEBUG] mod_openzap.c:1556 got FXO sig 1:1 [STOP]
2010-07-02 03:47:02.096373 [DEBUG] switch_channel.c:2261
(OpenZAP/1:1/1234567890) Callstate Change RINGING -> HANGUP
2010-07-02 03:47:02.096373 [NOTICE] mod_openzap.c:1577 Hangup
OpenZAP/1:1/1234567890 [CS_CONSUME_MEDIA] [NONE]
2010-07-02 03:47:02.096373 [DEBUG] switch_channel.c:2277 Send signal
OpenZAP/1:1/1234567890 [KILL]
2010-07-02 03:47:02.096373 [DEBUG] switch_core_session.c:1027 Send signal
OpenZAP/1:1/1234567890 [BREAK]
2010-07-02 03:47:02.096373 [DEBUG] switch_core_state_machine.c:314
(OpenZAP/1:1/1234567890) Running State Change CS_HANGUP
2010-07-02 03:47:02.096373 [DEBUG] zap_io.c:1388 channel done 1:1
2010-07-02 03:47:02.096373 [DEBUG] ozmod_analog.c:778 ANALOG CHANNEL 1:1
thread ended.
2010-07-02 03:47:02.096373 [DEBUG] switch_core_state_machine.c:500
(OpenZAP/1:1/1234567890) State HANGUP
2010-07-02 03:47:02.096373 [WARNING] mod_openzap.c:517 VETO Changing state
on 1:1 from DOWN to HANGUP
2010-07-02 03:47:02.096373 [DEBUG] mod_openzap.c:556 OpenZAP/1:1/1234567890
CHANNEL HANGUP
2010-07-02 03:47:02.096373 [DEBUG] switch_core_state_machine.c:46
OpenZAP/1:1/1234567890 Standard HANGUP, cause: NONE
2010-07-02 03:47:02.096373 [DEBUG] switch_core_state_machine.c:500
(OpenZAP/1:1/1234567890) State HANGUP going to sleep
2010-07-02 03:47:02.098372 [DEBUG] switch_core_state_machine.c:333
(OpenZAP/1:1/1234567890) State Change CS_HANGUP -> CS_REPORTING
2010-07-02 03:47:02.098372 [DEBUG] switch_core_session.c:1027 Send signal
OpenZAP/1:1/1234567890 [BREAK]
2010-07-02 03:47:02.098372 [DEBUG] switch_core_state_machine.c:314
(OpenZAP/1:1/1234567890) Running State Change CS_REPORTING
2010-07-02 03:47:02.098372 [DEBUG] switch_core_state_machine.c:591
(OpenZAP/1:1/1234567890) State REPORTING
2010-07-02 03:47:02.098372 [DEBUG] switch_core_state_machine.c:53
OpenZAP/1:1/1234567890 Standard REPORTING, cause: NONE
2010-07-02 03:47:02.098372 [DEBUG] switch_core_state_machine.c:591
(OpenZAP/1:1/1234567890) State REPORTING going to sleep
2010-07-02 03:47:02.098372 [DEBUG] switch_core_state_machine.c:327
(OpenZAP/1:1/1234567890) State Change CS_REPORTING -> CS_DESTROY
2010-07-02 03:47:02.098372 [DEBUG] switch_core_session.c:1027 Send signal
OpenZAP/1:1/1234567890 [BREAK]
2010-07-02 03:47:02.098372 [DEBUG] switch_core_session.c:1175 Session 26
(OpenZAP/1:1/1234567890) Locked, Waiting on external entities
2010-07-02 03:47:02.098372 [DEBUG] switch_ivr_originate.c:3369 Originate
Resulted in Error Cause: 19 [NO_ANSWER]
2010-07-02 03:47:02.098372 [INFO] mod_dptools.c:2382 Originate Failed.
 Cause: NO_ANSWER
2010-07-02 03:47:02.098372 [NOTICE] switch_core_session.c:1193 Session 26
(OpenZAP/1:1/1234567890) Ended
2010-07-02 03:47:02.098372 [NOTICE] switch_core_session.c:1195 Close Channel
OpenZAP/1:1/1234567890 [CS_DESTROY]
2010-07-02 03:47:02.098372 [DEBUG] switch_core_state_machine.c:427
(OpenZAP/1:1/1234567890) Callstate Change HANGUP -> DOWN
2010-07-02 03:47:02.098372 [DEBUG] switch_core_state_machine.c:430
(OpenZAP/1:1/1234567890) Running State Change CS_DESTROY
2010-07-02 03:47:02.098372 [DEBUG] switch_core_state_machine.c:440
(OpenZAP/1:1/1234567890) State DESTROY
2010-07-02 03:47:02.098372 [DEBUG] switch_core_state_machine.c:60
OpenZAP/1:1/1234567890 Standard DESTROY
2010-07-02 03:47:02.098372 [DEBUG] switch_core_state_machine.c:440
(OpenZAP/1:1/1234567890) State DESTROY going to sleep
2010-07-02 03:47:02.098372 [NOTICE] switch_core_state_machine.c:185
sofia/internal/1001 at 196.202.51.44 has executed the last dialplan
instruction, hanging up.
2010-07-02 03:47:02.098372 [DEBUG] switch_channel.c:2261 (sofia/internal/
1001 at 196.202.51.44) Callstate Change RINGING -> HANGUP
2010-07-02 03:47:02.098372 [NOTICE] switch_core_state_machine.c:187 Hangup
sofia/internal/1001 at 196.202.51.44 [CS_EXECUTE] [NORMAL_CLEARING]
2010-07-02 03:47:02.098372 [DEBUG] switch_channel.c:2277 Send signal
sofia/internal/1001 at 196.202.51.44 [KILL]
2010-07-02 03:47:02.098372 [DEBUG] switch_core_session.c:1027 Send signal
sofia/internal/1001 at 196.202.51.44 [BREAK]
2010-07-02 03:47:02.098372 [DEBUG] switch_core_state_machine.c:348
(sofia/internal/1001 at 196.202.51.44) State EXECUTE going to sleep
2010-07-02 03:47:02.098372 [DEBUG] switch_core_state_machine.c:314
(sofia/internal/1001 at 196.202.51.44) Running State Change CS_HANGUP
2010-07-02 03:47:02.098372 [DEBUG] switch_core_state_machine.c:500
(sofia/internal/1001 at 196.202.51.44) State HANGUP
2010-07-02 03:47:02.098372 [DEBUG] mod_sofia.c:453 Channel sofia/internal/
1001 at 196.202.51.44 hanging up, cause: NORMAL_CLEARING
2010-07-02 03:47:02.104376 [DEBUG] mod_sofia.c:515 Responding to INVITE
with: 480
2010-07-02 03:47:02.104376 [DEBUG] switch_core_state_machine.c:46
sofia/internal/1001 at 196.202.51.44 Standard HANGUP, cause: NORMAL_CLEARING
2010-07-02 03:47:02.104376 [DEBUG] switch_core_state_machine.c:500
(sofia/internal/1001 at 196.202.51.44) State HANGUP going to sleep
2010-07-02 03:47:02.106398 [DEBUG] switch_core_state_machine.c:333
(sofia/internal/1001 at 196.202.51.44) State Change CS_HANGUP -> CS_REPORTING
2010-07-02 03:47:02.106398 [DEBUG] switch_core_session.c:1027 Send signal
sofia/internal/1001 at 196.202.51.44 [BREAK]
2010-07-02 03:47:02.106398 [DEBUG] switch_core_state_machine.c:314
(sofia/internal/1001 at 196.202.51.44) Running State Change CS_REPORTING
2010-07-02 03:47:02.106398 [DEBUG] switch_core_state_machine.c:591
(sofia/internal/1001 at 196.202.51.44) State REPORTING
2010-07-02 03:47:02.106398 [DEBUG] switch_core_state_machine.c:53
sofia/internal/1001 at 196.202.51.44 Standard REPORTING, cause: NORMAL_CLEARING
2010-07-02 03:47:02.106398 [DEBUG] switch_core_state_machine.c:591
(sofia/internal/1001 at 196.202.51.44) State REPORTING going to sleep
2010-07-02 03:47:02.106398 [DEBUG] switch_core_state_machine.c:327
(sofia/internal/1001 at 196.202.51.44) State Change CS_REPORTING -> CS_DESTROY
2010-07-02 03:47:02.106398 [DEBUG] switch_core_session.c:1027 Send signal
sofia/internal/1001 at 196.202.51.44 [BREAK]
2010-07-02 03:47:02.106398 [DEBUG] switch_core_session.c:1175 Session 25
(sofia/internal/1001 at 196.202.51.44) Locked, Waiting on external entities
2010-07-02 03:47:02.106398 [NOTICE] switch_core_session.c:1193 Session 25
(sofia/internal/1001 at 196.202.51.44) Ended
2010-07-02 03:47:02.106398 [NOTICE] switch_core_session.c:1195 Close Channel
sofia/internal/1001 at 196.202.51.44 [CS_DESTROY]
2010-07-02 03:47:02.106398 [DEBUG] switch_core_state_machine.c:427
(sofia/internal/1001 at 196.202.51.44) Callstate Change HANGUP -> DOWN
2010-07-02 03:47:02.106398 [DEBUG] switch_core_state_machine.c:430
(sofia/internal/1001 at 196.202.51.44) Running State Change CS_DESTROY
2010-07-02 03:47:02.106398 [DEBUG] switch_core_state_machine.c:440
(sofia/internal/1001 at 196.202.51.44) State DESTROY
2010-07-02 03:47:02.106398 [DEBUG] mod_sofia.c:358 sofia/internal/
1001 at 196.202.51.44 SOFIA DESTROY
2010-07-02 03:47:02.106398 [DEBUG] switch_core_state_machine.c:60
sofia/internal/1001 at 196.202.51.44 Standard DESTROY
2010-07-02 03:47:02.106398 [DEBUG] switch_core_state_machine.c:440
(sofia/internal/1001 at 196.202.51.44) State DESTROY going to sleep
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20100702/2bacec89/attachment-0001.html

More information about the FreeSWITCH-users mailing list