[Apr 7 17:58:03] VERBOSE[9752] logger.c: < SAPI: 00 C/R: 0 EA: 0 [Apr 7 17:58:03] VERBOSE[9752] logger.c: < N(S): 122 0: 0 [Apr 7 17:58:03] VERBOSE[9752] logger.c: Handling message for SAPI/TEI=0/0 [Apr 7 17:58:03] VERBOSE[9752] logger.c: -- ACKing all packets from 54 to (but not including) 55 [Apr 7 17:58:03] VERBOSE[9752] logger.c: -- Since there was nothing left, stopping T200 counter [Apr 7 17:58:03] VERBOSE[9752] logger.c: -- Stopping T203 counter since we got an ACK [Apr 7 17:58:03] VERBOSE[9752] logger.c: -- Nothing left, starting T203 counter [Apr 7 17:58:03] VERBOSE[9752] logger.c: < Protocol Discriminator: Q.931 (8) len=35 [Apr 7 17:58:03] VERBOSE[9752] logger.c: < Call Ref: len= 2 (reference 26199/0x6657) (Originator) [Apr 7 17:58:03] VERBOSE[9752] logger.c: < Message type: SETUP (5) [Apr 7 17:58:03] VERBOSE[9752] logger.c: < [04 03 80 90 a3] [Apr 7 17:58:03] VERBOSE[9752] logger.c: < Bearer Capability (len= 5) [ Ext: 1 Q.931 Std: 0 Info transfer capability: Speech (0) [Apr 7 17:58:03] VERBOSE[9752] logger.c: < Ext: 1 Trans mode/rate: 64kbps, circuit-mode (16) [Apr 7 17:58:03] VERBOSE[9752] logger.c: < User information layer 1: A-Law (35) [Apr 7 17:58:03] VERBOSE[9752] logger.c: < [18 03 a1 83 89] [Apr 7 17:58:03] VERBOSE[9752] logger.c: < Channel ID (len= 5) [ Ext: 1 IntID: Implicit PRI Spare: 0 Preferred Dchan: 0 [Apr 7 17:58:03] VERBOSE[9752] logger.c: < ChanSel: As indicated in following octets [Apr 7 17:58:03] VERBOSE[9752] logger.c: < Ext: 1 Coding: 0 Number Specified Channel Type: 3 [Apr 7 17:58:03] VERBOSE[9752] logger.c: < Ext: 1 Channel: 9 ] [Apr 7 17:58:03] VERBOSE[9752] logger.c: < [6c 08 00 83 35 35 38 32 33 37] [Apr 7 17:58:03] VERBOSE[9752] logger.c: < Calling Number (len=10) [ Ext: 0 TON: Unknown Number Type (0) NPI: Unknown Number Plan (0) [Apr 7 17:58:03] VERBOSE[9752] logger.c: < Presentation: Presentation allowed of network provided number (3) '558XXX' ] [Apr 7 17:58:03] VERBOSE[9752] logger.c: < [70 03 80 30 31] [Apr 7 17:58:03] VERBOSE[9752] logger.c: < Called Number (len= 5) [ Ext: 1 TON: Unknown Number Type (0) NPI: Unknown Number Plan (0) '01' ] [Apr 7 17:58:03] VERBOSE[9752] logger.c: < [7c 03 80 90 a3] [Apr 7 17:58:03] VERBOSE[9752] logger.c: < IE: Low-layer Compatibility (len = 5) [Apr 7 17:58:03] VERBOSE[9752] logger.c: -- Making new call for cr 26199 [Apr 7 17:58:03] VERBOSE[9752] logger.c: -- Processing Q.931 Call Setup [Apr 7 17:58:03] VERBOSE[9752] logger.c: -- Processing IE 4 (cs0, Bearer Capability) [Apr 7 17:58:03] VERBOSE[9752] logger.c: -- Processing IE 24 (cs0, Channel Identification) [Apr 7 17:58:03] VERBOSE[9752] logger.c: -- Processing IE 108 (cs0, Calling Party Number) [Apr 7 17:58:03] VERBOSE[9752] logger.c: -- Processing IE 112 (cs0, Called Party Number) [Apr 7 17:58:03] VERBOSE[9752] logger.c: -- Processing IE 124 (cs0, Low-layer Compatibility) [Apr 7 17:58:03] VERBOSE[9752] logger.c: q931.c:3551 q931_receive: call 26199 on channel 9 enters state 6 (Call Present) [Apr 7 17:58:03] VERBOSE[9752] logger.c: Sending Receiver Ready (123) [Apr 7 17:58:03] VERBOSE[9752] logger.c: [Apr 7 17:58:03] VERBOSE[9752] logger.c: [Apr 7 17:58:03] VERBOSE[9752] logger.c: > SAPI: 00 C/R: 0 EA: 0 [Apr 7 17:58:03] VERBOSE[9752] logger.c: > Zero: 0 S: 0 01: 1 [ RR (receive ready) ] [Apr 7 17:58:03] VERBOSE[9752] logger.c: -- Restarting T203 timer [Apr 7 17:58:03] VERBOSE[9752] logger.c: q931.c:2868 q931_setup_ack: call 26199 on channel 9 enters state 25 (Overlap Receiving) [Apr 7 17:58:03] VERBOSE[9752] logger.c: -- Finally transmitting 55, since window opened up (0) [Apr 7 17:58:03] VERBOSE[9752] logger.c: [Apr 7 17:58:03] VERBOSE[9752] logger.c: [Apr 7 17:58:03] VERBOSE[9752] logger.c: > SAPI: 00 C/R: 1 EA: 0 [Apr 7 17:58:03] VERBOSE[9752] logger.c: > N(S): 055 0: 0 [Apr 7 17:58:03] VERBOSE[9752] logger.c: Stopping T_203 timer [Apr 7 17:58:03] VERBOSE[9752] logger.c: Starting T_200 timer [Apr 7 17:58:03] VERBOSE[9752] logger.c: -- Restarting T200 timer [Apr 7 17:58:03] VERBOSE[9752] logger.c: > Protocol Discriminator: Q.931 (8) len=14 [Apr 7 17:58:03] VERBOSE[9752] logger.c: > Call Ref: len= 2 (reference 26199/0x6657) (Terminator) [Apr 7 17:58:03] VERBOSE[9752] logger.c: > Message type: SETUP ACKNOWLEDGE (13) [Apr 7 17:58:03] VERBOSE[9752] logger.c: > [18 03 a9 83 89] [Apr 7 17:58:03] VERBOSE[9752] logger.c: > Channel ID (len= 5) [ Ext: 1 IntID: Implicit PRI Spare: 0 Exclusive Dchan: 0 [Apr 7 17:58:03] VERBOSE[9752] logger.c: > ChanSel: As indicated in following octets [Apr 7 17:58:03] VERBOSE[9752] logger.c: > Ext: 1 Coding: 0 Number Specified Channel Type: 3 [Apr 7 17:58:03] VERBOSE[9752] logger.c: > Ext: 1 Channel: 9 ] [Apr 7 17:58:03] VERBOSE[9752] logger.c: > [1e 02 81 82] [Apr 7 17:58:03] VERBOSE[9752] logger.c: > Progress Indicator (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) 0: 0 Location: Private network serving the local user (1) [Apr 7 17:58:03] VERBOSE[9752] logger.c: > Ext: 1 Progress Description: Called equipment is non-ISDN. (2) ] [Apr 7 17:58:03] VERBOSE[9752] logger.c: -- Accepting overlap call from '558XXX' to '01' on channel 0/9, span 2 [Apr 7 17:58:03] VERBOSE[9809] logger.c: -- Starting simple switch on 'DAHDI/40-1' [Apr 7 17:58:03] VERBOSE[9752] logger.c: [Apr 7 17:58:03] VERBOSE[9752] logger.c: [Apr 7 17:58:03] VERBOSE[9752] logger.c: < SAPI: 00 C/R: 1 EA: 0 [Apr 7 17:58:03] VERBOSE[9752] logger.c: < Zero: 0 S: 0 01: 1 [ RR (receive ready) ] [Apr 7 17:58:03] VERBOSE[9752] logger.c: Handling message for SAPI/TEI=0/0 [Apr 7 17:58:03] VERBOSE[9752] logger.c: -- ACKing all packets from 54 to (but not including) 56 [Apr 7 17:58:03] VERBOSE[9752] logger.c: -- ACKing packet 55, new txqueue is -1 (-1 means empty) [Apr 7 17:58:03] VERBOSE[9752] logger.c: -- Since there was nothing left, stopping T200 counter [Apr 7 17:58:03] VERBOSE[9752] logger.c: -- Nothing left, starting T203 counter [Apr 7 17:58:03] VERBOSE[9752] logger.c: -- Restarting T203 timer [Apr 7 17:58:04] VERBOSE[9752] logger.c: [Apr 7 17:58:04] VERBOSE[9752] logger.c: [Apr 7 17:58:04] VERBOSE[9752] logger.c: < SAPI: 00 C/R: 0 EA: 0 [Apr 7 17:58:04] VERBOSE[9752] logger.c: < N(S): 123 0: 0 [Apr 7 17:58:04] VERBOSE[9752] logger.c: Handling message for SAPI/TEI=0/0 [Apr 7 17:58:04] VERBOSE[9752] logger.c: -- ACKing all packets from 55 to (but not including) 56 [Apr 7 17:58:04] VERBOSE[9752] logger.c: -- Since there was nothing left, stopping T200 counter [Apr 7 17:58:04] VERBOSE[9752] logger.c: -- Stopping T203 counter since we got an ACK [Apr 7 17:58:04] VERBOSE[9752] logger.c: -- Nothing left, starting T203 counter [Apr 7 17:58:04] VERBOSE[9752] logger.c: < Protocol Discriminator: Q.931 (8) len=9 [Apr 7 17:58:04] VERBOSE[9752] logger.c: < Call Ref: len= 2 (reference 26199/0x6657) (Originator) [Apr 7 17:58:04] VERBOSE[9752] logger.c: < Message type: INFORMATION (123) [Apr 7 17:58:04] VERBOSE[9752] logger.c: < [70 02 80 39] [Apr 7 17:58:04] VERBOSE[9752] logger.c: < Called Number (len= 4) [ Ext: 1 TON: Unknown Number Type (0) NPI: Unknown Number Plan (0) '9' ] [Apr 7 17:58:04] VERBOSE[9752] logger.c: -- Processing IE 112 (cs0, Called Party Number) [Apr 7 17:58:04] VERBOSE[9752] logger.c: Sending Receiver Ready (124) [Apr 7 17:58:04] VERBOSE[9752] logger.c: [Apr 7 17:58:04] VERBOSE[9752] logger.c: [Apr 7 17:58:04] VERBOSE[9752] logger.c: > SAPI: 00 C/R: 0 EA: 0 [Apr 7 17:58:04] VERBOSE[9752] logger.c: > Zero: 0 S: 0 01: 1 [ RR (receive ready) ] [Apr 7 17:58:04] VERBOSE[9752] logger.c: -- Restarting T203 timer [Apr 7 17:58:05] VERBOSE[9752] logger.c: [Apr 7 17:58:05] VERBOSE[9752] logger.c: [Apr 7 17:58:05] VERBOSE[9752] logger.c: < SAPI: 00 C/R: 0 EA: 0 [Apr 7 17:58:05] VERBOSE[9752] logger.c: < N(S): 124 0: 0 [Apr 7 17:58:05] VERBOSE[9752] logger.c: Handling message for SAPI/TEI=0/0 [Apr 7 17:58:05] VERBOSE[9752] logger.c: -- ACKing all packets from 55 to (but not including) 56 [Apr 7 17:58:05] VERBOSE[9752] logger.c: -- Since there was nothing left, stopping T200 counter [Apr 7 17:58:05] VERBOSE[9752] logger.c: -- Stopping T203 counter since we got an ACK [Apr 7 17:58:05] VERBOSE[9752] logger.c: -- Nothing left, starting T203 counter [Apr 7 17:58:05] VERBOSE[9752] logger.c: < Protocol Discriminator: Q.931 (8) len=9 [Apr 7 17:58:05] VERBOSE[9752] logger.c: < Call Ref: len= 2 (reference 26199/0x6657) (Originator) [Apr 7 17:58:05] VERBOSE[9752] logger.c: < Message type: INFORMATION (123) [Apr 7 17:58:05] VERBOSE[9752] logger.c: < [70 02 80 33] [Apr 7 17:58:05] VERBOSE[9752] logger.c: < Called Number (len= 4) [ Ext: 1 TON: Unknown Number Type (0) NPI: Unknown Number Plan (0) '3' ] [Apr 7 17:58:05] VERBOSE[9752] logger.c: -- Processing IE 112 (cs0, Called Party Number) [Apr 7 17:58:05] VERBOSE[9752] logger.c: Sending Receiver Ready (125) [Apr 7 17:58:05] VERBOSE[9752] logger.c: [Apr 7 17:58:05] VERBOSE[9752] logger.c: [Apr 7 17:58:05] VERBOSE[9752] logger.c: > SAPI: 00 C/R: 0 EA: 0 [Apr 7 17:58:05] VERBOSE[9752] logger.c: > Zero: 0 S: 0 01: 1 [ RR (receive ready) ] [Apr 7 17:58:05] VERBOSE[9752] logger.c: -- Restarting T203 timer [Apr 7 17:58:05] VERBOSE[9752] logger.c: [Apr 7 17:58:05] VERBOSE[9752] logger.c: [Apr 7 17:58:05] VERBOSE[9752] logger.c: < SAPI: 00 C/R: 0 EA: 0 [Apr 7 17:58:05] VERBOSE[9752] logger.c: < N(S): 125 0: 0 [Apr 7 17:58:05] VERBOSE[9752] logger.c: Handling message for SAPI/TEI=0/0 [Apr 7 17:58:05] VERBOSE[9752] logger.c: -- ACKing all packets from 55 to (but not including) 56 [Apr 7 17:58:05] VERBOSE[9752] logger.c: -- Since there was nothing left, stopping T200 counter [Apr 7 17:58:05] VERBOSE[9752] logger.c: -- Stopping T203 counter since we got an ACK [Apr 7 17:58:05] VERBOSE[9752] logger.c: -- Nothing left, starting T203 counter [Apr 7 17:58:05] VERBOSE[9752] logger.c: < Protocol Discriminator: Q.931 (8) len=9 [Apr 7 17:58:05] VERBOSE[9752] logger.c: < Call Ref: len= 2 (reference 26199/0x6657) (Originator) [Apr 7 17:58:05] VERBOSE[9752] logger.c: < Message type: INFORMATION (123) [Apr 7 17:58:05] VERBOSE[9752] logger.c: < [70 02 80 32] [Apr 7 17:58:05] VERBOSE[9752] logger.c: < Called Number (len= 4) [ Ext: 1 TON: Unknown Number Type (0) NPI: Unknown Number Plan (0) '2' ] [Apr 7 17:58:05] VERBOSE[9752] logger.c: -- Processing IE 112 (cs0, Called Party Number) [Apr 7 17:58:05] VERBOSE[9752] logger.c: Sending Receiver Ready (126) [Apr 7 17:58:05] VERBOSE[9752] logger.c: [Apr 7 17:58:05] VERBOSE[9752] logger.c: [Apr 7 17:58:05] VERBOSE[9752] logger.c: > SAPI: 00 C/R: 0 EA: 0 [Apr 7 17:58:05] VERBOSE[9752] logger.c: > Zero: 0 S: 0 01: 1 [ RR (receive ready) ] [Apr 7 17:58:05] VERBOSE[9752] logger.c: -- Restarting T203 timer [Apr 7 17:58:07] VERBOSE[9752] logger.c: [Apr 7 17:58:07] VERBOSE[9752] logger.c: [Apr 7 17:58:07] VERBOSE[9752] logger.c: < SAPI: 00 C/R: 0 EA: 0 [Apr 7 17:58:07] VERBOSE[9752] logger.c: < N(S): 126 0: 0 [Apr 7 17:58:07] VERBOSE[9752] logger.c: Handling message for SAPI/TEI=0/0 [Apr 7 17:58:07] VERBOSE[9752] logger.c: -- ACKing all packets from 55 to (but not including) 56 [Apr 7 17:58:07] VERBOSE[9752] logger.c: -- Since there was nothing left, stopping T200 counter [Apr 7 17:58:07] VERBOSE[9752] logger.c: -- Stopping T203 counter since we got an ACK [Apr 7 17:58:07] VERBOSE[9752] logger.c: -- Nothing left, starting T203 counter [Apr 7 17:58:07] VERBOSE[9752] logger.c: < Protocol Discriminator: Q.931 (8) len=9 [Apr 7 17:58:07] VERBOSE[9752] logger.c: < Call Ref: len= 2 (reference 26199/0x6657) (Originator) [Apr 7 17:58:07] VERBOSE[9752] logger.c: < Message type: INFORMATION (123) [Apr 7 17:58:07] VERBOSE[9752] logger.c: < [70 02 80 32] [Apr 7 17:58:07] VERBOSE[9752] logger.c: < Called Number (len= 4) [ Ext: 1 TON: Unknown Number Type (0) NPI: Unknown Number Plan (0) 'X' ] [Apr 7 17:58:07] VERBOSE[9752] logger.c: -- Processing IE 112 (cs0, Called Party Number) [Apr 7 17:58:07] VERBOSE[9752] logger.c: Sending Receiver Ready (127) [Apr 7 17:58:07] VERBOSE[9752] logger.c: [Apr 7 17:58:07] VERBOSE[9752] logger.c: [Apr 7 17:58:07] VERBOSE[9752] logger.c: > SAPI: 00 C/R: 0 EA: 0 [Apr 7 17:58:07] VERBOSE[9752] logger.c: > Zero: 0 S: 0 01: 1 [ RR (receive ready) ] [Apr 7 17:58:07] VERBOSE[9752] logger.c: -- Restarting T203 timer [Apr 7 17:58:07] VERBOSE[9752] logger.c: [Apr 7 17:58:07] VERBOSE[9752] logger.c: [Apr 7 17:58:07] VERBOSE[9752] logger.c: < SAPI: 00 C/R: 0 EA: 0 [Apr 7 17:58:07] VERBOSE[9752] logger.c: < N(S): 127 0: 0 [Apr 7 17:58:07] VERBOSE[9752] logger.c: Handling message for SAPI/TEI=0/0 [Apr 7 17:58:07] VERBOSE[9752] logger.c: -- ACKing all packets from 55 to (but not including) 56 [Apr 7 17:58:07] VERBOSE[9752] logger.c: -- Since there was nothing left, stopping T200 counter [Apr 7 17:58:07] VERBOSE[9752] logger.c: -- Stopping T203 counter since we got an ACK [Apr 7 17:58:07] VERBOSE[9752] logger.c: -- Nothing left, starting T203 counter [Apr 7 17:58:07] VERBOSE[9752] logger.c: < Protocol Discriminator: Q.931 (8) len=9 [Apr 7 17:58:07] VERBOSE[9752] logger.c: < Call Ref: len= 2 (reference 26199/0x6657) (Originator) [Apr 7 17:58:07] VERBOSE[9752] logger.c: < Message type: INFORMATION (123) [Apr 7 17:58:07] VERBOSE[9752] logger.c: < [70 02 80 35] [Apr 7 17:58:07] VERBOSE[9752] logger.c: < Called Number (len= 4) [ Ext: 1 TON: Unknown Number Type (0) NPI: Unknown Number Plan (0) 'X' ] [Apr 7 17:58:07] VERBOSE[9752] logger.c: -- Processing IE 112 (cs0, Called Party Number) [Apr 7 17:58:07] VERBOSE[9752] logger.c: Sending Receiver Ready (0) [Apr 7 17:58:07] VERBOSE[9752] logger.c: [Apr 7 17:58:07] VERBOSE[9752] logger.c: [Apr 7 17:58:07] VERBOSE[9752] logger.c: > SAPI: 00 C/R: 0 EA: 0 [Apr 7 17:58:07] VERBOSE[9752] logger.c: > Zero: 0 S: 0 01: 1 [ RR (receive ready) ] [Apr 7 17:58:07] VERBOSE[9752] logger.c: -- Restarting T203 timer [Apr 7 17:58:07] VERBOSE[9752] logger.c: [Apr 7 17:58:07] VERBOSE[9752] logger.c: [Apr 7 17:58:07] VERBOSE[9752] logger.c: < SAPI: 00 C/R: 0 EA: 0 [Apr 7 17:58:07] VERBOSE[9752] logger.c: < N(S): 000 0: 0 [Apr 7 17:58:07] VERBOSE[9752] logger.c: Handling message for SAPI/TEI=0/0 [Apr 7 17:58:07] VERBOSE[9752] logger.c: -- ACKing all packets from 55 to (but not including) 56 [Apr 7 17:58:07] VERBOSE[9752] logger.c: -- Since there was nothing left, stopping T200 counter [Apr 7 17:58:07] VERBOSE[9752] logger.c: -- Stopping T203 counter since we got an ACK [Apr 7 17:58:07] VERBOSE[9752] logger.c: -- Nothing left, starting T203 counter [Apr 7 17:58:07] VERBOSE[9752] logger.c: < Protocol Discriminator: Q.931 (8) len=9 [Apr 7 17:58:07] VERBOSE[9752] logger.c: < Call Ref: len= 2 (reference 26199/0x6657) (Originator) [Apr 7 17:58:07] VERBOSE[9752] logger.c: < Message type: INFORMATION (123) [Apr 7 17:58:07] VERBOSE[9752] logger.c: < [70 02 80 31] [Apr 7 17:58:07] VERBOSE[9752] logger.c: < Called Number (len= 4) [ Ext: 1 TON: Unknown Number Type (0) NPI: Unknown Number Plan (0) 'X' ] [Apr 7 17:58:07] VERBOSE[9752] logger.c: -- Processing IE 112 (cs0, Called Party Number) [Apr 7 17:58:07] VERBOSE[9752] logger.c: Sending Receiver Ready (1) [Apr 7 17:58:07] VERBOSE[9752] logger.c: [Apr 7 17:58:07] VERBOSE[9752] logger.c: [Apr 7 17:58:07] VERBOSE[9752] logger.c: > SAPI: 00 C/R: 0 EA: 0 [Apr 7 17:58:07] VERBOSE[9752] logger.c: > Zero: 0 S: 0 01: 1 [ RR (receive ready) ] [Apr 7 17:58:07] VERBOSE[9752] logger.c: -- Restarting T203 timer [Apr 7 17:58:07] VERBOSE[9752] logger.c: [Apr 7 17:58:07] VERBOSE[9752] logger.c: [Apr 7 17:58:07] VERBOSE[9752] logger.c: < SAPI: 00 C/R: 0 EA: 0 [Apr 7 17:58:07] VERBOSE[9752] logger.c: < N(S): 001 0: 0 [Apr 7 17:58:07] VERBOSE[9752] logger.c: Handling message for SAPI/TEI=0/0 [Apr 7 17:58:07] VERBOSE[9752] logger.c: -- ACKing all packets from 55 to (but not including) 56 [Apr 7 17:58:07] VERBOSE[9752] logger.c: -- Since there was nothing left, stopping T200 counter [Apr 7 17:58:07] VERBOSE[9752] logger.c: -- Stopping T203 counter since we got an ACK [Apr 7 17:58:07] VERBOSE[9752] logger.c: -- Nothing left, starting T203 counter [Apr 7 17:58:07] VERBOSE[9752] logger.c: < Protocol Discriminator: Q.931 (8) len=9 [Apr 7 17:58:07] VERBOSE[9752] logger.c: < Call Ref: len= 2 (reference 26199/0x6657) (Originator) [Apr 7 17:58:07] VERBOSE[9752] logger.c: < Message type: INFORMATION (123) [Apr 7 17:58:07] VERBOSE[9752] logger.c: < [70 02 80 32] [Apr 7 17:58:07] VERBOSE[9752] logger.c: < Called Number (len= 4) [ Ext: 1 TON: Unknown Number Type (0) NPI: Unknown Number Plan (0) 'X' ] [Apr 7 17:58:07] VERBOSE[9752] logger.c: -- Processing IE 112 (cs0, Called Party Number) [Apr 7 17:58:07] VERBOSE[9752] logger.c: Sending Receiver Ready (2) [Apr 7 17:58:07] VERBOSE[9752] logger.c: [Apr 7 17:58:07] VERBOSE[9752] logger.c: [Apr 7 17:58:07] VERBOSE[9752] logger.c: > SAPI: 00 C/R: 0 EA: 0 [Apr 7 17:58:07] VERBOSE[9752] logger.c: > Zero: 0 S: 0 01: 1 [ RR (receive ready) ] [Apr 7 17:58:07] VERBOSE[9752] logger.c: -- Restarting T203 timer [Apr 7 17:58:08] VERBOSE[9752] logger.c: [Apr 7 17:58:08] VERBOSE[9752] logger.c: [Apr 7 17:58:08] VERBOSE[9752] logger.c: < SAPI: 00 C/R: 0 EA: 0 [Apr 7 17:58:08] VERBOSE[9752] logger.c: < N(S): 002 0: 0 [Apr 7 17:58:08] VERBOSE[9752] logger.c: Handling message for SAPI/TEI=0/0 [Apr 7 17:58:08] VERBOSE[9752] logger.c: -- ACKing all packets from 55 to (but not including) 56 [Apr 7 17:58:08] VERBOSE[9752] logger.c: -- Since there was nothing left, stopping T200 counter [Apr 7 17:58:08] VERBOSE[9752] logger.c: -- Stopping T203 counter since we got an ACK [Apr 7 17:58:08] VERBOSE[9752] logger.c: -- Nothing left, starting T203 counter [Apr 7 17:58:08] VERBOSE[9752] logger.c: < Protocol Discriminator: Q.931 (8) len=9 [Apr 7 17:58:08] VERBOSE[9752] logger.c: < Call Ref: len= 2 (reference 26199/0x6657) (Originator) [Apr 7 17:58:08] VERBOSE[9752] logger.c: < Message type: INFORMATION (123) [Apr 7 17:58:08] VERBOSE[9752] logger.c: < [70 02 80 36] [Apr 7 17:58:08] VERBOSE[9752] logger.c: < Called Number (len= 4) [ Ext: 1 TON: Unknown Number Type (0) NPI: Unknown Number Plan (0) 'X' ] [Apr 7 17:58:08] VERBOSE[9752] logger.c: -- Processing IE 112 (cs0, Called Party Number) [Apr 7 17:58:08] VERBOSE[9752] logger.c: Sending Receiver Ready (3) [Apr 7 17:58:08] VERBOSE[9752] logger.c: [Apr 7 17:58:08] VERBOSE[9752] logger.c: [Apr 7 17:58:08] VERBOSE[9752] logger.c: > SAPI: 00 C/R: 0 EA: 0 [Apr 7 17:58:08] VERBOSE[9752] logger.c: > Zero: 0 S: 0 01: 1 [ RR (receive ready) ] [Apr 7 17:58:08] VERBOSE[9752] logger.c: -- Restarting T203 timer [Apr 7 17:58:08] VERBOSE[9809] logger.c: -- Executing [01932XXXXX@in-from-siemens:1] Dial("DAHDI/40-1", "DAHDI/G1/01932XXXXX") in new stack [Apr 7 17:58:08] VERBOSE[9809] logger.c: -- Making new call for cr 32779 [Apr 7 17:58:08] VERBOSE[9809] logger.c: -- Requested transfer capability: 0x00 - SPEECH [Apr 7 17:58:08] VERBOSE[9809] logger.c: -- Finally transmitting 47, since window opened up (0) [Apr 7 17:58:08] VERBOSE[9809] logger.c: [Apr 7 17:58:08] VERBOSE[9809] logger.c: [Apr 7 17:58:08] VERBOSE[9809] logger.c: > SAPI: 00 C/R: 0 EA: 0 [Apr 7 17:58:08] VERBOSE[9809] logger.c: > N(S): 047 0: 0 [Apr 7 17:58:08] VERBOSE[9809] logger.c: Stopping T_203 timer [Apr 7 17:58:08] VERBOSE[9809] logger.c: Starting T_200 timer [Apr 7 17:58:08] VERBOSE[9809] logger.c: -- Restarting T200 timer [Apr 7 17:58:08] VERBOSE[9809] logger.c: > Protocol Discriminator: Q.931 (8) len=38 [Apr 7 17:58:08] VERBOSE[9809] logger.c: > Call Ref: len= 2 (reference 11/0xB) (Originator) [Apr 7 17:58:08] VERBOSE[9809] logger.c: > Message type: SETUP (5) [Apr 7 17:58:08] VERBOSE[9809] logger.c: > [04 03 80 90 a3] [Apr 7 17:58:08] VERBOSE[9809] logger.c: > Bearer Capability (len= 5) [ Ext: 1 Q.931 Std: 0 Info transfer capability: Speech (0) [Apr 7 17:58:08] VERBOSE[9809] logger.c: > Ext: 1 Trans mode/rate: 64kbps, circuit-mode (16) [Apr 7 17:58:08] VERBOSE[9809] logger.c: > User information layer 1: A-Law (35) [Apr 7 17:58:08] VERBOSE[9809] logger.c: > [18 03 a1 83 8f] [Apr 7 17:58:08] VERBOSE[9809] logger.c: > Channel ID (len= 5) [ Ext: 1 IntID: Implicit PRI Spare: 0 Preferred Dchan: 0 [Apr 7 17:58:08] VERBOSE[9809] logger.c: > ChanSel: As indicated in following octets [Apr 7 17:58:08] VERBOSE[9809] logger.c: > Ext: 1 Coding: 0 Number Specified Channel Type: 3 [Apr 7 17:58:08] VERBOSE[9809] logger.c: > Ext: 1 Channel: 15 ] [Apr 7 17:58:08] VERBOSE[9809] logger.c: > [6c 08 00 83 35 35 38 32 33 37] [Apr 7 17:58:08] VERBOSE[9809] logger.c: > Calling Number (len=10) [ Ext: 0 TON: Unknown Number Type (0) NPI: Unknown Number Plan (0) [Apr 7 17:58:08] VERBOSE[9809] logger.c: > Presentation: Presentation allowed of network provided number (3) '558XXX' ] [Apr 7 17:58:08] VERBOSE[9809] logger.c: > [70 0b 80 30 31 39 33 32 32 35 31 32 36] [Apr 7 17:58:08] VERBOSE[9809] logger.c: > Called Number (len=13) [ Ext: 1 TON: Unknown Number Type (0) NPI: Unknown Number Plan (0) '01932XXXXX' ] [Apr 7 17:58:08] VERBOSE[9809] logger.c: q931.c:3134 q931_setup: call 32779 on channel 15 enters state 1 (Call Initiated) [Apr 7 17:58:08] VERBOSE[9809] logger.c: -- Called G1/01932XXXXX [Apr 7 17:58:08] VERBOSE[9751] logger.c: [Apr 7 17:58:08] VERBOSE[9751] logger.c: [Apr 7 17:58:08] VERBOSE[9751] logger.c: < SAPI: 00 C/R: 0 EA: 0 [Apr 7 17:58:08] VERBOSE[9751] logger.c: < Zero: 0 S: 0 01: 1 [ RR (receive ready) ] [Apr 7 17:58:08] VERBOSE[9751] logger.c: Handling message for SAPI/TEI=0/0 [Apr 7 17:58:08] VERBOSE[9751] logger.c: -- ACKing all packets from 46 to (but not including) 48 [Apr 7 17:58:08] VERBOSE[9751] logger.c: -- ACKing packet 47, new txqueue is -1 (-1 means empty) [Apr 7 17:58:08] VERBOSE[9751] logger.c: -- Since there was nothing left, stopping T200 counter [Apr 7 17:58:08] VERBOSE[9751] logger.c: -- Nothing left, starting T203 counter [Apr 7 17:58:08] VERBOSE[9751] logger.c: -- Restarting T203 timer [Apr 7 17:58:08] VERBOSE[9751] logger.c: [Apr 7 17:58:08] VERBOSE[9751] logger.c: [Apr 7 17:58:08] VERBOSE[9751] logger.c: < SAPI: 00 C/R: 1 EA: 0 [Apr 7 17:58:08] VERBOSE[9751] logger.c: < N(S): 043 0: 0 [Apr 7 17:58:08] VERBOSE[9751] logger.c: Handling message for SAPI/TEI=0/0 [Apr 7 17:58:08] VERBOSE[9751] logger.c: -- ACKing all packets from 47 to (but not including) 48 [Apr 7 17:58:08] VERBOSE[9751] logger.c: -- Since there was nothing left, stopping T200 counter [Apr 7 17:58:08] VERBOSE[9751] logger.c: -- Stopping T203 counter since we got an ACK [Apr 7 17:58:08] VERBOSE[9751] logger.c: -- Nothing left, starting T203 counter [Apr 7 17:58:08] VERBOSE[9751] logger.c: < Protocol Discriminator: Q.931 (8) len=10 [Apr 7 17:58:08] VERBOSE[9751] logger.c: < Call Ref: len= 2 (reference 11/0xB) (Terminator) [Apr 7 17:58:08] VERBOSE[9751] logger.c: < Message type: SETUP ACKNOWLEDGE (13) [Apr 7 17:58:08] VERBOSE[9751] logger.c: < [18 03 a9 83 8f] [Apr 7 17:58:08] VERBOSE[9751] logger.c: < Channel ID (len= 5) [ Ext: 1 IntID: Implicit PRI Spare: 0 Exclusive Dchan: 0 [Apr 7 17:58:08] VERBOSE[9751] logger.c: < ChanSel: As indicated in following octets [Apr 7 17:58:08] VERBOSE[9751] logger.c: < Ext: 1 Coding: 0 Number Specified Channel Type: 3 [Apr 7 17:58:08] VERBOSE[9751] logger.c: < Ext: 1 Channel: 15 ] [Apr 7 17:58:08] VERBOSE[9751] logger.c: -- Processing IE 24 (cs0, Channel Identification) [Apr 7 17:58:08] VERBOSE[9751] logger.c: q931.c:3891 q931_receive: call 32779 on channel 15 enters state 2 (Overlap sending) [Apr 7 17:58:08] VERBOSE[9751] logger.c: Sending Receiver Ready (44) [Apr 7 17:58:08] VERBOSE[9751] logger.c: [Apr 7 17:58:08] VERBOSE[9751] logger.c: [Apr 7 17:58:08] VERBOSE[9751] logger.c: > SAPI: 00 C/R: 1 EA: 0 [Apr 7 17:58:08] VERBOSE[9751] logger.c: > Zero: 0 S: 0 01: 1 [ RR (receive ready) ] [Apr 7 17:58:08] VERBOSE[9751] logger.c: -- Restarting T203 timer [Apr 7 17:58:08] VERBOSE[9752] logger.c: [Apr 7 17:58:08] VERBOSE[9752] logger.c: [Apr 7 17:58:08] VERBOSE[9752] logger.c: < SAPI: 00 C/R: 0 EA: 0 [Apr 7 17:58:08] VERBOSE[9752] logger.c: < N(S): 003 0: 0 [Apr 7 17:58:08] VERBOSE[9752] logger.c: Handling message for SAPI/TEI=0/0 [Apr 7 17:58:08] VERBOSE[9752] logger.c: -- ACKing all packets from 55 to (but not including) 56 [Apr 7 17:58:08] VERBOSE[9752] logger.c: -- Since there was nothing left, stopping T200 counter [Apr 7 17:58:08] VERBOSE[9752] logger.c: -- Stopping T203 counter since we got an ACK [Apr 7 17:58:08] VERBOSE[9752] logger.c: -- Nothing left, starting T203 counter [Apr 7 17:58:08] VERBOSE[9752] logger.c: < Protocol Discriminator: Q.931 (8) len=9 [Apr 7 17:58:08] VERBOSE[9752] logger.c: < Call Ref: len= 2 (reference 26199/0x6657) (Originator) [Apr 7 17:58:08] VERBOSE[9752] logger.c: < Message type: INFORMATION (123) [Apr 7 17:58:08] VERBOSE[9752] logger.c: < [70 02 80 38] [Apr 7 17:58:08] VERBOSE[9752] logger.c: < Called Number (len= 4) [ Ext: 1 TON: Unknown Number Type (0) NPI: Unknown Number Plan (0) '8' ] [Apr 7 17:58:08] VERBOSE[9752] logger.c: -- Processing IE 112 (cs0, Called Party Number) [Apr 7 17:58:08] VERBOSE[9752] logger.c: Sending Receiver Ready (4) [Apr 7 17:58:08] VERBOSE[9752] logger.c: [Apr 7 17:58:08] VERBOSE[9752] logger.c: [Apr 7 17:58:08] VERBOSE[9752] logger.c: > SAPI: 00 C/R: 0 EA: 0 [Apr 7 17:58:08] VERBOSE[9752] logger.c: > Zero: 0 S: 0 01: 1 [ RR (receive ready) ] [Apr 7 17:58:08] VERBOSE[9752] logger.c: -- Restarting T203 timer [Apr 7 17:58:08] VERBOSE[9809] logger.c: -- Finally transmitting 48, since window opened up (0) [Apr 7 17:58:08] VERBOSE[9809] logger.c: [Apr 7 17:58:08] VERBOSE[9809] logger.c: [Apr 7 17:58:08] VERBOSE[9809] logger.c: > SAPI: 00 C/R: 0 EA: 0 [Apr 7 17:58:08] VERBOSE[9809] logger.c: > N(S): 048 0: 0 [Apr 7 17:58:08] VERBOSE[9809] logger.c: Stopping T_203 timer [Apr 7 17:58:08] VERBOSE[9809] logger.c: Starting T_200 timer [Apr 7 17:58:08] VERBOSE[9809] logger.c: -- Restarting T200 timer [Apr 7 17:58:08] VERBOSE[9809] logger.c: > Protocol Discriminator: Q.931 (8) len=9 [Apr 7 17:58:08] VERBOSE[9809] logger.c: > Call Ref: len= 2 (reference 11/0xB) (Originator) [Apr 7 17:58:08] VERBOSE[9809] logger.c: > Message type: INFORMATION (123) [Apr 7 17:58:08] VERBOSE[9809] logger.c: > [70 02 80 38] [Apr 7 17:58:08] VERBOSE[9809] logger.c: > Called Number (len= 4) [ Ext: 1 TON: Unknown Number Type (0) NPI: Unknown Number Plan (0) '8' ] [Apr 7 17:58:08] VERBOSE[9751] logger.c: [Apr 7 17:58:08] VERBOSE[9751] logger.c: [Apr 7 17:58:08] VERBOSE[9751] logger.c: < SAPI: 00 C/R: 0 EA: 0 [Apr 7 17:58:08] VERBOSE[9751] logger.c: < Zero: 0 S: 0 01: 1 [ RR (receive ready) ] [Apr 7 17:58:08] VERBOSE[9751] logger.c: Handling message for SAPI/TEI=0/0 [Apr 7 17:58:08] VERBOSE[9751] logger.c: -- ACKing all packets from 47 to (but not including) 49 [Apr 7 17:58:08] VERBOSE[9751] logger.c: -- ACKing packet 48, new txqueue is -1 (-1 means empty) [Apr 7 17:58:08] VERBOSE[9751] logger.c: -- Since there was nothing left, stopping T200 counter [Apr 7 17:58:08] VERBOSE[9751] logger.c: -- Nothing left, starting T203 counter [Apr 7 17:58:08] VERBOSE[9751] logger.c: -- Restarting T203 timer [Apr 7 17:58:12] VERBOSE[9751] logger.c: [Apr 7 17:58:12] VERBOSE[9751] logger.c: [Apr 7 17:58:12] VERBOSE[9751] logger.c: < SAPI: 00 C/R: 1 EA: 0 [Apr 7 17:58:12] VERBOSE[9751] logger.c: < N(S): 044 0: 0 [Apr 7 17:58:12] VERBOSE[9751] logger.c: Handling message for SAPI/TEI=0/0 [Apr 7 17:58:12] VERBOSE[9751] logger.c: -- ACKing all packets from 48 to (but not including) 49 [Apr 7 17:58:12] VERBOSE[9751] logger.c: -- Since there was nothing left, stopping T200 counter [Apr 7 17:58:12] VERBOSE[9751] logger.c: -- Stopping T203 counter since we got an ACK [Apr 7 17:58:12] VERBOSE[9751] logger.c: -- Nothing left, starting T203 counter [Apr 7 17:58:12] VERBOSE[9751] logger.c: < Protocol Discriminator: Q.931 (8) len=5 [Apr 7 17:58:12] VERBOSE[9751] logger.c: < Call Ref: len= 2 (reference 11/0xB) (Terminator) [Apr 7 17:58:12] VERBOSE[9751] logger.c: < Message type: CALL PROCEEDING (2) [Apr 7 17:58:12] VERBOSE[9751] logger.c: q931.c:3683 q931_receive: call 32779 on channel 15 enters state 3 (Outgoing call Proceeding) [Apr 7 17:58:12] VERBOSE[9751] logger.c: Sending Receiver Ready (45) [Apr 7 17:58:12] VERBOSE[9751] logger.c: [Apr 7 17:58:12] VERBOSE[9751] logger.c: [Apr 7 17:58:12] VERBOSE[9751] logger.c: > SAPI: 00 C/R: 1 EA: 0 [Apr 7 17:58:12] VERBOSE[9751] logger.c: > Zero: 0 S: 0 01: 1 [ RR (receive ready) ] [Apr 7 17:58:12] VERBOSE[9751] logger.c: -- Restarting T203 timer [Apr 7 17:58:12] DEBUG[9751] chan_dahdi.c: Queuing frame from PRI_EVENT_PROCEEDING on channel 0/15 span 1 [Apr 7 17:58:12] VERBOSE[9809] logger.c: -- DAHDI/15-1 is proceeding passing it to DAHDI/40-1 [Apr 7 17:58:12] DEBUG[9809] chan_dahdi.c: Received AST_CONTROL_PROCEEDING on DAHDI/40-1 [Apr 7 17:58:12] VERBOSE[9809] logger.c: q931.c:2816 q931_call_proceeding: call 26199 on channel 9 enters state 9 (Incoming Call Proceeding) [Apr 7 17:58:12] VERBOSE[9809] logger.c: -- Finally transmitting 56, since window opened up (0) [Apr 7 17:58:12] VERBOSE[9809] logger.c: [Apr 7 17:58:12] VERBOSE[9809] logger.c: [Apr 7 17:58:12] VERBOSE[9809] logger.c: > SAPI: 00 C/R: 1 EA: 0 [Apr 7 17:58:12] VERBOSE[9809] logger.c: > N(S): 056 0: 0 [Apr 7 17:58:12] VERBOSE[9809] logger.c: Stopping T_203 timer [Apr 7 17:58:12] VERBOSE[9809] logger.c: Starting T_200 timer [Apr 7 17:58:12] VERBOSE[9809] logger.c: -- Restarting T200 timer [Apr 7 17:58:12] VERBOSE[9809] logger.c: > Protocol Discriminator: Q.931 (8) len=14 [Apr 7 17:58:12] VERBOSE[9809] logger.c: > Call Ref: len= 2 (reference 26199/0x6657) (Terminator) [Apr 7 17:58:12] VERBOSE[9809] logger.c: > Message type: CALL PROCEEDING (2) [Apr 7 17:58:12] VERBOSE[9809] logger.c: > [18 03 a9 83 89] [Apr 7 17:58:12] VERBOSE[9809] logger.c: > Channel ID (len= 5) [ Ext: 1 IntID: Implicit PRI Spare: 0 Exclusive Dchan: 0 [Apr 7 17:58:12] VERBOSE[9809] logger.c: > ChanSel: As indicated in following octets [Apr 7 17:58:12] VERBOSE[9809] logger.c: > Ext: 1 Coding: 0 Number Specified Channel Type: 3 [Apr 7 17:58:12] VERBOSE[9809] logger.c: > Ext: 1 Channel: 9 ] [Apr 7 17:58:12] VERBOSE[9809] logger.c: > [1e 02 81 88] [Apr 7 17:58:12] VERBOSE[9809] logger.c: > Progress Indicator (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) 0: 0 Location: Private network serving the local user (1) [Apr 7 17:58:12] VERBOSE[9809] logger.c: > Ext: 1 Progress Description: Inband information or appropriate pattern now available. (8) ] [Apr 7 17:58:12] VERBOSE[9752] logger.c: [Apr 7 17:58:12] VERBOSE[9752] logger.c: [Apr 7 17:58:12] VERBOSE[9752] logger.c: < SAPI: 00 C/R: 1 EA: 0 [Apr 7 17:58:12] VERBOSE[9752] logger.c: < Zero: 0 S: 0 01: 1 [ RR (receive ready) ] [Apr 7 17:58:12] VERBOSE[9752] logger.c: Handling message for SAPI/TEI=0/0 [Apr 7 17:58:12] VERBOSE[9752] logger.c: -- ACKing all packets from 55 to (but not including) 57 [Apr 7 17:58:12] VERBOSE[9752] logger.c: -- ACKing packet 56, new txqueue is -1 (-1 means empty) [Apr 7 17:58:12] VERBOSE[9752] logger.c: -- Since there was nothing left, stopping T200 counter [Apr 7 17:58:12] VERBOSE[9752] logger.c: -- Nothing left, starting T203 counter [Apr 7 17:58:12] VERBOSE[9752] logger.c: -- Restarting T203 timer [Apr 7 17:58:12] VERBOSE[9751] logger.c: [Apr 7 17:58:12] VERBOSE[9751] logger.c: [Apr 7 17:58:12] VERBOSE[9751] logger.c: < SAPI: 00 C/R: 1 EA: 0 [Apr 7 17:58:12] VERBOSE[9751] logger.c: < N(S): 045 0: 0 [Apr 7 17:58:12] VERBOSE[9751] logger.c: Handling message for SAPI/TEI=0/0 [Apr 7 17:58:12] VERBOSE[9751] logger.c: -- ACKing all packets from 48 to (but not including) 49 [Apr 7 17:58:12] VERBOSE[9751] logger.c: -- Since there was nothing left, stopping T200 counter [Apr 7 17:58:12] VERBOSE[9751] logger.c: -- Stopping T203 counter since we got an ACK [Apr 7 17:58:12] VERBOSE[9751] logger.c: -- Nothing left, starting T203 counter [Apr 7 17:58:12] VERBOSE[9751] logger.c: < Protocol Discriminator: Q.931 (8) len=9 [Apr 7 17:58:12] VERBOSE[9751] logger.c: < Call Ref: len= 2 (reference 11/0xB) (Terminator) [Apr 7 17:58:12] VERBOSE[9751] logger.c: < Message type: ALERTING (1) [Apr 7 17:58:12] VERBOSE[9751] logger.c: < [1e 02 84 88] [Apr 7 17:58:12] VERBOSE[9751] logger.c: < Progress Indicator (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) 0: 0 Location: Public network serving the remote user (4) [Apr 7 17:58:12] VERBOSE[9751] logger.c: < Ext: 1 Progress Description: Inband information or appropriate pattern now available. (8) ] [Apr 7 17:58:12] VERBOSE[9751] logger.c: -- Processing IE 30 (cs0, Progress Indicator) [Apr 7 17:58:12] VERBOSE[9751] logger.c: q931.c:3596 q931_receive: call 32779 on channel 15 enters state 4 (Call Delivered) [Apr 7 17:58:12] VERBOSE[9751] logger.c: Sending Receiver Ready (46) [Apr 7 17:58:12] VERBOSE[9751] logger.c: [Apr 7 17:58:12] VERBOSE[9751] logger.c: [Apr 7 17:58:12] VERBOSE[9751] logger.c: > SAPI: 00 C/R: 1 EA: 0 [Apr 7 17:58:12] VERBOSE[9751] logger.c: > Zero: 0 S: 0 01: 1 [ RR (receive ready) ] [Apr 7 17:58:12] VERBOSE[9751] logger.c: -- Restarting T203 timer [Apr 7 17:58:12] VERBOSE[9809] logger.c: -- DAHDI/15-1 is ringing [Apr 7 17:58:12] VERBOSE[9809] logger.c: q931.c:2844 q931_alerting: call 26199 on channel 9 enters state 7 (Call Received) [Apr 7 17:58:12] VERBOSE[9809] logger.c: -- Finally transmitting 57, since window opened up (0) [Apr 7 17:58:12] VERBOSE[9809] logger.c: [Apr 7 17:58:12] VERBOSE[9809] logger.c: [Apr 7 17:58:12] VERBOSE[9809] logger.c: > SAPI: 00 C/R: 1 EA: 0 [Apr 7 17:58:12] VERBOSE[9809] logger.c: > N(S): 057 0: 0 [Apr 7 17:58:12] VERBOSE[9809] logger.c: Stopping T_203 timer [Apr 7 17:58:12] VERBOSE[9809] logger.c: Starting T_200 timer [Apr 7 17:58:12] VERBOSE[9809] logger.c: -- Restarting T200 timer [Apr 7 17:58:12] VERBOSE[9809] logger.c: > Protocol Discriminator: Q.931 (8) len=9 [Apr 7 17:58:12] VERBOSE[9809] logger.c: > Call Ref: len= 2 (reference 26199/0x6657) (Terminator) [Apr 7 17:58:12] VERBOSE[9809] logger.c: > Message type: ALERTING (1) [Apr 7 17:58:12] VERBOSE[9809] logger.c: > [1e 02 81 88] [Apr 7 17:58:12] VERBOSE[9809] logger.c: > Progress Indicator (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) 0: 0 Location: Private network serving the local user (1) [Apr 7 17:58:12] VERBOSE[9809] logger.c: > Ext: 1 Progress Description: Inband information or appropriate pattern now available. (8) ] [Apr 7 17:58:12] VERBOSE[9752] logger.c: [Apr 7 17:58:12] VERBOSE[9752] logger.c: [Apr 7 17:58:12] VERBOSE[9752] logger.c: < SAPI: 00 C/R: 1 EA: 0 [Apr 7 17:58:12] VERBOSE[9752] logger.c: < Zero: 0 S: 0 01: 1 [ RR (receive ready) ] [Apr 7 17:58:12] VERBOSE[9752] logger.c: Handling message for SAPI/TEI=0/0 [Apr 7 17:58:12] VERBOSE[9752] logger.c: -- ACKing all packets from 56 to (but not including) 58 [Apr 7 17:58:12] VERBOSE[9752] logger.c: -- ACKing packet 57, new txqueue is -1 (-1 means empty) [Apr 7 17:58:12] VERBOSE[9752] logger.c: -- Since there was nothing left, stopping T200 counter [Apr 7 17:58:12] VERBOSE[9752] logger.c: -- Nothing left, starting T203 counter [Apr 7 17:58:12] VERBOSE[9752] logger.c: -- Restarting T203 timer [Apr 7 17:58:16] VERBOSE[9751] logger.c: [Apr 7 17:58:16] VERBOSE[9751] logger.c: [Apr 7 17:58:16] VERBOSE[9751] logger.c: < SAPI: 00 C/R: 1 EA: 0 [Apr 7 17:58:16] VERBOSE[9751] logger.c: < N(S): 046 0: 0 [Apr 7 17:58:16] VERBOSE[9751] logger.c: Handling message for SAPI/TEI=0/0 [Apr 7 17:58:16] VERBOSE[9751] logger.c: -- ACKing all packets from 48 to (but not including) 49 [Apr 7 17:58:16] VERBOSE[9751] logger.c: -- Since there was nothing left, stopping T200 counter [Apr 7 17:58:16] VERBOSE[9751] logger.c: -- Stopping T203 counter since we got an ACK [Apr 7 17:58:16] VERBOSE[9751] logger.c: -- Nothing left, starting T203 counter [Apr 7 17:58:16] VERBOSE[9751] logger.c: < Protocol Discriminator: Q.931 (8) len=5 [Apr 7 17:58:16] VERBOSE[9751] logger.c: < Call Ref: len= 2 (reference 11/0xB) (Terminator) [Apr 7 17:58:16] VERBOSE[9751] logger.c: < Message type: CONNECT (7) [Apr 7 17:58:16] VERBOSE[9751] logger.c: q931.c:3626 q931_receive: call 32779 on channel 15 enters state 10 (Active) [Apr 7 17:58:16] VERBOSE[9751] logger.c: -- Finally transmitting 49, since window opened up (0) [Apr 7 17:58:16] VERBOSE[9751] logger.c: [Apr 7 17:58:16] VERBOSE[9751] logger.c: [Apr 7 17:58:16] VERBOSE[9751] logger.c: > SAPI: 00 C/R: 0 EA: 0 [Apr 7 17:58:16] VERBOSE[9751] logger.c: > N(S): 049 0: 0 [Apr 7 17:58:16] VERBOSE[9751] logger.c: Stopping T_203 timer [Apr 7 17:58:16] VERBOSE[9751] logger.c: Starting T_200 timer [Apr 7 17:58:16] VERBOSE[9751] logger.c: -- Restarting T200 timer [Apr 7 17:58:16] VERBOSE[9751] logger.c: > Protocol Discriminator: Q.931 (8) len=5 [Apr 7 17:58:16] VERBOSE[9751] logger.c: > Call Ref: len= 2 (reference 11/0xB) (Originator) [Apr 7 17:58:16] VERBOSE[9751] logger.c: > Message type: CONNECT ACKNOWLEDGE (15) [Apr 7 17:58:16] VERBOSE[9751] logger.c: -- Restarting T203 timer [Apr 7 17:58:16] DEBUG[9751] chan_dahdi.c: Echo cancellation already on [Apr 7 17:58:16] VERBOSE[9751] logger.c: [Apr 7 17:58:16] VERBOSE[9751] logger.c: [Apr 7 17:58:16] VERBOSE[9751] logger.c: < SAPI: 00 C/R: 0 EA: 0 [Apr 7 17:58:16] VERBOSE[9751] logger.c: < Zero: 0 S: 0 01: 1 [ RR (receive ready) ] [Apr 7 17:58:16] VERBOSE[9751] logger.c: Handling message for SAPI/TEI=0/0 [Apr 7 17:58:16] VERBOSE[9751] logger.c: -- ACKing all packets from 48 to (but not including) 50 [Apr 7 17:58:16] VERBOSE[9751] logger.c: -- ACKing packet 49, new txqueue is -1 (-1 means empty) [Apr 7 17:58:16] VERBOSE[9751] logger.c: -- Since there was nothing left, stopping T200 counter [Apr 7 17:58:16] VERBOSE[9751] logger.c: -- Stopping T203 counter since we got an ACK [Apr 7 17:58:16] VERBOSE[9751] logger.c: -- Nothing left, starting T203 counter [Apr 7 17:58:16] VERBOSE[9751] logger.c: -- Restarting T203 timer [Apr 7 17:58:16] VERBOSE[9809] logger.c: -- DAHDI/15-1 answered DAHDI/40-1 [Apr 7 17:58:16] VERBOSE[9809] logger.c: q931.c:2949 q931_connect: call 26199 on channel 9 enters state 10 (Active) [Apr 7 17:58:16] VERBOSE[9809] logger.c: -- Finally transmitting 58, since window opened up (0) [Apr 7 17:58:16] VERBOSE[9809] logger.c: [Apr 7 17:58:16] VERBOSE[9809] logger.c: [Apr 7 17:58:16] VERBOSE[9809] logger.c: > SAPI: 00 C/R: 1 EA: 0 [Apr 7 17:58:16] VERBOSE[9809] logger.c: > N(S): 058 0: 0 [Apr 7 17:58:16] VERBOSE[9809] logger.c: Stopping T_203 timer [Apr 7 17:58:16] VERBOSE[9809] logger.c: Starting T_200 timer [Apr 7 17:58:16] VERBOSE[9809] logger.c: -- Restarting T200 timer [Apr 7 17:58:16] VERBOSE[9809] logger.c: > Protocol Discriminator: Q.931 (8) len=14 [Apr 7 17:58:16] VERBOSE[9809] logger.c: > Call Ref: len= 2 (reference 26199/0x6657) (Terminator) [Apr 7 17:58:16] VERBOSE[9809] logger.c: > Message type: CONNECT (7) [Apr 7 17:58:16] VERBOSE[9809] logger.c: > [18 03 a9 83 89] [Apr 7 17:58:16] VERBOSE[9809] logger.c: > Channel ID (len= 5) [ Ext: 1 IntID: Implicit PRI Spare: 0 Exclusive Dchan: 0 [Apr 7 17:58:16] VERBOSE[9809] logger.c: > ChanSel: As indicated in following octets [Apr 7 17:58:16] VERBOSE[9809] logger.c: > Ext: 1 Coding: 0 Number Specified Channel Type: 3 [Apr 7 17:58:16] VERBOSE[9809] logger.c: > Ext: 1 Channel: 9 ] [Apr 7 17:58:16] VERBOSE[9809] logger.c: > [1e 02 81 82] [Apr 7 17:58:16] VERBOSE[9809] logger.c: > Progress Indicator (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) 0: 0 Location: Private network serving the local user (1) [Apr 7 17:58:16] VERBOSE[9809] logger.c: > Ext: 1 Progress Description: Called equipment is non-ISDN. (2) ] [Apr 7 17:58:16] DEBUG[9809] chan_dahdi.c: master: 40, slave: 15, nothingok: 0 [Apr 7 17:58:16] DEBUG[9809] chan_dahdi.c: Stopping tones on 40/0 talking to 15/0 [Apr 7 17:58:16] DEBUG[9809] chan_dahdi.c: Stopping tones on 15/0 talking to 40/0 [Apr 7 17:58:16] DEBUG[9809] chan_dahdi.c: Making 15 slave to master 40 at 0 [Apr 7 17:58:16] DEBUG[9809] chan_dahdi.c: Added 24 to conference 9/40 [Apr 7 17:58:16] DEBUG[9809] chan_dahdi.c: Added 33 to conference 9/15 [Apr 7 17:58:16] VERBOSE[9809] logger.c: -- Native bridging DAHDI/40-1 and DAHDI/15-1 [Apr 7 17:58:16] VERBOSE[9752] logger.c: [Apr 7 17:58:16] VERBOSE[9752] logger.c: [Apr 7 17:58:16] VERBOSE[9752] logger.c: < SAPI: 00 C/R: 1 EA: 0 [Apr 7 17:58:16] VERBOSE[9752] logger.c: < Zero: 0 S: 0 01: 1 [ RR (receive ready) ] [Apr 7 17:58:16] VERBOSE[9752] logger.c: Handling message for SAPI/TEI=0/0 [Apr 7 17:58:16] VERBOSE[9752] logger.c: -- ACKing all packets from 57 to (but not including) 59 [Apr 7 17:58:16] VERBOSE[9752] logger.c: -- ACKing packet 58, new txqueue is -1 (-1 means empty) [Apr 7 17:58:16] VERBOSE[9752] logger.c: -- Since there was nothing left, stopping T200 counter [Apr 7 17:58:16] VERBOSE[9752] logger.c: -- Nothing left, starting T203 counter [Apr 7 17:58:16] VERBOSE[9752] logger.c: -- Restarting T203 timer [Apr 7 17:58:16] VERBOSE[9752] logger.c: [Apr 7 17:58:16] VERBOSE[9752] logger.c: [Apr 7 17:58:16] VERBOSE[9752] logger.c: < SAPI: 00 C/R: 0 EA: 0 [Apr 7 17:58:16] VERBOSE[9752] logger.c: < N(S): 004 0: 0 [Apr 7 17:58:16] VERBOSE[9752] logger.c: Handling message for SAPI/TEI=0/0 [Apr 7 17:58:16] VERBOSE[9752] logger.c: -- ACKing all packets from 58 to (but not including) 59 [Apr 7 17:58:16] VERBOSE[9752] logger.c: -- Since there was nothing left, stopping T200 counter [Apr 7 17:58:16] VERBOSE[9752] logger.c: -- Stopping T203 counter since we got an ACK [Apr 7 17:58:16] VERBOSE[9752] logger.c: -- Nothing left, starting T203 counter [Apr 7 17:58:16] VERBOSE[9752] logger.c: < Protocol Discriminator: Q.931 (8) len=5 [Apr 7 17:58:16] VERBOSE[9752] logger.c: < Call Ref: len= 2 (reference 26199/0x6657) (Originator) [Apr 7 17:58:16] VERBOSE[9752] logger.c: < Message type: CONNECT ACKNOWLEDGE (15) [Apr 7 17:58:16] VERBOSE[9752] logger.c: Sending Receiver Ready (5) [Apr 7 17:58:16] VERBOSE[9752] logger.c: [Apr 7 17:58:16] VERBOSE[9752] logger.c: [Apr 7 17:58:16] VERBOSE[9752] logger.c: > SAPI: 00 C/R: 0 EA: 0 [Apr 7 17:58:16] VERBOSE[9752] logger.c: > Zero: 0 S: 0 01: 1 [ RR (receive ready) ] [Apr 7 17:58:16] VERBOSE[9752] logger.c: -- Restarting T203 timer [Apr 7 17:58:21] VERBOSE[9752] logger.c: [Apr 7 17:58:21] VERBOSE[9752] logger.c: [Apr 7 17:58:21] VERBOSE[9752] logger.c: < SAPI: 00 C/R: 0 EA: 0 [Apr 7 17:58:21] VERBOSE[9752] logger.c: < N(S): 005 0: 0 [Apr 7 17:58:21] VERBOSE[9752] logger.c: Handling message for SAPI/TEI=0/0 [Apr 7 17:58:21] VERBOSE[9752] logger.c: -- ACKing all packets from 58 to (but not including) 59 [Apr 7 17:58:21] VERBOSE[9752] logger.c: -- Since there was nothing left, stopping T200 counter [Apr 7 17:58:21] VERBOSE[9752] logger.c: -- Stopping T203 counter since we got an ACK [Apr 7 17:58:21] VERBOSE[9752] logger.c: -- Nothing left, starting T203 counter [Apr 7 17:58:21] VERBOSE[9752] logger.c: < Protocol Discriminator: Q.931 (8) len=9 [Apr 7 17:58:21] VERBOSE[9752] logger.c: < Call Ref: len= 2 (reference 26199/0x6657) (Originator) [Apr 7 17:58:21] VERBOSE[9752] logger.c: < Message type: DISCONNECT (69) [Apr 7 17:58:21] VERBOSE[9752] logger.c: < [08 02 81 90] [Apr 7 17:58:21] VERBOSE[9752] logger.c: < Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) Spare: 0 Location: Private network serving the local user (1) [Apr 7 17:58:21] VERBOSE[9752] logger.c: < Ext: 1 Cause: Normal Clearing (16), class = Normal Event (1) ] [Apr 7 17:58:21] VERBOSE[9752] logger.c: -- Processing IE 8 (cs0, Cause) [Apr 7 17:58:21] VERBOSE[9752] logger.c: q931.c:3826 q931_receive: call 26199 on channel 9 enters state 12 (Disconnect Indication) [Apr 7 17:58:21] VERBOSE[9752] logger.c: Sending Receiver Ready (6) [Apr 7 17:58:21] VERBOSE[9752] logger.c: [Apr 7 17:58:21] VERBOSE[9752] logger.c: [Apr 7 17:58:21] VERBOSE[9752] logger.c: > SAPI: 00 C/R: 0 EA: 0 [Apr 7 17:58:21] VERBOSE[9752] logger.c: > Zero: 0 S: 0 01: 1 [ RR (receive ready) ] [Apr 7 17:58:21] VERBOSE[9752] logger.c: -- Restarting T203 timer [Apr 7 17:58:21] VERBOSE[9752] logger.c: -- Channel 0/9, span 2 got hangup request, cause 16 [Apr 7 17:58:21] DEBUG[9809] chan_dahdi.c: Echo cancellation already on [Apr 7 17:58:21] DEBUG[9809] chan_dahdi.c: Echo cancellation already on [Apr 7 17:58:21] DEBUG[9809] chan_dahdi.c: Unlinking slave 15 from 40 [Apr 7 17:58:21] DEBUG[9809] chan_dahdi.c: Removed 24 from conference 9/40 [Apr 7 17:58:21] DEBUG[9809] chan_dahdi.c: Removed 33 from conference 9/15 [Apr 7 17:58:21] DEBUG[9809] chan_dahdi.c: Set option AUDIO MODE, value: ON(1) on DAHDI/15-1 [Apr 7 17:58:21] DEBUG[9809] chan_dahdi.c: Not yet hungup... Calling hangup once with icause, and clearing call [Apr 7 17:58:21] VERBOSE[9809] logger.c: NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Active, peerstate Connect Request [Apr 7 17:58:21] VERBOSE[9809] logger.c: q931.c:3015 q931_disconnect: call 32779 on channel 15 enters state 11 (Disconnect Request) [Apr 7 17:58:21] VERBOSE[9809] logger.c: -- Finally transmitting 50, since window opened up (0) [Apr 7 17:58:21] VERBOSE[9809] logger.c: [Apr 7 17:58:21] VERBOSE[9809] logger.c: [Apr 7 17:58:21] VERBOSE[9809] logger.c: > SAPI: 00 C/R: 0 EA: 0 [Apr 7 17:58:21] VERBOSE[9809] logger.c: > N(S): 050 0: 0 [Apr 7 17:58:21] VERBOSE[9809] logger.c: Stopping T_203 timer [Apr 7 17:58:21] VERBOSE[9809] logger.c: Starting T_200 timer [Apr 7 17:58:21] VERBOSE[9809] logger.c: -- Restarting T200 timer [Apr 7 17:58:21] VERBOSE[9809] logger.c: > Protocol Discriminator: Q.931 (8) len=9 [Apr 7 17:58:21] VERBOSE[9809] logger.c: > Call Ref: len= 2 (reference 11/0xB) (Originator) [Apr 7 17:58:21] VERBOSE[9809] logger.c: > Message type: DISCONNECT (69) [Apr 7 17:58:21] VERBOSE[9809] logger.c: > [08 02 81 90] [Apr 7 17:58:21] VERBOSE[9809] logger.c: > Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) Spare: 0 Location: Private network serving the local user (1) [Apr 7 17:58:21] VERBOSE[9809] logger.c: > Ext: 1 Cause: Normal Clearing (16), class = Normal Event (1) ] [Apr 7 17:58:21] DEBUG[9809] chan_dahdi.c: Set option AUDIO MODE, value: OFF(0) on DAHDI/15-1 [Apr 7 17:58:21] VERBOSE[9809] logger.c: -- Hungup 'DAHDI/15-1' [Apr 7 17:58:21] VERBOSE[9809] logger.c: == Spawn extension (in-from-siemens, 01932XXXXX, 1) exited non-zero on 'DAHDI/40-1' [Apr 7 17:58:21] DEBUG[9809] chan_dahdi.c: Set option AUDIO MODE, value: ON(1) on DAHDI/40-1 [Apr 7 17:58:21] DEBUG[9809] chan_dahdi.c: Not yet hungup... Calling hangup once with icause, and clearing call [Apr 7 17:58:21] VERBOSE[9809] logger.c: NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Disconnect Indication, peerstate Disconnect Request [Apr 7 17:58:21] VERBOSE[9809] logger.c: q931.c:2967 q931_release: call 26199 on channel 9 enters state 19 (Release Request) [Apr 7 17:58:21] VERBOSE[9809] logger.c: -- Finally transmitting 59, since window opened up (0) [Apr 7 17:58:21] VERBOSE[9809] logger.c: [Apr 7 17:58:21] VERBOSE[9809] logger.c: [Apr 7 17:58:21] VERBOSE[9809] logger.c: > SAPI: 00 C/R: 1 EA: 0 [Apr 7 17:58:21] VERBOSE[9809] logger.c: > N(S): 059 0: 0 [Apr 7 17:58:21] VERBOSE[9809] logger.c: Stopping T_203 timer [Apr 7 17:58:21] VERBOSE[9809] logger.c: Starting T_200 timer [Apr 7 17:58:21] VERBOSE[9809] logger.c: -- Restarting T200 timer [Apr 7 17:58:21] VERBOSE[9809] logger.c: > Protocol Discriminator: Q.931 (8) len=9 [Apr 7 17:58:21] VERBOSE[9809] logger.c: > Call Ref: len= 2 (reference 26199/0x6657) (Terminator) [Apr 7 17:58:21] VERBOSE[9809] logger.c: > Message type: RELEASE (77) [Apr 7 17:58:21] VERBOSE[9809] logger.c: > [08 02 81 90] [Apr 7 17:58:21] VERBOSE[9809] logger.c: > Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) Spare: 0 Location: Private network serving the local user (1) [Apr 7 17:58:21] VERBOSE[9809] logger.c: > Ext: 1 Cause: Normal Clearing (16), class = Normal Event (1) ] [Apr 7 17:58:21] DEBUG[9809] chan_dahdi.c: Set option AUDIO MODE, value: OFF(0) on DAHDI/40-1 [Apr 7 17:58:21] VERBOSE[9809] logger.c: -- Hungup 'DAHDI/40-1' [Apr 7 17:58:21] VERBOSE[9752] logger.c: [Apr 7 17:58:21] VERBOSE[9752] logger.c: [Apr 7 17:58:21] VERBOSE[9752] logger.c: < SAPI: 00 C/R: 1 EA: 0 [Apr 7 17:58:21] VERBOSE[9752] logger.c: < Zero: 0 S: 0 01: 1 [ RR (receive ready) ] [Apr 7 17:58:21] VERBOSE[9752] logger.c: Handling message for SAPI/TEI=0/0 [Apr 7 17:58:21] VERBOSE[9752] logger.c: -- ACKing all packets from 58 to (but not including) 60 [Apr 7 17:58:21] VERBOSE[9752] logger.c: -- ACKing packet 59, new txqueue is -1 (-1 means empty) [Apr 7 17:58:21] VERBOSE[9752] logger.c: -- Since there was nothing left, stopping T200 counter [Apr 7 17:58:21] VERBOSE[9752] logger.c: -- Nothing left, starting T203 counter [Apr 7 17:58:21] VERBOSE[9752] logger.c: -- Restarting T203 timer [Apr 7 17:58:21] VERBOSE[9751] logger.c: [Apr 7 17:58:21] VERBOSE[9751] logger.c: [Apr 7 17:58:21] VERBOSE[9751] logger.c: < SAPI: 00 C/R: 0 EA: 0 [Apr 7 17:58:21] VERBOSE[9751] logger.c: < Zero: 0 S: 0 01: 1 [ RR (receive ready) ] [Apr 7 17:58:21] VERBOSE[9751] logger.c: Handling message for SAPI/TEI=0/0 [Apr 7 17:58:21] VERBOSE[9751] logger.c: -- ACKing all packets from 49 to (but not including) 51 [Apr 7 17:58:21] VERBOSE[9751] logger.c: -- ACKing packet 50, new txqueue is -1 (-1 means empty) [Apr 7 17:58:21] VERBOSE[9751] logger.c: -- Since there was nothing left, stopping T200 counter [Apr 7 17:58:21] VERBOSE[9751] logger.c: -- Nothing left, starting T203 counter [Apr 7 17:58:21] VERBOSE[9751] logger.c: -- Restarting T203 timer [Apr 7 17:58:22] VERBOSE[9751] logger.c: [Apr 7 17:58:22] VERBOSE[9751] logger.c: [Apr 7 17:58:22] VERBOSE[9751] logger.c: < SAPI: 00 C/R: 1 EA: 0 [Apr 7 17:58:22] VERBOSE[9751] logger.c: < N(S): 047 0: 0 [Apr 7 17:58:22] VERBOSE[9751] logger.c: Handling message for SAPI/TEI=0/0 [Apr 7 17:58:22] VERBOSE[9751] logger.c: -- ACKing all packets from 50 to (but not including) 51 [Apr 7 17:58:22] VERBOSE[9751] logger.c: -- Since there was nothing left, stopping T200 counter [Apr 7 17:58:22] VERBOSE[9751] logger.c: -- Stopping T203 counter since we got an ACK [Apr 7 17:58:22] VERBOSE[9751] logger.c: -- Nothing left, starting T203 counter [Apr 7 17:58:22] VERBOSE[9751] logger.c: < Protocol Discriminator: Q.931 (8) len=5 [Apr 7 17:58:22] VERBOSE[9751] logger.c: < Call Ref: len= 2 (reference 11/0xB) (Terminator) [Apr 7 17:58:22] VERBOSE[9751] logger.c: < Message type: RELEASE (77) [Apr 7 17:58:22] VERBOSE[9751] logger.c: q931.c:3801 q931_receive: call 32779 on channel 15 enters state 0 (Null) [Apr 7 17:58:22] VERBOSE[9751] logger.c: Sending Receiver Ready (48) [Apr 7 17:58:22] VERBOSE[9751] logger.c: [Apr 7 17:58:22] VERBOSE[9751] logger.c: [Apr 7 17:58:22] VERBOSE[9751] logger.c: > SAPI: 00 C/R: 1 EA: 0 [Apr 7 17:58:22] VERBOSE[9751] logger.c: > Zero: 0 S: 0 01: 1 [ RR (receive ready) ] [Apr 7 17:58:22] VERBOSE[9751] logger.c: -- Restarting T203 timer [Apr 7 17:58:22] VERBOSE[9751] logger.c: NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Null, peerstate Release Request [Apr 7 17:58:22] VERBOSE[9751] logger.c: -- Finally transmitting 51, since window opened up (0) [Apr 7 17:58:22] VERBOSE[9751] logger.c: [Apr 7 17:58:22] VERBOSE[9751] logger.c: [Apr 7 17:58:22] VERBOSE[9751] logger.c: > SAPI: 00 C/R: 0 EA: 0 [Apr 7 17:58:22] VERBOSE[9751] logger.c: > N(S): 051 0: 0 [Apr 7 17:58:22] VERBOSE[9751] logger.c: Stopping T_203 timer [Apr 7 17:58:22] VERBOSE[9751] logger.c: Starting T_200 timer [Apr 7 17:58:22] VERBOSE[9751] logger.c: -- Restarting T200 timer [Apr 7 17:58:22] VERBOSE[9751] logger.c: > Protocol Discriminator: Q.931 (8) len=9 [Apr 7 17:58:22] VERBOSE[9751] logger.c: > Call Ref: len= 2 (reference 11/0xB) (Originator) [Apr 7 17:58:22] VERBOSE[9751] logger.c: > Message type: RELEASE COMPLETE (90) [Apr 7 17:58:22] VERBOSE[9751] logger.c: > [08 02 81 90] [Apr 7 17:58:22] VERBOSE[9751] logger.c: > Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) Spare: 0 Location: Private network serving the local user (1) [Apr 7 17:58:22] VERBOSE[9751] logger.c: > Ext: 1 Cause: Normal Clearing (16), class = Normal Event (1) ] [Apr 7 17:58:22] VERBOSE[9751] logger.c: NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Null, peerstate Null [Apr 7 17:58:22] VERBOSE[9751] logger.c: NEW_HANGUP DEBUG: Destroying the call, ourstate Null, peerstate Null [Apr 7 17:58:22] VERBOSE[9751] logger.c: [Apr 7 17:58:22] VERBOSE[9751] logger.c: [Apr 7 17:58:22] VERBOSE[9751] logger.c: < SAPI: 00 C/R: 0 EA: 0 [Apr 7 17:58:22] VERBOSE[9751] logger.c: < Zero: 0 S: 0 01: 1 [ RR (receive ready) ] [Apr 7 17:58:22] VERBOSE[9751] logger.c: Handling message for SAPI/TEI=0/0 [Apr 7 17:58:22] VERBOSE[9751] logger.c: -- ACKing all packets from 50 to (but not including) 52 [Apr 7 17:58:22] VERBOSE[9751] logger.c: -- ACKing packet 51, new txqueue is -1 (-1 means empty) [Apr 7 17:58:22] VERBOSE[9751] logger.c: -- Since there was nothing left, stopping T200 counter [Apr 7 17:58:22] VERBOSE[9751] logger.c: -- Nothing left, starting T203 counter [Apr 7 17:58:22] VERBOSE[9751] logger.c: -- Restarting T203 timer [Apr 7 17:58:22] VERBOSE[9752] logger.c: [Apr 7 17:58:22] VERBOSE[9752] logger.c: [Apr 7 17:58:22] VERBOSE[9752] logger.c: < SAPI: 00 C/R: 0 EA: 0 [Apr 7 17:58:22] VERBOSE[9752] logger.c: < N(S): 006 0: 0 [Apr 7 17:58:22] VERBOSE[9752] logger.c: Handling message for SAPI/TEI=0/0 [Apr 7 17:58:22] VERBOSE[9752] logger.c: -- ACKing all packets from 59 to (but not including) 60 [Apr 7 17:58:22] VERBOSE[9752] logger.c: -- Since there was nothing left, stopping T200 counter [Apr 7 17:58:22] VERBOSE[9752] logger.c: -- Stopping T203 counter since we got an ACK [Apr 7 17:58:22] VERBOSE[9752] logger.c: -- Nothing left, starting T203 counter [Apr 7 17:58:22] VERBOSE[9752] logger.c: < Protocol Discriminator: Q.931 (8) len=5 [Apr 7 17:58:22] VERBOSE[9752] logger.c: < Call Ref: len= 2 (reference 26199/0x6657) (Originator) [Apr 7 17:58:22] VERBOSE[9752] logger.c: < Message type: RELEASE COMPLETE (90) [Apr 7 17:58:22] VERBOSE[9752] logger.c: q931.c:3766 q931_receive: call 26199 on channel 9 enters state 0 (Null) [Apr 7 17:58:22] VERBOSE[9752] logger.c: NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Null, peerstate Null [Apr 7 17:58:22] VERBOSE[9752] logger.c: NEW_HANGUP DEBUG: Destroying the call, ourstate Null, peerstate Null [Apr 7 17:58:22] VERBOSE[9752] logger.c: Sending Receiver Ready (7) [Apr 7 17:58:22] VERBOSE[9752] logger.c: [Apr 7 17:58:22] VERBOSE[9752] logger.c: [Apr 7 17:58:22] VERBOSE[9752] logger.c: > SAPI: 00 C/R: 0 EA: 0 [Apr 7 17:58:22] VERBOSE[9752] logger.c: > Zero: 0 S: 0 01: 1 [ RR (receive ready) ] [Apr 7 17:58:22] VERBOSE[9752] logger.c: -- Restarting T203 timer [Apr 7 17:58:32] VERBOSE[9751] logger.c: [Apr 7 17:58:32] VERBOSE[9751] logger.c: [Apr 7 17:58:32] VERBOSE[9751] logger.c: < SAPI: 00 C/R: 1 EA: 0 [Apr 7 17:58:32] VERBOSE[9751] logger.c: < Zero: 0 S: 0 01: 1 [ RR (receive ready) ] [Apr 7 17:58:32] VERBOSE[9751] logger.c: Handling message for SAPI/TEI=0/0 [Apr 7 17:58:32] VERBOSE[9751] logger.c: -- ACKing all packets from 51 to (but not including) 52 [Apr 7 17:58:32] VERBOSE[9751] logger.c: -- Since there was nothing left, stopping T200 counter [Apr 7 17:58:32] VERBOSE[9751] logger.c: -- Stopping T203 counter since we got an ACK [Apr 7 17:58:32] VERBOSE[9751] logger.c: -- Nothing left, starting T203 counter [Apr 7 17:58:32] VERBOSE[9751] logger.c: -- Unsolicited RR with P/F bit, responding [Apr 7 17:58:32] VERBOSE[9751] logger.c: Sending Receiver Ready (48) [Apr 7 17:58:32] VERBOSE[9751] logger.c: [Apr 7 17:58:32] VERBOSE[9751] logger.c: [Apr 7 17:58:32] VERBOSE[9751] logger.c: > SAPI: 00 C/R: 1 EA: 0 [Apr 7 17:58:32] VERBOSE[9751] logger.c: > Zero: 0 S: 0 01: 1 [ RR (receive ready) ] [Apr 7 17:58:32] VERBOSE[9751] logger.c: -- Restarting T203 timer [Apr 7 17:58:32] VERBOSE[9752] logger.c: T203 counter expired, sending RR and scheduling T203 again [Apr 7 17:58:32] VERBOSE[9752] logger.c: Sending Receiver Ready (7) [Apr 7 17:58:32] VERBOSE[9752] logger.c: [Apr 7 17:58:32] VERBOSE[9752] logger.c: [Apr 7 17:58:32] VERBOSE[9752] logger.c: > SAPI: 00 C/R: 1 EA: 0 [Apr 7 17:58:32] VERBOSE[9752] logger.c: > Zero: 0 S: 0 01: 1 [ RR (receive ready) ] [Apr 7 17:58:32] VERBOSE[9752] logger.c: [Apr 7 17:58:32] VERBOSE[9752] logger.c: [Apr 7 17:58:32] VERBOSE[9752] logger.c: < SAPI: 00 C/R: 1 EA: 0 [Apr 7 17:58:32] VERBOSE[9752] logger.c: < Zero: 0 S: 0 01: 1 [ RR (receive ready) ]