No sound from LCR -> ISDN-TE

Perhaps this question is somewhat outdated.

I still own an ISDN line and try to use lcr as an ISDN<->SIP gateway. My
problem is, that sound does not propagate from lcr to my TE port. The
other direction works fine. Sound in both directions also works fine, if
I use misdntestlayer3 from mISDNuser. The following log shows an attempt
to contact my vbox:

port0 pc-00010001 dss1 TE state 0 from down SETUP port0 pc-00010001
state 0 --> 6 DEBUG (in stack2manager() line 2956): cmd(0x5)
pid(0x10001) DEBUG (in Port() line 212): new port (3) of type 0x1111,
name 'Ext-0-in' interface 'Ext' DEBUG (in PmISDN() line 193): Created
new mISDNPort(Ext-0-in). Currently 1 objects use, port #0 DEBUG (in
Pdss1() line 45): Created new mISDNPort(Ext-0-in). Currently 1 objects
use, TE port #0 TRACE : 27.03.19 13:24:21.133 CH(3): MT_NEW_L3ID
INDICATION iface Ext port 0 callref new=0x10001 TRACE : 27.03.19
13:24:21.133 CH(3): MT_SETUP INDICATION U<-N iface Ext port 0 calling_pn
type=2 plan=1 present=0 screen=0 number=2111111111 call_pn 2 type=2
plan=1 present=0 screen=3 number=2111111111 called_pn type=4 plan=1
number=9999999 complete channel_id exclusive=1 channel=1 bearer coding=0
capability=16 mode=0 rate=16 multi=-1 user=3 TRACE : 27.03.19
13:24:21.133 CH(3): CHANNEL SELECTION (setup) iface Ext port 0 channel
request='1 (forced)' reserved=0 conclusion 'channel available' connect
channel=1 DEBUG (in seize_bchannel() line 822): PmISDN(Ext-0-in) seizing
bchannel 1 (index 0) ERROR (in _bchannel_create() line 433): Error:
Failed to bind bchannel-socket for index 0 with mISDN-DSP layer
(errno=92). Did you load mISDN_dsp.ko? DEBUG (in Endpoint() line 48):
EPOINT(2): Allocating enpoint 2 and connecting it with: ioport DEBUG (in
portlist_new() line 150): EPOINT(2) allocating port_list, attaching to
port 3 DEBUG (in epointlist_new() line 131): PORT(3) allocating
epoint_list. DEBUG (in _message_put() line 70): message MESSAGE_SETUP
written from 3 to 2 (memory b775b0e0 at file dss1.cpp, line 748) DEBUG
(in new_state() line 285): PORT(Ext-0-in) new state PORT_STATE_IDLE -->
PORT_STATE_IN_SETUP DEBUG (in message_get() line 115): message
MESSAGE_SETUP reading from 3 to 2 (memory b775b0e0) DEBUG (in
ea_message_port() line 2527): EPOINT(2) incoming call from
callerid=2111111111, dialing=9999999 TRACE : 27.03.19 13:24:21.133
EP(2): SETUP from CH(3) interface from=Ext caller id number=02111111111
present=allowed caller id2 number=02111111111 present=allowed dialing
9999999 complete true TRACE : 27.03.19 13:24:21.134 --: SCREEN (found in
screen list) iface Ext given type=national present=allowed id=2111111111
used id=02111111111 TRACE : 27.03.19 13:24:21.134 --: SCREEN (found in
screen list) iface Ext given type=national present=allowed id=2111111111
used id=02111111111 DEBUG (in port_setup() line 1415): EPOINT(2)
incoming call is external or voip DEBUG (in port_setup() line 1496):
EPOINT(2) call from external port DEBUG (in _message_put() line 70):
message MESSAGE_TONE written from 2 to 3 (memory b7765da0 at file
apppbx.cpp, line 597) TRACE : 27.03.19 13:24:21.134 EP(2): TONE to CH(3)
directory default name dialing DEBUG (in process_dialing() line 2591):
EPOINT(2): terminal '' dialing: '9999999', checking matching rule of
ruleset 'main' DEBUG (in route() line 1977): parsing ruleset 'main'
DEBUG (in route() line 1979): checking rule in line 8 DEBUG (in route()
line 1979): checking rule in line 9 TRACE : 27.03.19 13:24:21.134 EP(2):
ACTION (match) action goto line 9 DEBUG (in process_dialing() line
2615): EPOINT(2): a rule with action 'goto' matches. DEBUG (in
process_dialing() line 2663): EPOINT(2): terminal '' action: goto
(dialing '9999999') DEBUG (in process_dialing() line 2666): EPOINT(2):
terminal : current action 'goto' has a dialing function, so we call
it... DEBUG (in getrulesetbyname() line 1928): ruleset extern found.
TRACE : 27.03.19 13:24:21.134 EP(2): ACTION goto/menu (change to)
ruleset extern dialing 9999999 DEBUG (in process_dialing() line 2591):
EPOINT(2): terminal '' dialing: '9999999', checking matching rule of
ruleset 'extern' DEBUG (in route() line 1977): parsing ruleset 'extern'
DEBUG (in route() line 1979): checking rule in line 17 DEBUG (in route()
line 1979): checking rule in line 18 TRACE : 27.03.19 13:24:21.134
EP(2): ACTION (match) action vbox-play line 18 DEBUG (in
process_dialing() line 2615): EPOINT(2): a rule with action 'vbox-play'
matches. DEBUG (in process_dialing() line 2652): EPOINT(2): terminal :
current action 'vbox-play' has a init function, so we call it... DEBUG
(in _message_put() line 70): message MESSAGE_CONNECT written from 2 to 3
(memory b7769880 at file action_vbox.cpp, line 96) TRACE : 27.03.19
13:24:21.134 EP(2): CONNECT to CH(3) connect id number= present='not
available' DEBUG (in action_init_vbox_play() line 100): EPOINT(2)
initializing answering vbox state DEBUG (in _message_put() line 70):
message MESSAGE_VBOX_TONE written from 2 to 3 (memory b776d360 at file
action_vbox.cpp, line 852) DEBUG (in set_tone_vbox() line 854):
EPOINT(2) terminal set tone 'menu' DEBUG (in vbox_index_read() line
139): EPOINT(2) no files in index DEBUG (in action_init_vbox_play() line
110): EPOINT(2) number of calls: 0 DEBUG (in _message_put() line 70):
message MESSAGE_VBOX_TONE written from 2 to 3 (memory b7770e40 at file
action_vbox.cpp, line 852) DEBUG (in set_tone_vbox() line 854):
EPOINT(2) terminal set tone 'nothing' DEBUG (in process_dialing() line
2663): EPOINT(2): terminal '' action: vbox-play (dialing '') DEBUG (in
process_dialing() line 2666): EPOINT(2): terminal : current action
'vbox-play' has a dialing function, so we call it... DEBUG (in
action_dialing_vbox_play() line 241): EPOINT(2) called with no digit
DEBUG (in message_get() line 115): message MESSAGE_TONE reading from 2
to 3 (memory b7765da0) DEBUG (in message_epoint() line 643):
PORT(Ext-0-in) setting tone 'dialing' dir '' DEBUG (in set_tone() line
1237): isdn port now plays tone:'dialing'. DEBUG (in message_get() line
115): message MESSAGE_CONNECT reading from 2 to 3 (memory b7769880)
TRACE : 27.03.19 13:24:21.135 CH(3): MT_CONNECT REQUEST U->N iface Ext
port 0 DEBUG (in new_state() line 285): PORT(Ext-0-in) new state
PORT_STATE_IN_SETUP --> PORT_STATE_CONNECT_WAITING DEBUG (in set_tone()
line 1237): isdn port now plays tone:''. port0 pc-00010001 dss1 TE state
6 from up CONNECT DEBUG (in message_get() line 115): message
MESSAGE_VBOX_TONE reading from 2 to 3 (memory b776d360) DEBUG (in
message_epoint() line 648): PORT(Ext-0-in) set answering machine tone
'vbox_english' 'menu' port0 pc-00010001 state 6 --> 8 port0 l3 State
ST_L3_LC_REL Event EV_ESTABLISH_REQ port0 l3 ChangeState ST_L3_LC_REL ->
ST_L3_LC_ESTAB_WAIT port0 send DL_ESTABLISH_REQ to tei 127 DEBUG (in
set_vbox_tone() line 440): PORT(Ext-0-in) opening tone:
/usr/local/share/lcr/vbox_english/menu DEBUG (in message_get() line
115): message MESSAGE_VBOX_TONE reading from 2 to 3 (memory b7770e40)
DEBUG (in message_epoint() line 648): PORT(Ext-0-in) set answering
machine tone 'vbox_english' 'nothing' DEBUG (in set_vbox_tone() line
440): PORT(Ext-0-in) opening tone:
/usr/local/share/lcr/vbox_english/nothing DEBUG (in vbox_refresh() line
625): EPOINT(2) terminal pending display:no calls DEBUG (in
_message_put() line 70): message MESSAGE_NOTIFY written from 2 to 3
(memory b775b0e0 at file action_vbox.cpp, line 626) TRACE : 27.03.19
13:24:21.135 EP(2): NOTIFY to CH(3) display 'no calls' DEBUG (in
message_get() line 115): message MESSAGE_NOTIFY reading from 2 to 3
(memory b775b0e0) port0: DL_INFORMATION_IND: chan(1) tei(65) port0:
changing tei: chan(1) old tei(65) new tei(7f) port0: DL_ESTABLISH_CNF:
chan(1) tei(65) port0 l3 State ST_L3_LC_ESTAB_WAIT Event
EV_ESTABLISH_CNF port0 l3 ChangeState ST_L3_LC_ESTAB_WAIT ->
ST_L3_LC_ESTAB port0 send DL_DATA_REQ to tei 101 port0 sent 1 messages
to L2 port0: pr DL_ESTABLISH_IND tei:127 pid 10001 ces 1/1 port0: send
to l3proc pid=10001 port0 pc-00010001 dss1 TE state 8 pr
DL_ESTABLISH_IND port0 pc-00010001 dss1 TE dl_ignore msg:nil TRACE :
27.03.19 13:24:21.176 CH: DL_ESTABLISH INDICATION U<-N iface Ext port 0
tei 101 port0: DL_(UNIT)DATA_IND: chan(1) tei(65) port0 pc-00010001 dss1
TE state 8 from down CONNECT_ACKNOWLEDGE port0 pc-00010001 state 8 -->
10 DEBUG (in stack2manager() line 2956): cmd(0xf) pid(0x10001) DEBUG (in
new_state() line 285): PORT(Ext-0-in) new state
PORT_STATE_CONNECT_WAITING --> PORT_STATE_CONNECT DEBUG (in
vbox_refresh() line 625): EPOINT(2) terminal pending display:no calls
DEBUG (in _message_put() line 70): message MESSAGE_NOTIFY written from 2
to 3 (memory b775b0e0 at file action_vbox.cpp, line 626) TRACE :
27.03.19 13:24:22.137 EP(2): NOTIFY to CH(3) display 'no calls' DEBUG
(in message_get() line 115): message MESSAGE_NOTIFY reading from 2 to 3
(memory b775b0e0) DEBUG (in vbox_refresh() line 625): EPOINT(2) terminal
pending display:no calls DEBUG (in _message_put() line 70): message
MESSAGE_NOTIFY written from 2 to 3 (memory b775b0e0 at file
action_vbox.cpp, line 626) TRACE : 27.03.19 13:24:23.139 EP(2): NOTIFY
to CH(3) display 'no calls' DEBUG (in message_get() line 115): message
MESSAGE_NOTIFY reading from 2 to 3 (memory b775b0e0) DEBUG (in
vbox_refresh() line 625): EPOINT(2) terminal pending display:no calls
DEBUG (in _message_put() line 70): message MESSAGE_NOTIFY written from 2
to 3 (memory b775b0e0 at file action_vbox.cpp, line 626) TRACE :
27.03.19 13:24:24.139 EP(2): NOTIFY to CH(3) display 'no calls' DEBUG
(in message_get() line 115): message MESSAGE_NOTIFY reading from 2 to 3
(memory b775b0e0) DEBUG (in vbox_refresh() line 625): EPOINT(2) terminal
pending display:no calls DEBUG (in _message_put() line 70): message
MESSAGE_NOTIFY written from 2 to 3 (memory b775b0e0 at file
action_vbox.cpp, line 626) TRACE : 27.03.19 13:24:25.141 EP(2): NOTIFY
to CH(3) display 'no calls' DEBUG (in message_get() line 115): message
MESSAGE_NOTIFY reading from 2 to 3 (memory b775b0e0) DEBUG (in
vbox_refresh() line 625): EPOINT(2) terminal pending display:no calls
DEBUG (in _message_put() line 70): message MESSAGE_NOTIFY written from 2
to 3 (memory b775b0e0 at file action_vbox.cpp, line 626) TRACE :
27.03.19 13:24:26.143 EP(2): NOTIFY to CH(3) display 'no calls' DEBUG
(in message_get() line 115): message MESSAGE_NOTIFY reading from 2 to 3
(memory b775b0e0) DEBUG (in vbox_refresh() line 625): EPOINT(2) terminal
pending display:no calls DEBUG (in _message_put() line 70): message
MESSAGE_NOTIFY written from 2 to 3 (memory b775b0e0 at file
action_vbox.cpp, line 626) TRACE : 27.03.19 13:24:27.145 EP(2): NOTIFY
to CH(3) display 'no calls' DEBUG (in message_get() line 115): message
MESSAGE_NOTIFY reading from 2 to 3 (memory b775b0e0) DEBUG (in
vbox_refresh() line 625): EPOINT(2) terminal pending display:no calls
DEBUG (in _message_put() line 70): message MESSAGE_NOTIFY written from 2
to 3 (memory b775b0e0 at file action_vbox.cpp, line 626) TRACE :
27.03.19 13:24:28.146 EP(2): NOTIFY to CH(3) display 'no calls' DEBUG
(in message_get() line 115): message MESSAGE_NOTIFY reading from 2 to 3
(memory b775b0e0) DEBUG (in vbox_refresh() line 625): EPOINT(2) terminal
pending display:no calls DEBUG (in _message_put() line 70): message
MESSAGE_NOTIFY written from 2 to 3 (memory b775b0e0 at file
action_vbox.cpp, line 626) TRACE : 27.03.19 13:24:29.148 EP(2): NOTIFY
to CH(3) display 'no calls' DEBUG (in message_get() line 115): message
MESSAGE_NOTIFY reading from 2 to 3 (memory b775b0e0) port0:
DL_(UNIT)DATA_IND: chan(1) tei(65) port0 pc-00010001 dss1 TE state 10
from down DISCONNECT port0 pc-00010001 state 10 --> 12

Is there any hint about, what's going wrong? I tried both (tones=yes/no
and earlyb=yes/no). And yes, vbox-play behaves as expected, if I connect
via SIP.

Best regards,
Bodo

_______________________________________________
isdn4linux mailing list
[email protected]
https://www.isdn4linux.de/mailman/listinfo/isdn4linux