CAPI problem: dialling out

[Arik Raffael Funke]

Hi,

I am working on getting callweaver to run on AVM Fritz!Box 7270. (DSL
Router with integrated ISDN ports.)

Everything seems to be working more or less as it should (calling
internally, accepting calls from outside) but I am having problems
dialling out:

The called phone never rings and using "capi debug" callweaver keeps
repeating the following two lines until the call is hung up:
-- ISDN_EXTERN#02: DATA_B3_IND (len=160) fr.datalen=160 fr.subclass=8
-- ISDN_INTERN#02: DATA_B3_IND (len=160) fr.datalen=160 fr.subclass=8

A fuller debug log is attached. (Note the repeating lines were cut. See
the comment in the log.)

I would really appreciate if somebody could give me a hint on where to
continue searching for the problem.

Many thanky,
Arik


========= Problem Log ==============

-- Executing [***@intern:1]
Dial("CAPI/ISDN_INTERN/015123456789-14", "CAPI/ISDN_EXTERN/015123456789")

data = ISDN_EXTERN/015123456789 format=8
parsed dialstring: 'ISDN_EXTERN' 'NULL' '015123456789' ''
capi request for interface 'ISDN_EXTERN'

== ISDN_EXTERN#02: setting format alaw - 0x8 (alaw)

parsed dialstring: 'ISDN_EXTERN' 'NULL' '015123456789' ''

== ISDN_EXTERN#02: Call CAPI/ISDN_EXTERN/015123456789-15
(pres=0x00, ton=0x00)

CAPI devicestate requested for ISDN_EXTERN/015123456789

-- Called ISDN_EXTERN/015123456789

CAPI devicestate requested for ISDN_EXTERN/015123456789

-- ISDN_INTERN#02: info element SETUP ACK


-- ISDN_INTERN#02: info element PI 81 88

ISDN_INTERN#02: In-band information available

-- CAPI queue frame: [ TYPE: Control (4) SUBCLASS: Unknown control
'14' (14) ] [ISDN_INTERN#02]


-- ISDN_INTERN#02: unhandled INFO_IND 0xc000 (PLCI=0x1403)

-- ISDN_EXTERN#02: received CONNECT_CONF PLCI = 0x1501
*CLI>
*CLI>
-- ISDN_EXTERN#02: info element SETUP ACK
*CLI>
*CLI>
-- ISDN_EXTERN#02: info element CHANNEL IDENTIFICATION 8a
*CLI>
*CLI>
-- ISDN_EXTERN#02: unhandled INFO_IND 0xc000 (PLCI=0x1501)
*CLI>
*CLI>
*CLI>
*CLI>
*CLI>
-- ISDN_EXTERN#02: info element CALL PROCEEDING
-- CAPI queue frame: [ TYPE: Control (4) SUBCLASS: Unknown control
'15' (15) ] [ISDN_EXTERN#02]
-- CAPI/ISDN_EXTERN/015123456789-15 is proceeding passing it to
CAPI/ISDN_INTERN/015123456789-14
== ISDN_INTERN#02: Requested PROCEEDING-Indication for
CAPI/ISDN_INTERN/015123456789-14
*CLI>
*CLI>
*CLI>
-- ISDN_EXTERN#02: info element PI 82 88

ISDN_EXTERN#02: In-band information available

-- CAPI queue frame: [ TYPE: Control (4) SUBCLASS: Unknown control
'14' (14) ] [ISDN_EXTERN#02]
-- CAPI/ISDN_EXTERN/015123456789-15 is making progress passing it
to CAPI/ISDN_INTERN/015123456789-14
== ISDN_INTERN#02: Requested PROGRESS-Indication for
CAPI/ISDN_INTERN/015123456789-14

*CLI>

-- ISDN_EXTERN#02: info element NOTIFICATION INDICATOR '?' (0xfb)


-- ISDN_EXTERN#02: unhandled INFO_IND 0xc000 (PLCI=0x1501)

Feb 6 14:27:45 WARNING[9225]: chan_capi.c:3864 show_capi_conf_error:
ISDN_INTERN#02: conf_error 0x2001 PLCI=0x1403
Command=SELECT_B_PROTOCOL_CONF,0x8495

ISDN_INTERN#02: CAPI INFO 0x2001: Message not supported in

current state

Feb 6 14:27:45 WARNING[9225]: chan_capi.c:3864 show_capi_conf_error:
ISDN_INTERN#02: conf_error 0x2001 PLCI=0x1403
Command=SELECT_B_PROTOCOL_CONF,0x8495

ISDN_INTERN#02: CAPI INFO 0x2001: Message not supported in

current state
*CLI>

-- ISDN_EXTERN#02: info element CONNECT


-- ISDN_EXTERN#02: info element Date/Time 12/02/06 14:27


-- ISDN_EXTERN#02: unhandled INFO_IND 0x76 (PLCI=0x1501)


-- ISDN_EXTERN#02: unhandled INFO_IND 0xc000 (PLCI=0x1501)



-- ISDN_EXTERN#02: sent CONNECT_B3_REQ PLCI=0x1501



-- CAPI queue frame: [ TYPE: Control (4) SUBCLASS: Answer (4) ]
[ISDN_EXTERN#02]
-- CAPI/ISDN_EXTERN/015123456789-15 answered
CAPI/ISDN_INTERN/015123456789-14
== ISDN_INTERN#02: Answering for 015123456789

CAPI devicestate requested for ISDN_EXTERN/015123456789

*CLI>
== ISDN_INTERN#02:ISDN_EXTERN#02 Requested native bridge for
CAPI/ISDN_INTERN/015123456789-14 and CAPI/ISDN_EXTERN/015123456789-15
*CLI>

CAPI devicestate requested for ISDN_INTERN/015123456789

*CLI>


== ISDN_INTERN#02: Setting up DTMF detector (PLCI=0x1403, flag=1)

ISDN_INTERN#02: DTMF conf(PLCI=0x1403)

-- ISDN_EXTERN#02: DATA_B3_IND (len=160) fr.datalen=160 fr.subclass=8
*CLI>
*CLI>

-- ISDN_INTERN#02: DATA_B3_IND (len=160) fr.datalen=160 fr.subclass=8
*CLI>
*CLI>

============ last two messages keep repeating until hangup ==========

*CLI>
*CLI>
*CLI>

-- ISDN_INTERN#02: info element DISCONNECT
-- ISDN_INTERN#02: Disconnect case 3
-- CAPI queue frame: [ TYPE: Control (4) SUBCLASS: Hangup (1) ]
[ISDN_INTERN#02]

== ISDN_EXTERN#02: CAPI Hangingup for PLCI=0x1501 in state 2
-- ISDN_EXTERN#02: activehangingup (cause=16) for PLCI=0x1501
*CLI>
-- ISDN_INTERN#02: info element CAUSE 00 80


-- ISDN_INTERN#02: unhandled INFO_IND 0xc000 (PLCI=0x1403)

*CLI>
ISDN_EXTERN#02: wait for (0x8481)
*CLI>




ISDN_EXTERN#02: found and signal for

ISDN_EXTERN#02: cond signal received for
== Spawn extension (intern, 015123456789, 1) exited non-zero on
'CAPI/ISDN_INTERN/015123456789-14'

CAPI devicestate requested for ISDN_EXTERN/015123456789
CAPI devicestate requested for ISDN_EXTERN/015123456789

*CLI>
*CLI>
*CLI>
== ISDN_INTERN#02: CAPI Hangingup for PLCI=0x1403 in state 2
-- ISDN_INTERN#02: activehangingup (cause=0) for PLCI=0x1403
*CLI>
*CLI>
ISDN_INTERN#02: wait for (0x481)
ISDN_INTERN#02: found and signal for
ISDN_INTERN#02: cond signal received for

CAPI devicestate requested for ISDN_INTERN/015123456789
CAPI devicestate requested for ISDN_INTERN/015123456789

*CLI>

== ISDN_INTERN#02: Interface cleanup PLCI=0x1403
*CLI>

== ISDN_EXTERN#02: Interface cleanup PLCI=0x1501
*CLI>