Das liefert bei einem weiteren Verbindungsversuch folgenden Output:
May 19 11:17:00.019: ISDN LIFd: l3_timer: timer Expiry (0x82763D08), timer_type (0x1313)
May 19 11:17:00.019: ISDN BR0 Q931d: L3_Go: source 0x0300, event 0x1313, call id 0x int id 0x10
May 19 11:17:00.019: ISDN BR0 Q931d: L3_Go: event 0x1313 cr_len 0 cr 0
May 19 11:17:00.019: ISDN BR0 Q931d: L3_Go: call_id 0x8010 cr 0x10 state 1 event 0x1313 ces 1
May 19 11:17:00.019: ISDN BR0 Q931d: L3_ProcessEvent: callref = 0x0010 T303_EXPIRY:U1_T303Expiry(nlcb)
May 19 11:17:00.019: ISDN BR0 Q931d: srl_send_l3_pak:
source_id = Q.931 0x0300, dest_id = Q.921 0x0000, prim = DL_DATA_REQ 0x0240
priv_len = 4 int_id = 0x8203843C datasize = 24
May 19 11:17:00.023: ISDN BR0 Q931d: data =
May 19 11:17:00.023: 8203843C000003000240040D00010806
May 19 11:17:00.023: 0801105A080280E6
May 19 11:17:00.023: ISDN BR0 Q931d: L3_state_change: callref 0x0010 old CALL_INIT, new NULL_STATE
May 19 11:17:00.023: ISDN BR0 PACKET: handle_mail: received:
dest_id = 0, source_id = 768, prim = 240
priv_ln = 4, int_id = -2113698756, datasize = 24
May 19 11:17:00.023: ISDN BR0 PACKET: L2IF_DispPak: packet - start(3167038), size (24)
May 19 11:17:00.027: 0801105A080280E60015F90DE144574E
May 19 11:17:00.027: F3C600090F0209E5
May 19 11:17:00.027: ISDN BR0 PACKET: handle_mail: received data =
May 19 11:17:00.027: 0801105A080280E6
May 19 11:17:00.027: ISDN BR0 Q921d: L2_GetDLCB: ces 1
May 19 11:17:00.027: ISDN BR0 Q921d: NOP: DLCB state 1 EventIndex 1 L2_Event 576 Tei 255 DSL_Chan 0 ces 1 SAPI 0
May 19 11:17:00.027: ISDN BR0 Q921d: L2_FreeDLCB
May 19 11:17:00.031: ISDN LIFd: isdn_L3_timer_process: event_count (1)
May 19 11:17:00.031: ISDN BR0 CC: CCBRI_Go: source id 0x300, state 1, call id 0x8010, event 0x341
May 19 11:17:00.031: ISDN BR0 CC: CCBRI_Go: call id 0x8010 call ref 0x10 state 6 event 0x91 Src->L3
May 19 11:17:00.031: ISDN BR0 TGRM: get_tgrm_avail_state: idb 0x8203843C bchan 1 service_state 0 call_state 0 false busy 0x0 dsl 0
May 19 11:17:00.031: ISDN BR0 TGRM: update_tgrm_call_status: idb 0x8203843C bchan 1 availability state 1 call state(prev,new) (1,0), dsl 0
May 19 11:17:00.035: ISDN BR0 TGRM: update_tgrm_call_status: Calling TGRM with tgrm_call_isdn_update: idb 0x8203843C bchan 1 call state 0 call type 0 call dir 1
May 19 11:17:00.035: ISDN EVENTd: cc_clear_free_list freed 0x8278A118
May 19 11:17:00.035: ISDN BR0 EVENT: process_rxstate: ces/callid 1/0x8010 calltype 1 HOST_DISCONNECT_ACK
May 19 11:17:00.035: ISDN BR0 PACKET: process_rxstate:
May 19 11:17:00.035: 060001801000
May 19 11:17:00.035: ISDN BR0 EVENTd: calltrkr_call_cleared: isdn_info=0x820397D8, call_id=0x8010
May 19 11:17:00.039: ISDN BR0 EVENTd: calltrkr_call_cleared: hndl=0l, cause=0, Unknown cause value
May 19 11:17:00.039: ISDN BR0 **ERROR**: host_disconnect_ack: Unfound B-channel on Disconnect_Ack call id 0x8010
May 19 11:17:22.072: ISDN BR0 EVENT: UserIdle: callid 0x8010 received ISDN_HANGUP (0x1)
May 19 11:17:22.072: ISDN BR0 EVENTd: process_disconnect: call id 0x8010, call type is DATA, b_idb 0x8203843C, ces 1, cause Normal call clearing(0x10)
May 19 11:17:22.072: ISDN BR0 EVENTd: calltrkr_call_disconnected: isdn_info=0x820397D8, call_id=0x8010
May 19 11:17:22.072: ISDN BR0 EVENTd: process_disconnect: Raw Release Message
May 19 11:17:22.072: 0500018010040802FF9008028090
May 19 11:17:22.072: ISDN BR0 CC: CCBRI_Go: source id 0x500, state 0, call id 0x0, event 0x5
May 19 11:17:22.072: ISDN BR0 CCd: CCBRI_Go: Host PkgInfo:
May 19 11:17:22.076: 0500018010040802FF9008028090
May 19 11:17:22.076: ISDN BR0 **ERROR**: CCBRI_Go: NO CCB Src->HOST call id 0x8010, event 0x5 ces 1
May 19 11:17:22.076: ISDN BR0 EVENT: process_rxstate: ces/callid 1/0x8010 calltype 1 HOST_QUERY_RESPONSE
May 19 11:17:22.076: ISDN BR0 PACKET: process_rxstate:
May 19 11:17:22.076: 0B0001801003140100