coexistence of Istec TA and passive ISDN card with isdnd

[Robert Eckardt]

Hi,

currently I'm having trouble setting up a box running 5.0-RELEASE
using the ELSA MicroLink ISDN/PCI card in coexistence with my
ISTEC 1003 TA.

I can dial out to my ISP using one channel but then my TA won't react to
give me a line on the second channel.
When I call from outside I get a "temporarily not available" message
on the first try. Sometimes, the second try succeeds in ringing the
phone. All connections attempts are logged by isdnd.
Nevertheless, I still get no line to dial out with my phone.
After I hang up the isdn-connection of my computer I have to power-cycle
my TA to get a line again. What's wrong here?

(Besides, my old configuration (4.4-RELEASE with Teles S0/16) works still
flawlessly.  -- Except that its isdnd crashes when someone dials in while
my new box has dialed out. NB: The old box isn't connected yet.)


##### dmesg:
isic0: <ELSA MicroLink ISDN/PCI> port 0xc000-0xc003,0xbc00-0xbc7f mem
0xe0022000-0xe002207f irq 9 at device 6.0 on pci1
isic0: passive stack unit 0
 [..]
i4bisppp: 4 ISDN SyncPPP device(s) attached
i4b: ISDN call control device attached
i4btel: 2 ISDN telephony interface device(s) attached
i4brbch: 4 raw B channel access device(s) attached
i4bipr: 4 IP over raw HDLC ISDN device(s) attached (VJ header compression)
i4bctl: ISDN system control port attached
i4btrc: 4 ISDN trace device(s) attached
 [..]
i4b: unit 0, assigned TEI = 101 = 0x65
i4b-L3 T303_timeout: SETUP not answered, cr = 91
i4b-L3 next_l3state: FSM illegal state, state = ST_U0 - Null, event =
EV_T303EXP - T303 timeout!
i4b-L3 T303_timeout: SETUP not answered, cr = 110
i4b-L3 next_l3state: FSM illegal state, state = ST_U0 - Null, event =
EV_T303EXP - T303 timeout!
i4b-L2 i4b_mph_status_ind: unit 0, persistent deactivation!
i4b-L3 i4b_mdl_status_ind: STI_PDEACT: unit 0 TEI = 0 = 0x00

##### pciconf:
isic0 at pci1:6:0: class=0x028000 card=0x10001048 chip=0x10001048 rev=0x02 hdr=0x00
    vendor   = 'ELSA GmbH'
    device   = 'QuickStep 1000 PCI to SCSI Bridge'
    class    = network

##### isdnd.log:
Jun 22 16:38:21 quasar isdnd[1108]: DBG msg_dialout: dial req from isp, unit 0
Jun 22 16:38:21 quasar isdnd[1108]: DBG setup_dialout: entry MYISP1 ok!
Jun 22 16:38:21 quasar isdnd[1108]: DBG find_by_device_for_dialout: found entry 3!
Jun 22 16:38:21 quasar isdnd[1108]: DBG FSM event [msg-dialout]: [idle => dialing]
Jun 22 16:38:21 quasar isdnd[1108]: DBG F_DIAL: local dial out request
Jun 22 16:38:21 quasar isdnd[1108]: CHD 00011 MYISP1 rate 150 sec/unit (rate)
Jun 22 16:38:21 quasar isdnd[1108]: DBG sendm_connect_req: ctrl = 0, chan = -1
Jun 22 16:38:21 quasar isdnd[1108]: DBG decr_free_channels: ctrl 0, now 1 chan
free
Jun 22 16:38:21 quasar isdnd[1108]: CHD 00011 MYISP1 dialing out from
<<Home-1>> to <<ISP>>
Jun 22 16:38:22 quasar isdnd[1108]: DBG set_channel_busy: controller [0]
channel B1 set to BUSY!
Jun 22 16:38:22 quasar isdnd[1108]: CHD 00011 MYISP1 outgoing call proceeding
(ctl 0, ch 0)
Jun 22 16:38:23 quasar isdnd[1108]: DBG msg_charging: 1 unit(s) (estimated)
Jun 22 16:38:23 quasar isdnd[1108]: DBG set_channel_busy: controller [0]
channel B1 already busy!
Jun 22 16:38:23 quasar isdnd[1108]: CHD 00011 MYISP1 outgoing call active (ctl
0, ch 0, isp0)
Jun 22 16:38:23 quasar isdnd[1108]: DBG FSM event [msg-con-act-ind]: [dialing
=> connected]
Jun 22 16:38:23 quasar isdnd[1108]: DBG F_DOK: dial out ok
Jun 22 16:38:30 quasar isdnd[1108]: DBG isp0: switched to state 3
Jun 22 16:40:19 quasar isdnd[1108]: DBG find_matching_entry_incoming: entry 2,
myno <<Home-2>> != incomingno <<Home-1>>
Jun 22 16:40:19 quasar isdnd[1108]: DBG find_matching_entry_incoming: entry 3,
myno <<Home-2>> != incomingno <<Home-1>>
Jun 22 16:40:19 quasar isdnd[1108]: CHD 00012 <unknown> incoming call from
<<Handy>> to <<Home-1>> ctrl 0
Jun 22 16:40:19 quasar isdnd[1108]: DBG <<Handy>> - screening network provided
Jun 22 16:40:19 quasar isdnd[1108]: DBG <<Handy>> - presentation allowed
Jun 22 16:40:53 quasar isdnd[1108]: DBG msg_charging: 2 unit(s) (estimated)
Jun 22 16:40:55 quasar isdnd[1108]: DBG find_matching_entry_incoming: entry 2,
myno <<Home-2>> != incomingno <<Home-1>>
Jun 22 16:40:55 quasar isdnd[1108]: DBG find_matching_entry_incoming: entry 3,
myno <<Home-2>> != incomingno <<Home-1>>
Jun 22 16:40:55 quasar isdnd[1108]: CHD 00014 <unknown> incoming call from
<<Handy>> to <<Home-1>> ctrl 0
Jun 22 16:40:55 quasar isdnd[1108]: DBG <<Handy>> - screening network provided
Jun 22 16:40:55 quasar isdnd[1108]: DBG <<Handy>> - presentation allowed
Jun 22 16:43:23 quasar isdnd[1108]: DBG msg_charging: 3 unit(s) (estimated)
Jun 22 16:43:54 quasar isdnd[1108]: DBG find_matching_entry_incoming: entry 2,
myno <<Home-2>> != incomingno <<Home-1>>
Jun 22 16:43:54 quasar isdnd[1108]: DBG find_matching_entry_incoming: entry 3,
myno <<Home-2>> != incomingno <<Home-1>>
Jun 22 16:43:54 quasar isdnd[1108]: CHD 00017 <unknown> incoming call from
<<Handy>> to <<Home-1>> ctrl 0
Jun 22 16:43:54 quasar isdnd[1108]: DBG <<Handy>> - screening network provided
Jun 22 16:43:54 quasar isdnd[1108]: DBG <<Handy>> - presentation allowed
Jun 22 16:45:53 quasar isdnd[1108]: DBG msg_charging: 4 unit(s) (estimated)
Jun 22 16:46:40 quasar isdnd[1108]: CHD 00011 MYISP1 outgoing call
disconnected (remote)
Jun 22 16:46:40 quasar isdnd[1108]: CHD 00011 MYISP1 cause 16: Normal call
clearing (Q.850)
Jun 22 16:46:40 quasar isdnd[1108]: CHD 00011 MYISP1 charging: 4 units, 497
seconds
Jun 22 16:46:40 quasar isdnd[1108]: CHD 00011 MYISP1 accounting: in 1464349,
out 60950 (in 1466589, out 57522)
Jun 22 16:46:40 quasar isdnd[1108]: DBG set_channel_idle: controller [0]
channel B1 set to IDLE!
Jun 22 16:46:40 quasar isdnd[1108]: DBG incr_free_channels: ctrl 0, now 2 chan
free
Jun 22 16:46:40 quasar isdnd[1108]: DBG FSM event [msg-disc-ind]: [connected
=> idle]
Jun 22 16:46:40 quasar isdnd[1108]: DBG F_IDIS: disconnect indication


--
Dr. Robert Eckardt    ---    Robert.Eckardt at Robert-Eckardt.de