Jun 17 13:16:47: AAA/AUTHEN/LOGIN (0000003D): Pick method list 'use-local' 
Jun 17 13:16:47: TTY65: resume timer type 10 (OK)user1
Jun 17 13:16:50: TTY65: pause timer type 10 (OK)
Jun 17 13:16:50: TTY65: resume timer type 10 (OK)
a
Jun 17 13:16:53: TTY65: pause timer type 10 (OK)
Jun 17 13:16:53: AAA/AUTHOR (0000003D): Method list id=0 not configured. Skip authort
OK
atdt22111122
Jun 17 13:17:00: Modem 2/0 CSM: Called Number Rcvd = T22111122
Jun 17 13:17:00: Modem 2/0 CSM: Dropped character T
Jun 17 13:17:00: Modem 2/0 CSM: Dial String to be processed (22111122)
Jun 17 13:17:00: Modem 2/0 CSM: End of Dial String
Jun 17 13:17:00: Modem 2/0 CSM: (CSM_PROC_IDLE)<--MODEM_DIAL_OUT
Jun 17 13:17:00: Modem 2/0 Mica: configured for Originate mode, with Null signaling, 0x1 tone detection.
Jun 17 13:17:00: Modem 2/0 Mica: received dialstring T22111122
Jun 17 13:17:00: ISDN BR1/7 Q931: TX -> SETUP pd = 8  callref = 0x15 
        Bearer Capability i = 0x8090A3 
                Standard = CCITT 
                Transer Capability = Speech  
                Transfer Mode = Circuit 
                Transfer Rate = 64 kbit/s 
        Channel ID i = 0x83 
        Called Party Number i = 0x80, '22111122' 
                Plan:Unknown, Type:Unknown
Jun 17 13:17:00: Modem 2/0 CSM: (CSM_PROC_OC_ISDN_PROCESSING_CALL)<--CSM_EVENT_MODEM_SETUP
Jun 17 13:17:00: Modem 2/0 Mica: in modem state CALL_SETUP
Jun 17 13:17:00: ISDN BR1/7 Q931: RX <- SETUP_ACK pd = 8  callref = 0x95 
        Channel ID i = 0x89
Jun 17 13:17:00: CSM: MODEM_REPORT from 1/7:0, call_id=0x8024, event=0x2, cause=0x0, dchan_idb=0x6389C290
Jun 17 13:17:00: Modem 2/0 CSM: (CSM_PROC_OC_ISDN_PROCESSING_CALL)<--ISDN_BCHAN_ASSIGNED
Jun 17 13:17:00: ISDN BR1/7 Q931: RX <- CALL_PROC pd = 8  callref = 0x95
Jun 17 13:17:00: CSM: MODEM_REPORT from 1/7:0, call_id=0x8024, event=0x3, cause=0x0, dchan_idb=0x6389C290
Jun 17 13:17:00: CSM: MODEM_REPORT rcvd DEV_CALL_PROC for call_id 0x8024, but modem_info is NULL
Jun 17 13:17:00: ISDN BR1/7 **ERROR**: host_more_info: HOST_PROCEEDING: VOICE ERROR: Undefined B-IDB(0xFD): b channel 0, call id 0x8024
Jun 17 13:17:00: %ISDN-6-DISCONNECT: Interface BRI1/7:1  disconnected from unknown , call lasted 12369 seconds
Jun 17 13:17:04: ISDN BR1/7 Q931: RX <- ALERTING pd = 8  callref = 0x95 
        Progress Ind i = 0x8288 - In-band info or appropriate now available 
Jun 17 13:17:04: CSM: MODEM_REPORT from 1/7:0, call_id=0x8024, event=0x5, cause=0x0, dchan_idb=0x6389C290
Jun 17 13:17:04: Modem 2/0 CSM: MODEM_REPORT rcvd DEV_CALL_PROGRESSING for call_id 0x8024
Jun 17 13:17:04: Modem 2/0 CSM: (CSM_PROC_OC_ISDN_CONNECT_PENDING)<--ISDN_CALL_PROGRESSING
Jun 17 13:17:05: Modem 2/0 CSM: (CSM_PROC_OC_ISDN_CONNECT_PENDING)<--MODEM_TONE_DETECTED
Jun 17 13:17:05: Modem 2/0 Mica: Detected Dial tone
Jun 17 13:17:10: ISDN BR1/7 Q931: RX <- DISCONNECT pd = 8  callref = 0x95 
        Cause i = 0x8091 - User busy 
        Facility i = 0x91A11C0201BC02012430143012A11030060201000201013006020100020102 
        - ETSI Supplementary Service, Invoke, AOC-E Charging Units: 0 
        Progress Ind i = 0x8288 - In-band info or appropriate now available 
Jun 17 13:17:10: CSM: MODEM_REPORT from 1/7:0, call_id=0x8024, event=0x0, cause=0x11, dchan_idb=0x6389C290
Jun 17 13:17:10: Modem 2/0 CSM: MODEM_REPORT rcvd DEV_IDLE for call_id 0x8024
Jun 17 13:17:10: Modem 2/0 CSM: (CSM_PROC_OC_ISDN_CONNECT_PENDING)<--ISDN_DISCONNECTED
BUSY

Jun 17 13:17:10: ISDN BR1/7 Q931: TX -> RELEASE pd = 8  callref = 0x15 
        Cause i = 0x8091 - User busy
Jun 17 13:17:10: Modem 2/0 Mica: in modem state TERMINATING
Jun 17 13:17:10:  Modem 2/0 Mica: received TerminateInfo 
Jun 17 13:17:10: Modem 2/0 CSM: (CSM_PROC_DISCONNECTED)<--MODEM_DISCONNECTED
Jun 17 13:17:10: Modem 2/0 CSM: Stopping dm tone timer
Jun 17 13:17:10: Modem 2/0 Mica: in modem state IDLE
Jun 17 13:17:10: Modem 2/0 CSM: (CSM_PROC_DISCONNECTED)<--QUEUED_DISCONNECT
Jun 17 13:17:10: Modem 2/0 CSM: Stopping dm tone timer
Jun 17 13:17:10: Modem 2/0 CSM: CSM_MODEM_DEALLOCATE: modem is deallocated
Jun 17 13:17:10: Modem 2/0 Mica: DISCONNECT after 00:03:30, due to reason (0x7F01) Busy.
Jun 17 13:17:10: ISDN BR1/7 Q931: RX <- RELEASE_COMP pd = 8  callref = 0x95
Jun 17 13:17:10: CSM: MODEM_REPORT from 1/7:0, call_id=0x8024, event=0x0, cause=0x0, dchan_idb=0x6389C290
Jun 17 13:17:10: CSM: MODEM_REPORT rcvd DEV_IDLE for call_id 0x8024, modem not found due to wrong b channel number or b channel is deallocated
Jun 17 13:17:10: ISDN BR1/7 **ERROR**: host_disconnect_ack: VOICE ERROR: NULL VDEV Common(0xFC): b channel 0, call id 0x8024
Jun 17 13:17:12: %ISDN-6-LAYER2DOWN: Layer 2 for Interface BR1/7, TEI 102 changed to down
Jun 17 13:17:18: ISDN BR1/7 Q931: L3_ShutDown: Shutting down ISDN Layer 3