[asterisk-users] Zaptel FXO offhook when connected to PSTN

CSB kjcsb at xnet.co.nz
Mon Oct 20 21:20:04 CDT 2008 

>> I installed Trixbox and a TDM400P with 2 FXO and 2 FXS ports and am
having
>> an annoying issue with the FXO ports. As soon as I plug either one into
the
>> phone line it's as though the line is disconnected i.e. get disconnected
>> tone when trying to dial out, line is busy when dialling in.
>
>Err... it should be exactly the other way around. You should have an
>alarm when you disconnect.
>
That seems to be the case now (see below). Perhaps I mixed it up yesterday.

>What version of zaptel is it?
>
>  cat /sys/modules/zaptel/version
1.4.9.2-

Curiously, I installed zaptel-1.4.12.1 but it still reports 1.4.9.2-.

>To see the status of alarms: 
>
>  cat /proc/zaptel/1 
>
>If there is 'RED' on a channel, it is in alarm.
Span 1: WCTDM/0 "Wildcard TDM400P REV I Board 1" (MASTER)

           1 WCTDM/0/0 FXOKS (In use)
           2 WCTDM/0/1 FXOKS (In use)
           3 WCTDM/0/2 FXSKS (In use)
           4 WCTDM/0/3 FXSKS (In use)

(Same whether plugged in or not)

Plug in
[Oct 21 15:05:09] DEBUG[18892] chan_dahdi.c: Monitor doohicky got event No
more alarm on channel 4
[Oct 21 15:05:09] NOTICE[18892] chan_dahdi.c: Alarm cleared on channel 4

dahdi show channel 4
Channel: 4LI>
File Descriptor: 15
Span: 1
Extension:
Dialing: no
Context: from-pstn
Caller ID:
Calling TON: 0
Caller ID name:
Destroy: 0
InAlarm: 0
Signalling Type: FXS Kewlstart
Radio: 0
Owner: <None>
Real: <None>
Callwait: <None>
Threeway: <None>
Confno: -1
Propagated Conference: -1
Real in conference: 0
DSP: no
Relax DTMF: no
Dialing/CallwaitCAS: 0/0
Default law: ulaw
Fax Handled: no
Pulse phone: no
Echo Cancellation: 128 taps unless TDM bridged, currently OFF
Actual Confinfo: Num/0, Mode/0x0000
Actual Confmute: No
Hookstate (FXS only): Offhook

Dial
[Oct 21 15:05:23] DEBUG[18916] chan_dahdi.c: Using channel 4
[Oct 21 15:05:23] DEBUG[18916] rtp.c: Channel 'Zap/4-1' has no RTP, not
doing anything
[Oct 21 15:05:23] DEBUG[18916] chan_dahdi.c: Dialing '4412335'
[Oct 21 15:05:23] DEBUG[18916] chan_dahdi.c: Deferring dialing...
[Oct 21 15:05:23] DEBUG[18916] devicestate.c: Notification of state change
to be queued on device/channel Zap/4
[Oct 21 15:05:23] VERBOSE[18916] logger.c: [Oct 21 15:05:23]     -- Called
g0/4412335
[Oct 21 15:05:23] DEBUG[18916] chan_dahdi.c: Dropping frame since I'm still
dialing on Zap/4-1...
[Oct 21 15:05:23] DEBUG[18687] devicestate.c: No provider found, checking
channel drivers for Zap - 4
[Oct 21 15:05:23] DEBUG[18687] devicestate.c: Changing state for Zap/4 -
state 2 (In use)
[Oct 21 15:05:23] DEBUG[18707] app_queue.c: Device 'Zap/4' changed to state
'2' (In use) but we don't care because they're not a member of any queue.
[Oct 21 15:05:23] DEBUG[18916] chan_dahdi.c: Dropping frame since I'm still
dialing on Zap/4-1...
Numerous of these
[Oct 21 15:05:24] DEBUG[18916] chan_dahdi.c: Exception on 15, channel 4
[Oct 21 15:05:24] DEBUG[18916] chan_dahdi.c: Got event Hook Transition
Complete(12) on channel 4 (index 0)
[Oct 21 15:05:24] DEBUG[18916] chan_dahdi.c: Sent deferred digit string:
T4412335w
[Oct 21 15:05:24] DEBUG[18916] chan_dahdi.c: Dropping frame since I'm still
dialing on Zap/4-1...
More of these
[Oct 21 15:05:26] DEBUG[18916] chan_dahdi.c: Exception on 15, channel 4
[Oct 21 15:05:26] DEBUG[18916] chan_dahdi.c: Got event Dial Complete(9) on
channel 4 (index 0)
[Oct 21 15:05:26] DEBUG[18916] chan_dahdi.c: Enabled echo cancellation on
channel 4
[Oct 21 15:05:26] DEBUG[18916] devicestate.c: Notification of state change
to be queued on device/channel Zap/4
[Oct 21 15:05:26] VERBOSE[18916] logger.c: [Oct 21 15:05:26]     -- Zap/4-1
answered Zap/1-1
[Oct 21 15:05:26] DEBUG[18916] rtp.c: Channel 'Zap/1-1' has no RTP, not
doing anything
[Oct 21 15:05:26] DEBUG[18916] devicestate.c: Notification of state change
to be queued on device/channel Zap/1
[Oct 21 15:05:26] DEBUG[18916] chan_dahdi.c: Took Zap/1-1 off hook
[Oct 21 15:05:26] DEBUG[18916] chan_dahdi.c: Requested indication 20 on
channel Zap/1-1
[Oct 21 15:05:26] DEBUG[18916] chan_dahdi.c: Requested indication 20 on
channel Zap/4-1
[Oct 21 15:05:26] DEBUG[18916] chan_dahdi.c: master: 1, slave: 4, nothingok:
0
[Oct 21 15:05:26] DEBUG[18916] chan_dahdi.c: Stopping tones on 1/0 talking
to 4/0
[Oct 21 15:05:26] DEBUG[18916] chan_dahdi.c: Stopping tones on 4/0 talking
to 1/0
[Oct 21 15:05:26] DEBUG[18916] chan_dahdi.c: disabled echo cancellation on
channel 1
[Oct 21 15:05:26] DEBUG[18916] chan_dahdi.c: disabled echo cancellation on
channel 4
[Oct 21 15:05:26] DEBUG[18916] chan_dahdi.c: Making 4 slave to master 1 at 0
[Oct 21 15:05:26] DEBUG[18916] chan_dahdi.c: Added 15 to conference 9/1
[Oct 21 15:05:26] DEBUG[18916] chan_dahdi.c: Added 11 to conference 9/4
[Oct 21 15:05:26] DEBUG[18916] chan_dahdi.c: Updated conferencing on 1, with
0 conference users
[Oct 21 15:05:26] DEBUG[18916] chan_dahdi.c: Updated conferencing on 4, with
0 conference users
[Oct 21 15:05:26] VERBOSE[18916] logger.c: [Oct 21 15:05:26]     -- Native
bridging Zap/1-1 and Zap/4-1
[Oct 21 15:05:26] DEBUG[18687] devicestate.c: No provider found, checking
channel drivers for Zap - 4
[Oct 21 15:05:26] DEBUG[18687] devicestate.c: Changing state for Zap/4 -
state 2 (In use)
[Oct 21 15:05:26] DEBUG[18687] devicestate.c: No provider found, checking
channel drivers for Zap - 1
[Oct 21 15:05:26] DEBUG[18687] devicestate.c: Changing state for Zap/1 -
state 2 (In use)
[Oct 21 15:05:26] DEBUG[18687] devicestate.c: No provider found, checking
channel drivers for ZAP - 1
[Oct 21 15:05:26] DEBUG[18707] app_queue.c: Device 'Zap/4' changed to state
'2' (In use) but we don't care because they're not a member of any queue.
[Oct 21 15:05:26] DEBUG[18707] app_queue.c: Device 'Zap/1' changed to state
'2' (In use) but we don't care because they're not a member of any queue.
[Oct 21 15:05:30] DEBUG[18916] chan_dahdi.c: Exception on 11, channel 1
[Oct 21 15:05:30] DEBUG[18916] chan_dahdi.c: Got event On hook(1) on channel
1 (index 0)
[Oct 21 15:05:30] DEBUG[18916] chan_dahdi.c: disabled echo cancellation on
channel 1
[Oct 21 15:05:30] DEBUG[18916] chan_dahdi.c: Enabled echo cancellation on
channel 1
[Oct 21 15:05:30] DEBUG[18916] chan_dahdi.c: Enabled echo cancellation on
channel 4
[Oct 21 15:05:30] DEBUG[18916] chan_dahdi.c: Unlinking slave 4 from 1
[Oct 21 15:05:30] DEBUG[18916] chan_dahdi.c: Removed 15 from conference 9/1
[Oct 21 15:05:30] DEBUG[18916] chan_dahdi.c: Removed 11 from conference 9/4
[Oct 21 15:05:30] DEBUG[18916] chan_dahdi.c: Updated conferencing on 1, with
0 conference users
[Oct 21 15:05:30] DEBUG[18916] channel.c: Returning from native bridge,
channels: Zap/1-1, Zap/4-1
[Oct 21 15:05:30] DEBUG[18916] cdr_addon_mysql.c: cdr_mysql: inserting a CDR
record.
[Oct 21 15:05:30] DEBUG[18916] cdr_addon_mysql.c: cdr_mysql: SQL command as
follows: INSERT INTO cdr
(calldate,clid,src,dst,dcontext,channel,dstchannel,lastapp,lastdata,duration
,billsec,disposition,amaflags,accountcode,uniqueid,userfield) VALUES
('2008-10-21 15:05:15','\"test\" <201>','201','94412335','from-internal',
'Zap/1-1','Zap/4-1','Dial','ZAP/g0/4412335|300|',15,4,'ANSWERED',3,'','12245
54715.3','')
[Oct 21 15:05:30] DEBUG[18916] channel.c: Hanging up channel 'Zap/4-1'
[Oct 21 15:05:30] DEBUG[18916] chan_dahdi.c: dahdi_hangup(Zap/4-1)
[Oct 21 15:05:30] DEBUG[18916] chan_dahdi.c: Hangup: channel: 4 index = 0,
normal = 15, callwait = -1, thirdcall = -1
[Oct 21 15:05:30] DEBUG[18916] chan_dahdi.c: disabled echo cancellation on
channel 4
[Oct 21 15:05:30] DEBUG[18916] chan_dahdi.c: Set option TDD MODE, value:
OFF(0) on Zap/4-1
[Oct 21 15:05:30] DEBUG[18916] chan_dahdi.c: Updated conferencing on 4, with
0 conference users
[Oct 21 15:05:30] VERBOSE[18916] logger.c: [Oct 21 15:05:30]     -- Hungup
'Zap/4-1'

Unplug
[Oct 21 15:05:33] DEBUG[18892] chan_dahdi.c: Monitor doohicky got event
Alarm on channel 4
[Oct 21 15:05:33] WARNING[18892] chan_dahdi.c: Detected alarm on channel 4:
Red Alarm

dahdi show channel 4
Channel: 4LI>
File Descriptor: 15
Span: 1
Extension:
Dialing: no
Context: from-pstn
Caller ID:
Calling TON: 0
Caller ID name:
Destroy: 0
InAlarm: 1
Signalling Type: FXS Kewlstart
Radio: 0
Owner: <None>
Real: <None>
Callwait: <None>
Threeway: <None>
Confno: -1
Propagated Conference: -1
Real in conference: 0
DSP: no
Relax DTMF: no
Dialing/CallwaitCAS: 0/0
Default law: ulaw
Fax Handled: no
Pulse phone: no
Echo Cancellation: 128 taps unless TDM bridged, currently OFF
Actual Confinfo: Num/0, Mode/0x0000
Actual Confmute: No
Hookstate (FXS only): Onhook

So to reiterate, as soon as the line is plugged into the FXO port the line
is busy (can't dial into the number). When I dial out I can faintly hear the
busy tone from the FXO side on the phone connected to the FXS port.

Again, any advice appreciated.

Regards

Cameron

More information about the asterisk-users mailing list