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