Aug 5 01:36:11 VERBOSE[27215] logger.c: < Protocol Discriminator: Q.931 (8) len=51 Aug 5 01:36:11 VERBOSE[27215] logger.c: < Call Ref: len= 2 (reference 3/0x3) (Originator) Aug 5 01:36:11 VERBOSE[27215] logger.c: < Message type: SETUP (5) Aug 5 01:36:11 VERBOSE[27215] logger.c: < [Aug 5 01:36:11 VERBOSE[27215] logger.c: < [04Aug 5 01:36:11 VERBOSE[27215] logger.c: < [04 03Aug 5 01:36:11 VERBOSE[27215] logger.c: < [04 03 80Aug 5 01:36:11 VERBOSE[27215] logger.c: < [04 03 80 90Aug 5 01:36:11 VERBOSE[27215] logger.c: < [04 03 80 90 a2Aug 5 01:36:11 VERBOSE[27215] logger.c: < [04 03 80 90 a2] Aug 5 01:36:11 VERBOSE[27215] logger.c: < Bearer Capability (len= 5) [ Ext: 1 Q.931 Std: 0 Info transfer capability: Speech (0) Aug 5 01:36:11 VERBOSE[27215] logger.c: < Ext: 1 Trans mode/rate: 64kbps, circuit-mode (16) Aug 5 01:36:11 VERBOSE[27215] logger.c: < Ext: 1 User information layer 1: u-Law (34) Aug 5 01:36:11 VERBOSE[27215] logger.c: < [Aug 5 01:36:11 VERBOSE[27215] logger.c: < [18Aug 5 01:36:11 VERBOSE[27215] logger.c: < [18 03Aug 5 01:36:11 VERBOSE[27215] logger.c: < [18 03 a1Aug 5 01:36:11 VERBOSE[27215] logger.c: < [18 03 a1 83Aug 5 01:36:11 VERBOSE[27215] logger.c: < [18 03 a1 83 97Aug 5 01:36:11 VERBOSE[27215] logger.c: < [18 03 a1 83 97] Aug 5 01:36:11 VERBOSE[27215] logger.c: < Channel ID (len= 5) [ Ext: 1 IntID: Implicit, PRI Spare: 0, Preferred Dchan: 0 Aug 5 01:36:11 VERBOSE[27215] logger.c: < ChanSel: Reserved Aug 5 01:36:11 VERBOSE[27215] logger.c: < Ext: 1 Coding: 0 Number Specified Channel Type: 3 Aug 5 01:36:11 VERBOSE[27215] logger.c: < Ext: 1 Channel: 23 ] Aug 5 01:36:11 VERBOSE[27215] logger.c: < [Aug 5 01:36:11 VERBOSE[27215] logger.c: < [28Aug 5 01:36:11 VERBOSE[27215] logger.c: < [28 0bAug 5 01:36:11 VERBOSE[27215] logger.c: < [28 0b b1Aug 5 01:36:11 VERBOSE[27215] logger.c: < [28 0b b1 57Aug 5 01:36:11 VERBOSE[27215] logger.c: < [28 0b b1 57 68Aug 5 01:36:11 VERBOSE[27215] logger.c: < [28 0b b1 57 68 61Aug 5 01:36:11 VERBOSE[27215] logger.c: < [28 0b b1 57 68 61 72Aug 5 01:36:11 VERBOSE[27215] logger.c: < [28 0b b1 57 68 61 72 66Aug 5 01:36:11 VERBOSE[27215] logger.c: < [28 0b b1 57 68 61 72 66 52Aug 5 01:36:11 VERBOSE[27215] logger.c: < [28 0b b1 57 68 61 72 66 52 64Aug 5 01:36:11 VERBOSE[27215] logger.c: < [28 0b b1 57 68 61 72 66 52 64 44Aug 5 01:36:11 VERBOSE[27215] logger.c: < [28 0b b1 57 68 61 72 66 52 64 44 41Aug 5 01:36:11 VERBOSE[27215] logger.c: < [28 0b b1 57 68 61 72 66 52 64 44 41 4eAug 5 01:36:11 VERBOSE[27215] logger.c: < [28 0b b1 57 68 61 72 66 52 64 44 41 4e] Aug 5 01:36:11 VERBOSE[27215] logger.c: < Display (len=11) Charset: 31 [ WharfRdDAN ] Aug 5 01:36:11 VERBOSE[27215] logger.c: < [Aug 5 01:36:11 VERBOSE[27215] logger.c: < [6cAug 5 01:36:11 VERBOSE[27215] logger.c: < [6c 06Aug 5 01:36:11 VERBOSE[27215] logger.c: < [6c 06 00Aug 5 01:36:11 VERBOSE[27215] logger.c: < [6c 06 00 80Aug 5 01:36:11 VERBOSE[27215] logger.c: < [6c 06 00 80 36Aug 5 01:36:11 VERBOSE[27215] logger.c: < [6c 06 00 80 36 31Aug 5 01:36:11 VERBOSE[27215] logger.c: < [6c 06 00 80 36 31 30Aug 5 01:36:11 VERBOSE[27215] logger.c: < [6c 06 00 80 36 31 30 31Aug 5 01:36:11 VERBOSE[27215] logger.c: < [6c 06 00 80 36 31 30 31] Aug 5 01:36:11 VERBOSE[27215] logger.c: < Calling Number (len= 8) [ Ext: 0 TON: Unknown Number Type (0) NPI: Unknown Number Plan (0) Aug 5 01:36:11 VERBOSE[27215] logger.c: < Presentation: Presentation permitted, user number not screened (0) '6101' ] Aug 5 01:36:11 VERBOSE[27215] logger.c: < [Aug 5 01:36:11 VERBOSE[27215] logger.c: < [70Aug 5 01:36:11 VERBOSE[27215] logger.c: < [70 0dAug 5 01:36:11 VERBOSE[27215] logger.c: < [70 0d 80Aug 5 01:36:11 VERBOSE[27215] logger.c: < [70 0d 80 39Aug 5 01:36:11 VERBOSE[27215] logger.c: < [70 0d 80 39 31Aug 5 01:36:11 VERBOSE[27215] logger.c: < [70 0d 80 39 31 36Aug 5 01:36:11 VERBOSE[27215] logger.c: < [70 0d 80 39 31 36 30Aug 5 01:36:11 VERBOSE[27215] logger.c: < [70 0d 80 39 31 36 30 34Aug 5 01:36:11 VERBOSE[27215] logger.c: < [70 0d 80 39 31 36 30 34 35Aug 5 01:36:11 VERBOSE[27215] logger.c: < [70 0d 80 39 31 36 30 34 35 38Aug 5 01:36:11 VERBOSE[27215] logger.c: < [70 0d 80 39 31 36 30 34 35 38 32Aug 5 01:36:11 VERBOSE[27215] logger.c: < [70 0d 80 39 31 36 30 34 35 38 32 35Aug 5 01:36:11 VERBOSE[27215] logger.c: < [70 0d 80 39 31 36 30 34 35 38 32 35 33Aug 5 01:36:11 VERBOSE[27215] logger.c: < [70 0d 80 39 31 36 30 34 35 38 32 35 33 33Aug 5 01:36:11 VERBOSE[27215] logger.c: < [70 0d 80 39 31 36 30 34 35 38 32 35 33 33 32Aug 5 01:36:11 VERBOSE[27215] logger.c: < [70 0d 80 39 31 36 30 34 35 38 32 35 33 33 32] Aug 5 01:36:11 VERBOSE[27215] logger.c: < Called Number (len=15) [ Ext: 1 TON: Unknown Number Type (0) NPI: Unknown Number Plan (0) '916045825332' ] Aug 5 01:36:11 VERBOSE[27215] logger.c: -- Making new call for cr 3 Aug 5 01:36:11 VERBOSE[27215] logger.c: -- Processing Q.931 Call Setup Aug 5 01:36:11 VERBOSE[27215] logger.c: -- Processing IE 4 (cs0, Bearer Capability) Aug 5 01:36:11 VERBOSE[27215] logger.c: -- Processing IE 24 (cs0, Channel Identification) Aug 5 01:36:11 VERBOSE[27215] logger.c: -- Processing IE 40 (cs0, Display) Aug 5 01:36:11 VERBOSE[27215] logger.c: -- Processing IE 108 (cs0, Calling Party Number) Aug 5 01:36:11 VERBOSE[27215] logger.c: -- Processing IE 112 (cs0, Called Party Number) Aug 5 01:36:11 VERBOSE[27215] logger.c: > Protocol Discriminator: Q.931 (8) len=10 Aug 5 01:36:11 VERBOSE[27215] logger.c: > Call Ref: len= 2 (reference 3/0x3) (Terminator) Aug 5 01:36:11 VERBOSE[27215] logger.c: > Message type: CALL PROCEEDING (2) Aug 5 01:36:11 VERBOSE[27215] logger.c: > [Aug 5 01:36:11 VERBOSE[27215] logger.c: > [18Aug 5 01:36:11 VERBOSE[27215] logger.c: > [18 03Aug 5 01:36:11 VERBOSE[27215] logger.c: > [18 03 a9Aug 5 01:36:11 VERBOSE[27215] logger.c: > [18 03 a9 83Aug 5 01:36:11 VERBOSE[27215] logger.c: > [18 03 a9 83 97Aug 5 01:36:11 VERBOSE[27215] logger.c: > [18 03 a9 83 97] Aug 5 01:36:11 VERBOSE[27215] logger.c: > Channel ID (len= 5) [ Ext: 1 IntID: Implicit, PRI Spare: 0, Exclusive Dchan: 0 Aug 5 01:36:11 VERBOSE[27215] logger.c: > ChanSel: Reserved Aug 5 01:36:11 VERBOSE[27215] logger.c: > Ext: 1 Coding: 0 Number Specified Channel Type: 3 Aug 5 01:36:11 VERBOSE[27215] logger.c: > Ext: 1 Channel: 23 ] Aug 5 01:36:11 VERBOSE[27215] logger.c: -- Accepting call from '6101' to '916045825332' on channel 0/23, span 1 Aug 5 01:36:11 DEBUG[27215] chan_zap.c: No echo cancellation requested Aug 5 01:36:11 VERBOSE[27261] logger.c: -- Executing Goto("Zap/23-1", "dialplan-routing|916045825332|1") in new stack Aug 5 01:36:11 VERBOSE[27261] logger.c: -- Goto (dialplan-routing,916045825332,1) Aug 5 01:36:11 VERBOSE[27261] logger.c: -- Executing NoOp("Zap/23-1", "Answer()") in new stack Aug 5 01:36:11 VERBOSE[27261] logger.c: -- Executing Dial("Zap/23-1", "IAX2/astpbx-pstn/916045825332@out-pstn") in new stack Aug 5 01:36:11 VERBOSE[27214] logger.c: Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: NEW Aug 5 01:36:11 VERBOSE[27214] logger.c: Timestamp: 00008ms SCall: 00001 DCall: 00000 [10.255.40.1:4569] Aug 5 01:36:11 VERBOSE[27214] logger.c: VERSION : 2 Aug 5 01:36:11 VERBOSE[27214] logger.c: CALLED NUMBER : 916045825332 Aug 5 01:36:11 VERBOSE[27214] logger.c: CODEC_PREFS : (ulaw) Aug 5 01:36:11 VERBOSE[27214] logger.c: CALLING NUMBER : 6101 Aug 5 01:36:11 VERBOSE[27214] logger.c: CALLING PRESNTN : 0 Aug 5 01:36:11 VERBOSE[27214] logger.c: CALLING TYPEOFN : 0 Aug 5 01:36:11 VERBOSE[27214] logger.c: CALLING TRANSIT : 0 Aug 5 01:36:11 VERBOSE[27214] logger.c: CALLING NAME : WharfRdDAN Aug 5 01:36:11 VERBOSE[27214] logger.c: LANGUAGE : en Aug 5 01:36:11 VERBOSE[27214] logger.c: CALLED CONTEXT : out-pstn Aug 5 01:36:11 VERBOSE[27214] logger.c: FORMAT : 4 Aug 5 01:36:11 VERBOSE[27214] logger.c: CAPABILITY : 63492 Aug 5 01:36:11 VERBOSE[27214] logger.c: ADSICPE : 2 Aug 5 01:36:11 VERBOSE[27214] logger.c: DATE TIME : 2005-08-05 01:36:10 Aug 5 01:36:11 VERBOSE[27214] logger.c: Aug 5 01:36:11 VERBOSE[27261] logger.c: -- Called astpbx-pstn/916045825332@out-pstn Aug 5 01:36:11 VERBOSE[27214] logger.c: Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 001 Type: IAX Subclass: AUTHREQ Aug 5 01:36:11 VERBOSE[27214] logger.c: Timestamp: 00004ms SCall: 00001 DCall: 00001 [10.255.40.1:4569] Aug 5 01:36:11 VERBOSE[27214] logger.c: AUTHMETHODS : 3 Aug 5 01:36:11 VERBOSE[27214] logger.c: CHALLENGE : 832486114 Aug 5 01:36:11 VERBOSE[27214] logger.c: USERNAME : astpbx-woodbay-incoming Aug 5 01:36:11 VERBOSE[27214] logger.c: Aug 5 01:36:11 VERBOSE[27214] logger.c: Tx-Frame Retry[000] -- OSeqno: 001 ISeqno: 001 Type: IAX Subclass: AUTHREP Aug 5 01:36:11 VERBOSE[27214] logger.c: Timestamp: 00032ms SCall: 00001 DCall: 00001 [10.255.40.1:4569] Aug 5 01:36:11 VERBOSE[27214] logger.c: MD5 RESULT : 338914ab6ac1f674f8d7eea38dbc6bbf Aug 5 01:36:11 VERBOSE[27214] logger.c: Aug 5 01:36:11 VERBOSE[27214] logger.c: Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 002 Type: IAX Subclass: ACCEPT Aug 5 01:36:11 VERBOSE[27214] logger.c: Timestamp: 00014ms SCall: 00001 DCall: 00001 [10.255.40.1:4569] Aug 5 01:36:11 VERBOSE[27214] logger.c: FORMAT : 4 Aug 5 01:36:11 VERBOSE[27214] logger.c: Aug 5 01:36:11 VERBOSE[27214] logger.c: -- Call accepted by 10.255.40.1 (format ulaw) Aug 5 01:36:11 VERBOSE[27214] logger.c: -- Format for call is ulaw Aug 5 01:36:11 VERBOSE[27214] logger.c: Tx-Frame Retry[-01] -- OSeqno: 002 ISeqno: 002 Type: IAX Subclass: ACK Aug 5 01:36:11 VERBOSE[27214] logger.c: Timestamp: 00014ms SCall: 00001 DCall: 00001 [10.255.40.1:4569] Aug 5 01:36:11 VERBOSE[27214] logger.c: Tx-Frame Retry[000] -- OSeqno: 002 ISeqno: 002 Type: VOICE Subclass: 4 Aug 5 01:36:11 VERBOSE[27214] logger.c: Timestamp: 00060ms SCall: 00001 DCall: 00001 [10.255.40.1:4569] Aug 5 01:36:11 VERBOSE[27214] logger.c: Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 003 Type: IAX Subclass: ACK Aug 5 01:36:11 VERBOSE[27214] logger.c: Timestamp: 00060ms SCall: 00001 DCall: 00001 [10.255.40.1:4569] Aug 5 01:36:12 VERBOSE[27214] logger.c: Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 003 Type: VOICE Subclass: 4 Aug 5 01:36:12 VERBOSE[27214] logger.c: Timestamp: 01120ms SCall: 00001 DCall: 00001 [10.255.40.1:4569] Aug 5 01:36:12 DEBUG[27214] chan_iax2.c: Ooh, voice format changed to 4 Aug 5 01:36:12 VERBOSE[27214] logger.c: Tx-Frame Retry[-01] -- OSeqno: 003 ISeqno: 003 Type: IAX Subclass: ACK Aug 5 01:36:12 VERBOSE[27214] logger.c: Timestamp: 01120ms SCall: 00001 DCall: 00001 [10.255.40.1:4569] Aug 5 01:36:12 VERBOSE[27214] logger.c: Rx-Frame Retry[ No] -- OSeqno: 003 ISeqno: 003 Type: CONTROL Subclass: (15?) Aug 5 01:36:12 VERBOSE[27214] logger.c: Timestamp: 01263ms SCall: 00001 DCall: 00001 [10.255.40.1:4569] Aug 5 01:36:12 VERBOSE[27214] logger.c: Tx-Frame Retry[-01] -- OSeqno: 003 ISeqno: 004 Type: IAX Subclass: ACK Aug 5 01:36:12 VERBOSE[27214] logger.c: Timestamp: 01263ms SCall: 00001 DCall: 00001 [10.255.40.1:4569] Aug 5 01:36:13 VERBOSE[27261] logger.c: -- IAX2/astpbx-pstn-1 is proceeding passing it to Zap/23-1 Aug 5 01:36:13 DEBUG[27261] chan_zap.c: Requested indication 15 on channel Zap/23-1 Aug 5 01:36:13 DEBUG[27261] chan_zap.c: Received AST_CONTROL_PROCEEDING on Zap/23-1 Aug 5 01:36:13 VERBOSE[27261] logger.c: > Protocol Discriminator: Q.931 (8) len=14 Aug 5 01:36:13 VERBOSE[27261] logger.c: > Call Ref: len= 2 (reference 3/0x3) (Terminator) Aug 5 01:36:13 VERBOSE[27261] logger.c: > Message type: CALL PROCEEDING (2) Aug 5 01:36:13 VERBOSE[27261] logger.c: > [Aug 5 01:36:13 VERBOSE[27261] logger.c: > [18Aug 5 01:36:13 VERBOSE[27261] logger.c: > [18 03Aug 5 01:36:13 VERBOSE[27261] logger.c: > [18 03 a9Aug 5 01:36:13 VERBOSE[27261] logger.c: > [18 03 a9 83Aug 5 01:36:13 VERBOSE[27261] logger.c: > [18 03 a9 83 97Aug 5 01:36:13 VERBOSE[27261] logger.c: > [18 03 a9 83 97] Aug 5 01:36:13 VERBOSE[27261] logger.c: > Channel ID (len= 5) [ Ext: 1 IntID: Implicit, PRI Spare: 0, Exclusive Dchan: 0 Aug 5 01:36:13 VERBOSE[27261] logger.c: > ChanSel: Reserved Aug 5 01:36:13 VERBOSE[27261] logger.c: > Ext: 1 Coding: 0 Number Specified Channel Type: 3 Aug 5 01:36:13 VERBOSE[27261] logger.c: > Ext: 1 Channel: 23 ] Aug 5 01:36:13 VERBOSE[27261] logger.c: > [Aug 5 01:36:13 VERBOSE[27261] logger.c: > [1eAug 5 01:36:13 VERBOSE[27261] logger.c: > [1e 02Aug 5 01:36:13 VERBOSE[27261] logger.c: > [1e 02 81Aug 5 01:36:13 VERBOSE[27261] logger.c: > [1e 02 81 88Aug 5 01:36:13 VERBOSE[27261] logger.c: > [1e 02 81 88] Aug 5 01:36:13 VERBOSE[27261] logger.c: > Progress Indicator (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) 0: 0 Location: Private network serving the local user (1) Aug 5 01:36:13 VERBOSE[27261] logger.c: > Ext: 1 Progress Description: Inband information or appropriate pattern now available. (8) ] Aug 5 01:36:13 VERBOSE[27215] logger.c: < Protocol Discriminator: Q.931 (8) len=12 Aug 5 01:36:13 VERBOSE[27215] logger.c: < Call Ref: len= 2 (reference 3/0x3) (Originator) Aug 5 01:36:13 VERBOSE[27215] logger.c: < Message type: STATUS (125) Aug 5 01:36:13 VERBOSE[27215] logger.c: < [Aug 5 01:36:13 VERBOSE[27215] logger.c: < [08Aug 5 01:36:13 VERBOSE[27215] logger.c: < [08 02Aug 5 01:36:13 VERBOSE[27215] logger.c: < [08 02 82Aug 5 01:36:13 VERBOSE[27215] logger.c: < [08 02 82 e5Aug 5 01:36:13 VERBOSE[27215] logger.c: < [08 02 82 e5] Aug 5 01:36:13 VERBOSE[27215] logger.c: < Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) 0: 0 Location: Public network serving the local user (2) Aug 5 01:36:13 VERBOSE[27215] logger.c: < Ext: 1 Cause: Unknown (101), class = Protocol Error (6) ] Aug 5 01:36:13 VERBOSE[27215] logger.c: < [Aug 5 01:36:13 VERBOSE[27215] logger.c: < [14Aug 5 01:36:13 VERBOSE[27215] logger.c: < [14 01Aug 5 01:36:13 VERBOSE[27215] logger.c: < [14 01 03Aug 5 01:36:13 VERBOSE[27215] logger.c: < [14 01 03] Aug 5 01:36:13 VERBOSE[27215] logger.c: < Call State (len= 3) [ Ext: 0 Coding: CCITT (ITU) standard (0) Call state: Outgoing call Proceeding (3) Aug 5 01:36:13 VERBOSE[27215] logger.c: -- Processing IE 8 (cs0, Cause) Aug 5 01:36:13 VERBOSE[27215] logger.c: -- Processing IE 20 (cs0, Call State) Aug 5 01:36:14 VERBOSE[27214] logger.c: Rx-Frame Retry[ No] -- OSeqno: 004 ISeqno: 003 Type: CONTROL Subclass: (14?) Aug 5 01:36:14 VERBOSE[27214] logger.c: Timestamp: 02523ms SCall: 00001 DCall: 00001 [10.255.40.1:4569] Aug 5 01:36:14 VERBOSE[27214] logger.c: Tx-Frame Retry[-01] -- OSeqno: 003 ISeqno: 005 Type: IAX Subclass: ACK Aug 5 01:36:14 VERBOSE[27214] logger.c: Timestamp: 02523ms SCall: 00001 DCall: 00001 [10.255.40.1:4569] Aug 5 01:36:14 VERBOSE[27261] logger.c: -- IAX2/astpbx-pstn-1 is making progress passing it to Zap/23-1 Aug 5 01:36:14 DEBUG[27261] chan_zap.c: Requested indication 14 on channel Zap/23-1 Aug 5 01:36:14 DEBUG[27261] chan_zap.c: Received AST_CONTROL_PROGRESS on Zap/23-1 Aug 5 01:36:21 VERBOSE[27214] logger.c: Tx-Frame Retry[000] -- OSeqno: 003 ISeqno: 005 Type: IAX Subclass: LAGRQ Aug 5 01:36:21 VERBOSE[27214] logger.c: Timestamp: 10009ms SCall: 00001 DCall: 00001 [10.255.40.1:4569] Aug 5 01:36:21 VERBOSE[27214] logger.c: Rx-Frame Retry[ No] -- OSeqno: 005 ISeqno: 004 Type: IAX Subclass: LAGRP Aug 5 01:36:21 VERBOSE[27214] logger.c: Timestamp: 10009ms SCall: 00001 DCall: 00001 [10.255.40.1:4569] Aug 5 01:36:21 VERBOSE[27214] logger.c: Tx-Frame Retry[-01] -- OSeqno: 004 ISeqno: 006 Type: IAX Subclass: ACK Aug 5 01:36:21 VERBOSE[27214] logger.c: Timestamp: 10009ms SCall: 00001 DCall: 00001 [10.255.40.1:4569] Aug 5 01:36:21 VERBOSE[27214] logger.c: Rx-Frame Retry[ No] -- OSeqno: 006 ISeqno: 004 Type: IAX Subclass: LAGRQ Aug 5 01:36:21 VERBOSE[27214] logger.c: Timestamp: 10021ms SCall: 00001 DCall: 00001 [10.255.40.1:4569] Aug 5 01:36:21 VERBOSE[27214] logger.c: Tx-Frame Retry[000] -- OSeqno: 004 ISeqno: 007 Type: IAX Subclass: LAGRP Aug 5 01:36:21 VERBOSE[27214] logger.c: Timestamp: 10021ms SCall: 00001 DCall: 00001 [10.255.40.1:4569] Aug 5 01:36:21 VERBOSE[27214] logger.c: Rx-Frame Retry[ No] -- OSeqno: 007 ISeqno: 005 Type: IAX Subclass: ACK Aug 5 01:36:21 VERBOSE[27214] logger.c: Timestamp: 10021ms SCall: 00001 DCall: 00001 [10.255.40.1:4569] Aug 5 01:36:21 VERBOSE[27215] logger.c: < Protocol Discriminator: Q.931 (8) len=9 Aug 5 01:36:21 VERBOSE[27215] logger.c: < Call Ref: len= 2 (reference 3/0x3) (Originator) Aug 5 01:36:21 VERBOSE[27215] logger.c: < Message type: DISCONNECT (69) Aug 5 01:36:21 VERBOSE[27215] logger.c: < [Aug 5 01:36:21 VERBOSE[27215] logger.c: < [08Aug 5 01:36:21 VERBOSE[27215] logger.c: < [08 02Aug 5 01:36:21 VERBOSE[27215] logger.c: < [08 02 82Aug 5 01:36:21 VERBOSE[27215] logger.c: < [08 02 82 e6Aug 5 01:36:21 VERBOSE[27215] logger.c: < [08 02 82 e6] Aug 5 01:36:21 VERBOSE[27215] logger.c: < Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) 0: 0 Location: Public network serving the local user (2) Aug 5 01:36:21 VERBOSE[27215] logger.c: < Ext: 1 Cause: Unknown (102), class = Protocol Error (6) ] Aug 5 01:36:21 VERBOSE[27215] logger.c: -- Processing IE 8 (cs0, Cause) Aug 5 01:36:21 VERBOSE[27215] logger.c: -- Channel 0/23, span 1 got hangup request Aug 5 01:36:21 DEBUG[27261] chan_iax2.c: We're hanging up IAX2/astpbx-pstn-1 now... Aug 5 01:36:21 VERBOSE[27261] logger.c: -- Hungup 'IAX2/astpbx-pstn-1' Aug 5 01:36:21 DEBUG[27261] app_dial.c: Exiting with DIALSTATUS=CANCEL. Aug 5 01:36:21 VERBOSE[27261] logger.c: == Spawn extension (dialplan-routing, 916045825332, 2) exited non-zero on 'Zap/23-1' Aug 5 01:36:21 DEBUG[27261] chan_zap.c: Set option AUDIO MODE, value: ON(1) on Zap/23-1 Aug 5 01:36:21 DEBUG[27261] chan_zap.c: Hangup: channel: 23 index = 0, normal = 42, callwait = -1, thirdcall = -1 Aug 5 01:36:21 DEBUG[27261] chan_zap.c: Not yet hungup... Calling hangup once with icause, and clearing call Aug 5 01:36:21 VERBOSE[27261] logger.c: NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Disconnect Indication, peerstate Disconnect Request Aug 5 01:36:21 VERBOSE[27261] logger.c: > Protocol Discriminator: Q.931 (8) len=9 Aug 5 01:36:21 VERBOSE[27261] logger.c: > Call Ref: len= 2 (reference 3/0x3) (Terminator) Aug 5 01:36:21 VERBOSE[27261] logger.c: > Message type: RELEASE (77) Aug 5 01:36:21 VERBOSE[27261] logger.c: > [Aug 5 01:36:21 VERBOSE[27261] logger.c: > [08Aug 5 01:36:21 VERBOSE[27261] logger.c: > [08 02Aug 5 01:36:21 VERBOSE[27261] logger.c: > [08 02 81Aug 5 01:36:21 VERBOSE[27261] logger.c: > [08 02 81 e6Aug 5 01:36:21 VERBOSE[27261] logger.c: > [08 02 81 e6] Aug 5 01:36:21 VERBOSE[27261] logger.c: > Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) 0: 0 Location: Private network serving the local user (1) Aug 5 01:36:21 VERBOSE[27261] logger.c: > Ext: 1 Cause: Unknown (102), class = Protocol Error (6) ] Aug 5 01:36:21 DEBUG[27261] chan_zap.c: Set option TDD MODE, value: OFF(0) on Zap/23-1 Aug 5 01:36:21 DEBUG[27261] chan_zap.c: Updated conferencing on 23, with 0 conference users Aug 5 01:36:21 DEBUG[27261] chan_zap.c: Set option AUDIO MODE, value: OFF(0) on Zap/23-1 Aug 5 01:36:21 VERBOSE[27261] logger.c: -- Hungup 'Zap/23-1' Aug 5 01:36:21 VERBOSE[27214] logger.c: Tx-Frame Retry[000] -- OSeqno: 005 ISeqno: 007 Type: IAX Subclass: HANGUP Aug 5 01:36:21 VERBOSE[27214] logger.c: Timestamp: 10040ms SCall: 00001 DCall: 00001 [10.255.40.1:4569] Aug 5 01:36:21 VERBOSE[27214] logger.c: CAUSE CODE : 0 Aug 5 01:36:21 VERBOSE[27214] logger.c: Aug 5 01:36:21 VERBOSE[27214] logger.c: Rx-Frame Retry[ No] -- OSeqno: 007 ISeqno: 006 Type: IAX Subclass: ACK Aug 5 01:36:21 VERBOSE[27214] logger.c: Timestamp: 10040ms SCall: 00001 DCall: 00001 [10.255.40.1:4569] Aug 5 01:36:21 VERBOSE[27215] logger.c: < Protocol Discriminator: Q.931 (8) len=5 Aug 5 01:36:21 VERBOSE[27215] logger.c: < Call Ref: len= 2 (reference 3/0x3) (Originator) Aug 5 01:36:21 VERBOSE[27215] logger.c: < Message type: RELEASE COMPLETE (90) Aug 5 01:36:21 VERBOSE[27215] logger.c: NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Null, peerstate Null Aug 5 01:36:21 VERBOSE[27215] logger.c: NEW_HANGUP DEBUG: Destroying the call, ourstate Null, peerstate Null Aug 5 01:37:10 VERBOSE[27238] logger.c: -- Remote UNIX connection disconnected