Re: No sound from LCR -> ISDN-TE

Bodo Pfelzer <bodo.pfelzer-S0/[email protected]> Mon, 1 Apr 2019 11:41:16 +0200
Newsgroups gmane.linux.isdn.i4l.user
Message-ID <[email protected]>
Hi Andreas,

sorry, now mISDN_dsp is loaded. But I still don't hear anything:

port0: DL_(UNIT)DATA_IND: chan(1) tei(67) port0: MT_SETUP 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 (8) 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 : 01.04.19 11:29:54.148 CH(8): MT_NEW_L3ID INDICATION
iface Ext port 0 callref new=0x10001 TRACE : 01.04.19 11:29:54.149
CH(8): 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 : 01.04.19
11:29:54.149 CH(8): 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) TRACE : 01.04.19 11:29:54.149 CH(8): BCHANNEL
create socket iface Ext port 0 channel 1 socket 20 TRACE : 01.04.19
11:29:54.149 CH(8): BCHANNEL activate iface Ext port 0 channel 1 DEBUG
(in Endpoint() line 48): EPOINT(6): Allocating enpoint 6 and connecting
it with: ioport DEBUG (in portlist_new() line 150): EPOINT(6) allocating
port_list, attaching to port 8 DEBUG (in epointlist_new() line 131):
PORT(8) allocating epoint_list. DEBUG (in _message_put() line 70):
message MESSAGE_SETUP written from 8 to 6 (memory 1bf75f60 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 8 to 6 (memory 1bf75f60)
DEBUG (in ea_message_port() line 2527): EPOINT(6) incoming call from
callerid=2111111111, dialing=9999999 TRACE : 01.04.19 11:29:54.150
EP(6): SETUP from CH(8) interface from=Ext caller id number=02111111111
present=allowed caller id2 number=02111111111 present=allowed dialing
9999999 complete true TRACE : 01.04.19 11:29:54.150 --: SCREEN (found in
screen list) iface Ext given type=national present=allowed id=2111111111
used id=02111111111 TRACE : 01.04.19 11:29:54.150 --: SCREEN (found in
screen list) iface Ext given type=national present=allowed id=2111111111
used id=02111111111 DEBUG (in port_setup() line 1415): EPOINT(6)
incoming call is external or voip DEBUG (in port_setup() line 1496):
EPOINT(6) call from external port DEBUG (in _message_put() line 70):
message MESSAGE_TONE written from 6 to 8 (memory 1bf79a40 at file
apppbx.cpp, line 597) TRACE : 01.04.19 11:29:54.150 EP(6): TONE to CH(8)
directory default name dialing DEBUG (in process_dialing() line 2591):
EPOINT(6): 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 : 01.04.19 11:29:54.150 EP(6):
ACTION (match) action goto line 9 DEBUG (in process_dialing() line
2615): EPOINT(6): a rule with action 'goto' matches. DEBUG (in
process_dialing() line 2663): EPOINT(6): terminal '' action: goto
(dialing '9999999') DEBUG (in process_dialing() line 2666): EPOINT(6):
terminal : current action 'goto' has a dialing function, so we call
it... DEBUG (in getrulesetbyname() line 1928): ruleset extern found.
TRACE : 01.04.19 11:29:54.150 EP(6): ACTION goto/menu (change to)
ruleset extern dialing 9999999 DEBUG (in process_dialing() line 2591):
EPOINT(6): 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 : 01.04.19 11:29:54.150
EP(6): ACTION (match) action vbox-play line 18 DEBUG (in
process_dialing() line 2615): EPOINT(6): a rule with action 'vbox-play'
matches. DEBUG (in process_dialing() line 2652): EPOINT(6): terminal :
current action 'vbox-play' has a init function, so we call it... DEBUG
(in _message_put() line 70): message MESSAGE_CONNECT written from 6 to 8
(memory 1bf7d520 at file action_vbox.cpp, line 96) TRACE : 01.04.19
11:29:54.150 EP(6): CONNECT to CH(8) connect id number= present='not
available' DEBUG (in action_init_vbox_play() line 100): EPOINT(6)
initializing answering vbox state DEBUG (in _message_put() line 70):
message MESSAGE_VBOX_TONE written from 6 to 8 (memory 1bf81000 at file
action_vbox.cpp, line 852) DEBUG (in set_tone_vbox() line 854):
EPOINT(6) terminal set tone 'menu' DEBUG (in vbox_index_read() line
139): EPOINT(6) no files in index DEBUG (in action_init_vbox_play() line
110): EPOINT(6) number of calls: 0 DEBUG (in _message_put() line 70):
message MESSAGE_VBOX_TONE written from 6 to 8 (memory 1bf84ae0 at file
action_vbox.cpp, line 852) DEBUG (in set_tone_vbox() line 854):
EPOINT(6) terminal set tone 'nothing' DEBUG (in process_dialing() line
2663): EPOINT(6): terminal '' action: vbox-play (dialing '') DEBUG (in
process_dialing() line 2666): EPOINT(6): terminal : current action
'vbox-play' has a dialing function, so we call it... DEBUG (in
action_dialing_vbox_play() line 241): EPOINT(6) called with no digit
DEBUG (in message_get() line 115): message MESSAGE_TONE reading from 6
to 8 (memory 1bf79a40) 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 6 to 8 (memory 1bf7d520)
TRACE : 01.04.19 11:29:54.151 CH(8): 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 6 to 8 (memory 1bf81000) DEBUG (in
message_epoint() line 648): PORT(Ext-0-in) set answering machine tone
'vbox_english' 'menu' port0 pc-00010001 state 6 --> 8 port0 send msg
(DL_DATA_REQ) len=12 to L2 tei 103 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 6 to 8 (memory 1bf84ae0) 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(6) terminal pending display:no calls DEBUG (in
_message_put() line 70): message MESSAGE_NOTIFY written from 6 to 8
(memory 1bf75f60 at file action_vbox.cpp, line 626) TRACE : 01.04.19
11:29:54.151 EP(6): NOTIFY to CH(8) display 'no calls' DEBUG (in
message_get() line 115): message MESSAGE_NOTIFY reading from 6 to 8
(memory 1bf75f60) DEBUG (in b_sock_callback() line 1736): DL_ESTABLISH
confirm: bchannel is now activated (socket 20). TRACE : 01.04.19
11:29:54.151 CH(8): BCHANNEL control iface Ext port 0 DSP-DTMF 1 port0:
DL_(UNIT)DATA_IND: chan(1) tei(67) 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(6)
terminal pending display:no calls DEBUG (in _message_put() line 70):
message MESSAGE_NOTIFY written from 6 to 8 (memory 1bf75f60 at file
action_vbox.cpp, line 626) TRACE : 01.04.19 11:29:55.152 EP(6): NOTIFY
to CH(8) display 'no calls' DEBUG (in message_get() line 115): message
MESSAGE_NOTIFY reading from 6 to 8 (memory 1bf75f60) DEBUG (in
vbox_refresh() line 625): EPOINT(6) terminal pending display:no calls
DEBUG (in _message_put() line 70): message MESSAGE_NOTIFY written from 6
to 8 (memory 1bf75f60 at file action_vbox.cpp, line 626) TRACE :
01.04.19 11:29:56.153 EP(6): NOTIFY to CH(8) display 'no calls' DEBUG
(in message_get() line 115): message MESSAGE_NOTIFY reading from 6 to 8
(memory 1bf75f60) DEBUG (in _message_put() line 70): message
MESSAGE_TONE_EOF written from 8 to 6 (memory 1bf75f60 at file port.cpp,
line 597) DEBUG (in read_audio() line 607): PORT(Ext-0-in) no tone loop:
/usr/local/share/lcr/vbox_english/nothing_loop DEBUG (in message_get()
line 115): message MESSAGE_TONE_EOF reading from 8 to 6 (memory
1bf75f60) DEBUG (in ea_message_port() line 2504): EPOINT(6) current tone
is now end of file. DEBUG (in vbox_message_eof() line 650): EPOINT(6)
terminal end of file during state: 11 DEBUG (in _message_put() line 70):
message MESSAGE_VBOX_TONE written from 6 to 8 (memory 1bf79a40 at file
action_vbox.cpp, line 852) DEBUG (in set_tone_vbox() line 854):
EPOINT(6) terminal set tone 'menu' DEBUG (in message_get() line 115):
message MESSAGE_VBOX_TONE reading from 6 to 8 (memory 1bf79a40) DEBUG
(in message_epoint() line 648): PORT(Ext-0-in) set answering machine
tone 'vbox_english' 'menu' DEBUG (in set_vbox_tone() line 440):
PORT(Ext-0-in) opening tone: /usr/local/share/lcr/vbox_english/menu
DEBUG (in vbox_refresh() line 625): EPOINT(6) terminal pending
display:press 2 to play DEBUG (in _message_put() line 70): message
MESSAGE_NOTIFY written from 6 to 8 (memory 1bf75f60 at file
action_vbox.cpp, line 626) TRACE : 01.04.19 11:29:56.457 EP(6): NOTIFY
to CH(8) display 'press 2 to play' DEBUG (in message_get() line 115):
message MESSAGE_NOTIFY reading from 6 to 8 (memory 1bf75f60) DEBUG (in
vbox_refresh() line 625): EPOINT(6) terminal pending display:press 2 to
play DEBUG (in _message_put() line 70): message MESSAGE_NOTIFY written
from 6 to 8 (memory 1bf75f60 at file action_vbox.cpp, line 626) TRACE :
01.04.19 11:29:57.458 EP(6): NOTIFY to CH(8) display 'press 2 to play'
DEBUG (in message_get() line 115): message MESSAGE_NOTIFY reading from 6
to 8 (memory 1bf75f60) DEBUG (in vbox_refresh() line 625): EPOINT(6)
terminal pending display:press 2 to play DEBUG (in _message_put() line
70): message MESSAGE_NOTIFY written from 6 to 8 (memory 1bf75f60 at file
action_vbox.cpp, line 626) TRACE : 01.04.19 11:29:58.458 EP(6): NOTIFY
to CH(8) display 'press 2 to play' DEBUG (in message_get() line 115):
message MESSAGE_NOTIFY reading from 6 to 8 (memory 1bf75f60) DEBUG (in
vbox_refresh() line 625): EPOINT(6) terminal pending display:press 2 to
play DEBUG (in _message_put() line 70): message MESSAGE_NOTIFY written
from 6 to 8 (memory 1bf75f60 at file action_vbox.cpp, line 626) TRACE :
01.04.19 11:29:59.459 EP(6): NOTIFY to CH(8) display 'press 2 to play'
DEBUG (in message_get() line 115): message MESSAGE_NOTIFY reading from 6
to 8 (memory 1bf75f60) DEBUG (in vbox_refresh() line 625): EPOINT(6)
terminal pending display:press 2 to play DEBUG (in _message_put() line
70): message MESSAGE_NOTIFY written from 6 to 8 (memory 1bf75f60 at file
action_vbox.cpp, line 626) TRACE : 01.04.19 11:30:00.460 EP(6): NOTIFY
to CH(8) display 'press 2 to play' DEBUG (in message_get() line 115):
message MESSAGE_NOTIFY reading from 6 to 8 (memory 1bf75f60) port0:
DL_(UNIT)DATA_IND: chan(1) tei(67) port0 pc-00010001 dss1 TE state 10
from down DISCONNECT port0 pc-00010001 state 10 --> 12 DEBUG (in
stack2manager() line 2956): cmd(0x45) pid(0x10001) TRACE : 01.04.19
11:30:01.269 CH(8): MT_DISCONNECT INDICATION U<-N iface Ext port 0
progress codeing=0 location=2 indicator=8 cause location=0 value=16
DEBUG (in _message_put() line 70): message MESSAGE_PROGRESS written from
8 to 6 (memory 1bf75f60 at file dss1.cpp, line 1129) DEBUG (in
_message_put() line 70): message MESSAGE_DISCONNECT written from 8 to 6
(memory 1bf79a40 at file dss1.cpp, line 1168) DEBUG (in new_state() line
285): PORT(Ext-0-in) new state PORT_STATE_CONNECT -->
PORT_STATE_IN_DISCONNECT DEBUG (in message_get() line 115): message
MESSAGE_PROGRESS reading from 8 to 6 (memory 1bf75f60) DEBUG (in
ea_message_port() line 2642): EPOINT(6) epoint with terminal '' (caller
id '02111111111') received progress. TRACE : 01.04.19 11:30:01.270
EP(6): PROGRESS from CH(8) indicator 'In-band info or pattern available'
cause location=2-Local-Exchange DEBUG (in message_get() line 115):
message MESSAGE_DISCONNECT reading from 8 to 6 (memory 1bf79a40) DEBUG
(in ea_message_port() line 2617): EPOINT(6) call disconnect with
cause=16 location=0 (terminal '', caller id '02111111111') TRACE :
01.04.19 11:30:01.270 EP(6): DISCONNECT from CH(8) cause value=16
location=0-User DEBUG (in port_disconnect_release() line 2089):
EPOINT(6) current multipoint cause 0 location 0, received cause 16
location 0. DEBUG (in port_disconnect_release() line 2091): EPOINT(6)
new multipoint cause 16 location 0. DEBUG (in process_hangup() line
2711): EPOINT(6): terminal '' DEBUG (in _message_put() line 70): message
MESSAGE_TONE written from 6 to 8 (memory 1bf75f60 at file apppbx.cpp,
line 597) TRACE : 01.04.19 11:30:01.270 EP(6): TONE to CH(8) directory
default name cause_10 DEBUG (in release() line 222): EPOINT(6): do
pending release (joincause 16 location 0) DEBUG (in release() line 240):
EPOINT(6) do pending release (portcause 16 portlocation) DEBUG (in
_message_put() line 70): message MESSAGE_TONE written from 6 to 8
(memory 1bf7d520 at file apppbx.cpp, line 597) TRACE : 01.04.19
11:30:01.270 EP(6): TONE to CH(8) directory default name cause_10 DEBUG
(in _message_put() line 70): message MESSAGE_RELEASE written from 6 to 8
(memory 1bf81000 at file apppbx.cpp, line 249) TRACE : 01.04.19
11:30:01.270 EP(6): RELEASE to CH(8) cause value=16 location=1-Local-PBX
DEBUG (in free_portlist() line 189): EPOINT(6) removed port 8 from
port_list of endpoint DEBUG (in release() line 319): EPOINT(6) do
pending release of epoint itself. DEBUG (in message_get() line 115):
message MESSAGE_TONE reading from 6 to 8 (memory 1bf75f60) DEBUG (in
message_epoint() line 643): PORT(Ext-0-in) setting tone 'cause_10' dir
'' DEBUG (in set_tone() line 1237): isdn port now plays tone:'cause_10'.
DEBUG (in set_tone() line 389): PORT(Ext-0-in) Given Cause 0x10 has no
tone, using release tone DEBUG (in message_get() line 115): message
MESSAGE_TONE reading from 6 to 8 (memory 1bf7d520) DEBUG (in
message_epoint() line 643): PORT(Ext-0-in) setting tone 'cause_10' dir
'' DEBUG (in set_tone() line 1237): isdn port now plays tone:'cause_10'.
DEBUG (in set_tone() line 389): PORT(Ext-0-in) Given Cause 0x10 has no
tone, using release tone DEBUG (in message_get() line 115): message
MESSAGE_RELEASE reading from 6 to 8 (memory 1bf81000) TRACE : 01.04.19
11:30:01.271 CH(8): MT_RELEASE REQUEST U->N iface Ext port 0 cause
location=1 value=16 DEBUG (in new_state() line 285): PORT(Ext-0-in) new
state PORT_STATE_IN_DISCONNECT --> PORT_STATE_RELEASE DEBUG (in
free_epointid() line 114): PORT(8) removed epoint from port DEBUG (in
~Endpoint() line 138): removed endpoint 6. port0 pc-00010001 dss1 TE
state 12 from up RELEASE port0 pc-00010001 state 12 --> 19 port0 send
msg (DL_DATA_REQ) len=16 to L2 tei 103 DEBUG (in read_audio() line 523):
PORT(Ext-0-in) no tone: /usr/local/share/lcr/tones_american/release
DEBUG (in read_audio() line 626): PORT(Ext-0-in) opening tone:
/usr/local/share/lcr/tones_american/release_loop port0:
DL_(UNIT)DATA_IND: chan(1) tei(67) port0 pc-00010001 dss1 TE state 19
from down RELEASE_COMPLETE port0 pc-00010001 state 19 --> 0 port0: tei
103 idle DEBUG (in stack2manager() line 2956): cmd(0x5a) pid(0x10001)
TRACE : 01.04.19 11:30:01.392 CH(8): MT_RELEASE_COMP INDICATION U<-N
iface Ext port 0 layer 1 up DEBUG (in new_state() line 285):
PORT(Ext-0-in) new state PORT_STATE_RELEASE --> PORT_STATE_RELEASE DEBUG
(in stack2manager() line 2956): cmd(0x11001) pid(0x10001) TRACE :
01.04.19 11:30:01.392 CH(8): MT_RELEASE_L3ID INDICATION iface Ext port 0
callref 0x10001 DEBUG (in stack2manager() line 2956): cmd(0x12002)
pid(0x67) DEBUG (in stack2manager() line 3059): Got L2 idle DEBUG (in
drop_bchannel() line 857): PmISDN(Ext-0-in) dropping bchannel TRACE :
01.04.19 11:30:01.393 CH(8): BCHANNEL deactivate iface Ext port 0
channel 1 DEBUG (in ~PmISDN() line 224): destroyed mISDNPort(Ext-0-in).
Currently 0 objects DEBUG (in ~Port() line 224): removing port (8) of
type 0x1111, name 'Ext-0-in' interface 'Ext' DEBUG (in b_sock_callback()
line 1744): DL_RELEASE confirm: bchannel is now de-activated (socket
20). TRACE : 01.04.19 11:30:01.393 CH: BCHANNEL remove socket iface Ext
port 0 channel 1 socket 20

During the call I execute:

bodo@server:~$ lsmod | grep mISDN mISDN_dsp 208896 1 mISDN_core 94208 10
hfcpci,mISDN_dsp

Best regards,
Bodo

Am 30.03.19 um 07:30 schrieb Andreas Eversberg:
>
>
>
> On 27.03.2019 14:35, Bodo Pfelzer wrote:
>> 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:
>> 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?
> Hi Bodo,
>
> there is no mISDN_dsp.ko loaded. It is required for all mISDN
> interfaces. Just do "modprobe mISDN_dsp" to solve this.
>
> Regards,
>
> Andreas
>

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