CASE 1: Operator sent Disconnect request, but Asterisk continues with the call CLI: 3432136593 Call Ref: 34 Channel: Zap/106-1 [Jan 8 13:59:47] VERBOSE[4565] logger.c: -- ACKing all packets from 15 to (but not including) 16 [Jan 8 13:59:47] VERBOSE[4565] logger.c: -- Since there was nothing left, stopping T200 counter [Jan 8 13:59:47] VERBOSE[4565] logger.c: -- Stopping T203 counter since we got an ACK [Jan 8 13:59:47] VERBOSE[4565] logger.c: -- Nothing left, starting T203 counter [Jan 8 13:59:47] VERBOSE[4565] logger.c: < Protocol Discriminator: Q.931 (8) len=47 [Jan 8 13:59:47] VERBOSE[4565] logger.c: < Call Ref: len= 2 (reference 34/0x22) (Originator) [Jan 8 13:59:47] VERBOSE[4565] logger.c: < Message type: SETUP (5) [Jan 8 13:59:47] VERBOSE[4565] logger.c: < [a1] [Jan 8 13:59:47] VERBOSE[4565] logger.c: < Sending Complete (len= 1) [Jan 8 13:59:47] VERBOSE[4565] logger.c: < [04 03 80 90 a3] [Jan 8 13:59:47] VERBOSE[4565] logger.c: < Bearer Capability (len= 5) [ Ext: 1 Q.931 Std: 0 Info transfer capability: Speech (0) [Jan 8 13:59:47] VERBOSE[4565] logger.c: < Ext: 1 Trans mode/rate: 64kbps, circuit-mode (16) [Jan 8 13:59:47] VERBOSE[4565] logger.c: < Ext: 1 User information layer 1: A-Law (35) [Jan 8 13:59:47] VERBOSE[4565] logger.c: < [18 03 a9 83 8d] [Jan 8 13:59:47] VERBOSE[4565] logger.c: < Channel ID (len= 5) [ Ext: 1 IntID: Implicit PRI Spare: 0 Exclusive Dchan: 0 [Jan 8 13:59:47] VERBOSE[4565] logger.c: < ChanSel: Reserved [Jan 8 13:59:47] VERBOSE[4565] logger.c: < Ext: 1 Coding: 0 Number Specified Channel Type: 3 [Jan 8 13:59:47] VERBOSE[4565] logger.c: < Ext: 1 Channel: 13 ] [Jan 8 13:59:47] VERBOSE[4565] logger.c: < [6c 0c 21 83 33 34 33 32 31 33 36 35 39 33] [Jan 8 13:59:47] VERBOSE[4565] logger.c: < Calling Number (len=14) [ Ext: 0 TON: National Number (2) NPI: ISDN/Telephony Numbering Plan (E.164/E.163) (1) [Jan 8 13:59:47] VERBOSE[4565] logger.c: < Presentation: Presentation allowed of network provided number (3) '3432136593' ] [Jan 8 13:59:47] VERBOSE[4565] logger.c: < [70 0b 81 34 35 35 34 39 30 30 34 34 34] [Jan 8 13:59:47] VERBOSE[4565] logger.c: < Called Number (len=13) [ Ext: 1 TON: Unknown Number Type (0) NPI: ISDN/Telephony Numbering Plan (E.164/E.163) (1) '4554900444' ] [Jan 8 13:59:47] VERBOSE[4565] logger.c: < [7d 02 91 81] [Jan 8 13:59:47] VERBOSE[4565] logger.c: < IE: High-layer Compatibility (len = 4) [Jan 8 13:59:47] VERBOSE[4565] logger.c: -- Making new call for cr 34 [Jan 8 13:59:47] VERBOSE[4565] logger.c: -- Processing Q.931 Call Setup [Jan 8 13:59:47] VERBOSE[4565] logger.c: -- Processing IE 161 (cs0, Sending Complete) [Jan 8 13:59:47] VERBOSE[4565] logger.c: -- Processing IE 4 (cs0, Bearer Capability) [Jan 8 13:59:47] VERBOSE[4565] logger.c: -- Processing IE 24 (cs0, Channel Identification) [Jan 8 13:59:47] VERBOSE[4565] logger.c: -- Processing IE 108 (cs0, Calling Party Number) [Jan 8 13:59:47] VERBOSE[4565] logger.c: -- Processing IE 112 (cs0, Called Party Number) [Jan 8 13:59:47] VERBOSE[4565] logger.c: -- Processing IE 125 (cs0, High-layer Compatibility) [Jan 8 13:59:47] VERBOSE[4565] logger.c: q931.c:3298 q931_receive: call 34 on channel 13 enters state 6 (Call Present) [Jan 8 13:59:47] VERBOSE[4565] logger.c: Sending Receiver Ready (6) [Jan 8 13:59:47] VERBOSE[4565] logger.c: -- Restarting T203 counter [Jan 8 13:59:47] VERBOSE[4565] logger.c: -- Restarting T203 counter [Jan 8 13:59:47] VERBOSE[4565] logger.c: q931.c:2571 q931_call_proceeding: call 34 on channel 13 enters state 9 (Incoming Call Proceeding) [Jan 8 13:59:47] VERBOSE[4565] logger.c: [Jan 8 13:59:47] VERBOSE[4565] logger.c: -- Restarting T203 counter [Jan 8 13:59:47] VERBOSE[4565] logger.c: Stopping T_203 timer [Jan 8 13:59:47] VERBOSE[4565] logger.c: Starting T_200 timer [Jan 8 13:59:47] VERBOSE[4565] logger.c: > Protocol Discriminator: Q.931 (8) len=10 [Jan 8 13:59:47] VERBOSE[4565] logger.c: > Call Ref: len= 2 (reference 34/0x22) (Terminator) [Jan 8 13:59:47] VERBOSE[4565] logger.c: > Message type: CALL PROCEEDING (2) [Jan 8 13:59:47] VERBOSE[4565] logger.c: > [18 03 a9 83 8d] [Jan 8 13:59:47] VERBOSE[4565] logger.c: > Channel ID (len= 5) [ Ext: 1 IntID: Implicit PRI Spare: 0 Exclusive Dchan: 0 [Jan 8 13:59:47] VERBOSE[4565] logger.c: > ChanSel: Reserved [Jan 8 13:59:47] VERBOSE[4565] logger.c: > Ext: 1 Coding: 0 Number Specified Channel Type: 3 [Jan 8 13:59:47] VERBOSE[4565] logger.c: > Ext: 1 Channel: 13 ] [Jan 8 13:59:47] VERBOSE[4565] logger.c: -- Accepting call from '3432136593' to '4554900444' on channel 0/13, span 5 [Jan 8 13:59:47] VERBOSE[25905] logger.c: -- Executing [4554900444@default:1] Set("Zap/106-1", "__DEST=444") in new stack [Jan 8 13:59:47] VERBOSE[25905] logger.c: -- Executing [4554900444@default:2] SetCDRUserField("Zap/106-1", "444") in new stack [Jan 8 13:59:47] VERBOSE[25905] logger.c: -- Executing [4554900444@default:3] Goto("Zap/106-1", "MUSIC_STATION1|s|1") in new stack [Jan 8 13:59:47] VERBOSE[25905] logger.c: -- Goto (MUSIC_STATION1,s,1) [Jan 8 13:59:47] VERBOSE[25905] logger.c: -- Executing [s@MUSIC_STATION1:1] Answer("Zap/106-1", "") in new stack [Jan 8 13:59:47] VERBOSE[25905] logger.c: q931.c:2700 q931_connect: call 34 on channel 13 enters state 8 (Connect Request) [Jan 8 13:59:47] VERBOSE[25905] logger.c: [Jan 8 13:59:47] VERBOSE[25905] logger.c: T_200 timer already going (1) [Jan 8 13:59:47] VERBOSE[25905] logger.c: > Protocol Discriminator: Q.931 (8) len=14 [Jan 8 13:59:47] VERBOSE[25905] logger.c: > Call Ref: len= 2 (reference 34/0x22) (Terminator) [Jan 8 13:59:47] VERBOSE[25905] logger.c: > Message type: CONNECT (7) [Jan 8 13:59:47] VERBOSE[25905] logger.c: > [18 03 a9 83 8d] [Jan 8 13:59:47] VERBOSE[25905] logger.c: > Channel ID (len= 5) [ Ext: 1 IntID: Implicit PRI Spare: 0 Exclusive Dchan: 0 [Jan 8 13:59:47] VERBOSE[25905] logger.c: > ChanSel: Reserved [Jan 8 13:59:47] VERBOSE[25905] logger.c: > Ext: 1 Coding: 0 Number Specified Channel Type: 3 [Jan 8 13:59:47] VERBOSE[25905] logger.c: > Ext: 1 Channel: 13 ] [Jan 8 13:59:47] VERBOSE[25905] logger.c: > [1e 02 81 82] [Jan 8 13:59:47] VERBOSE[25905] logger.c: > Progress Indicator (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) 0: 0 Location: Private network serving the local user (1) [Jan 8 13:59:47] VERBOSE[25905] logger.c: > Ext: 1 Progress Description: Called equipment is non-ISDN. (2) ] [Jan 8 13:59:47] VERBOSE[25905] logger.c: -- Executing [s@MUSIC_STATION1:2] Set("Zap/106-1", "__DB_USER_ID=1199782787") in new stack [Jan 8 13:59:47] VERBOSE[25905] logger.c: -- Executing [s@MUSIC_STATION1:3] Set("Zap/106-1", "__DB_CLI=3432136593") in new stack [Jan 8 13:59:47] VERBOSE[25905] logger.c: -- Executing [s@MUSIC_STATION1:4] Playback("Zap/106-1", "/efclub/prompts/music/music_welcome") in new stack [Jan 8 13:59:47] VERBOSE[25905] logger.c: -- Playing '/efclub/prompts/music/music_welcome' (language 'en') [Jan 8 13:59:47] VERBOSE[4565] logger.c: [Jan 8 13:59:47] VERBOSE[4565] logger.c: -- ACKing all packets from 17 to (but not including) 18 [Jan 8 13:59:47] VERBOSE[4565] logger.c: -- Since there was nothing left, stopping T200 counter [Jan 8 13:59:47] VERBOSE[4565] logger.c: -- Stopping T203 counter since we got an ACK [Jan 8 13:59:47] VERBOSE[4565] logger.c: -- Nothing left, starting T203 counter [Jan 8 13:59:47] VERBOSE[4565] logger.c: < Protocol Discriminator: Q.931 (8) len=5 [Jan 8 13:59:47] VERBOSE[4565] logger.c: < Call Ref: len= 2 (reference 34/0x22) (Originator) [Jan 8 13:59:47] VERBOSE[4565] logger.c: < Message type: CONNECT ACKNOWLEDGE (15) [Jan 8 13:59:47] VERBOSE[4565] logger.c: q931.c:3456 q931_receive: call 34 on channel 13 enters state 10 (Active) [Jan 8 13:59:47] VERBOSE[4565] logger.c: Sending Receiver Ready (7) [Jan 8 13:59:47] VERBOSE[4565] logger.c: [Jan 8 14:01:47] VERBOSE[4565] logger.c: -- ACKing all packets from 29 to (but not including) 30 [Jan 8 14:01:47] VERBOSE[4565] logger.c: -- Since there was nothing left, stopping T200 counter [Jan 8 14:01:47] VERBOSE[4565] logger.c: -- Stopping T203 counter since we got an ACK [Jan 8 14:01:47] VERBOSE[4565] logger.c: -- Nothing left, starting T203 counter [Jan 8 14:01:47] VERBOSE[4565] logger.c: < Protocol Discriminator: Q.931 (8) len=13 [Jan 8 14:01:47] VERBOSE[4565] logger.c: < Call Ref: len= 2 (reference 34/0x22) (Originator) [Jan 8 14:01:47] VERBOSE[4565] logger.c: < Message type: DISCONNECT (69) [Jan 8 14:01:47] VERBOSE[4565] logger.c: < [08 02 80 90] [Jan 8 14:01:47] VERBOSE[4565] logger.c: < Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) Spare: 0 Location: User (0) [Jan 8 14:01:47] VERBOSE[4565] logger.c: < Ext: 1 Cause: Normal Clearing (16), class = Normal Event (1) ] [Jan 8 14:01:47] VERBOSE[4565] logger.c: < [1e 02 82 88] [Jan 8 14:01:47] VERBOSE[4565] logger.c: < Progress Indicator (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) 0: 0 Location: Public network serving the local user (2) [Jan 8 14:01:47] VERBOSE[4565] logger.c: < Ext: 1 Progress Description: Inband information or appropriate pattern now available. (8) ] [Jan 8 14:01:47] VERBOSE[4565] logger.c: -- Processing IE 8 (cs0, Cause) [Jan 8 14:01:47] VERBOSE[4565] logger.c: -- Processing IE 30 (cs0, Progress Indicator) [Jan 8 14:01:47] VERBOSE[4565] logger.c: q931.c:3563 q931_receive: call 34 on channel 13 enters state 12 (Disconnect Indication) [Jan 8 14:01:47] VERBOSE[4565] logger.c: Sending Receiver Ready (63) [Jan 8 14:01:47] VERBOSE[4565] logger.c: [Jan 8 14:02:27] VERBOSE[4565] logger.c: -- ACKing all packets from 80 to (but not including) 81 [Jan 8 14:02:27] VERBOSE[4565] logger.c: -- Since there was nothing left, stopping T200 counter [Jan 8 14:02:27] VERBOSE[4565] logger.c: -- Stopping T203 counter since we got an ACK [Jan 8 14:02:27] VERBOSE[4565] logger.c: -- Nothing left, starting T203 counter [Jan 8 14:02:27] VERBOSE[4565] logger.c: < Protocol Discriminator: Q.931 (8) len=9 [Jan 8 14:02:27] VERBOSE[4565] logger.c: < Call Ref: len= 2 (reference 34/0x22) (Originator) [Jan 8 14:02:27] VERBOSE[4565] logger.c: < Message type: RELEASE (77) [Jan 8 14:02:27] VERBOSE[4565] logger.c: < [08 02 80 90] [Jan 8 14:02:27] VERBOSE[4565] logger.c: < Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) Spare: 0 Location: User (0) [Jan 8 14:02:27] VERBOSE[4565] logger.c: < Ext: 1 Cause: Normal Clearing (16), class = Normal Event (1) ] [Jan 8 14:02:27] VERBOSE[4565] logger.c: -- Processing IE 8 (cs0, Cause) [Jan 8 14:02:27] VERBOSE[4565] logger.c: q931.c:3538 q931_receive: call 34 on channel 13 enters state 0 (Null) [Jan 8 14:02:27] VERBOSE[4565] logger.c: Sending Receiver Ready (6) [Jan 8 14:02:27] VERBOSE[4565] logger.c: [Jan 8 14:02:31] VERBOSE[4565] logger.c: -- ACKing all packets from 84 to (but not including) 85 [Jan 8 14:02:31] VERBOSE[4565] logger.c: -- Since there was nothing left, stopping T200 counter [Jan 8 14:02:31] VERBOSE[4565] logger.c: -- Stopping T203 counter since we got an ACK [Jan 8 14:02:31] VERBOSE[4565] logger.c: -- Nothing left, starting T203 counter [Jan 8 14:02:31] VERBOSE[4565] logger.c: < Protocol Discriminator: Q.931 (8) len=9 [Jan 8 14:02:31] VERBOSE[4565] logger.c: < Call Ref: len= 2 (reference 34/0x22) (Originator) [Jan 8 14:02:31] VERBOSE[4565] logger.c: < Message type: RELEASE (77) [Jan 8 14:02:31] VERBOSE[4565] logger.c: < [08 02 80 90] [Jan 8 14:02:31] VERBOSE[4565] logger.c: < Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) Spare: 0 Location: User (0) [Jan 8 14:02:31] VERBOSE[4565] logger.c: < Ext: 1 Cause: Normal Clearing (16), class = Normal Event (1) ] [Jan 8 14:02:31] VERBOSE[4565] logger.c: -- Processing IE 8 (cs0, Cause) [Jan 8 14:02:31] VERBOSE[4565] logger.c: Sending Receiver Ready (13) [Jan 8 14:02:31] VERBOSE[4565] logger.c: [Jan 8 14:02:31] VERBOSE[4565] logger.c: -- Restarting T203 counter [Jan 8 14:02:31] VERBOSE[4565] logger.c: -- Restarting T203 counter [Jan 8 14:02:31] VERBOSE[4565] logger.c: NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Null, peerstate Release Request [Jan 8 14:02:31] VERBOSE[4565] logger.c: [Jan 8 14:02:31] VERBOSE[4565] logger.c: -- Restarting T203 counter [Jan 8 14:02:31] VERBOSE[4565] logger.c: Stopping T_203 timer [Jan 8 14:02:31] VERBOSE[4565] logger.c: Starting T_200 timer [Jan 8 14:02:31] VERBOSE[4565] logger.c: > Protocol Discriminator: Q.931 (8) len=9 [Jan 8 14:02:31] VERBOSE[4565] logger.c: > Call Ref: len= 2 (reference 34/0x22) (Terminator) [Jan 8 14:02:31] VERBOSE[4565] logger.c: > Message type: RELEASE COMPLETE (90) [Jan 8 14:02:31] VERBOSE[4565] logger.c: > [08 02 81 90] [Jan 8 14:02:31] VERBOSE[4565] logger.c: > Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) Spare: 0 Location: Private network serving the local user (1) [Jan 8 14:02:31] VERBOSE[4565] logger.c: > Ext: 1 Cause: Normal Clearing (16), class = Normal Event (1) ] [Jan 8 14:02:31] VERBOSE[4565] logger.c: NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Null, peerstate Null [Jan 8 14:02:31] VERBOSE[4565] logger.c: NEW_HANGUP DEBUG: Destroying the call, ourstate Null, peerstate Null [Jan 8 14:02:31] VERBOSE[4565] logger.c: [Jan 8 14:02:50] VERBOSE[4565] logger.c: -- Restarting T203 counter [Jan 8 14:02:50] VERBOSE[4565] logger.c: -- Restarting T203 counter [Jan 8 14:02:50] DEBUG[4565] chan_zap.c: Ring requested on channel 0/13 already in use or previously requested on span 5. Attempting to renegotiating channel. [Jan 8 14:02:50] VERBOSE[4565] logger.c: NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Call Present, peerstate Call Initiated [Jan 8 14:02:50] VERBOSE[4565] logger.c: q931.c:2893 q931_release_complete: call 121 on channel 13 enters state 0 (Null) [Jan 8 14:02:50] VERBOSE[4565] logger.c: [Jan 8 14:03:14] DEBUG[4565] chan_zap.c: Ring requested on channel 0/13 already in use or previously requested on span 5. Attempting to renegotiating channel. [Jan 8 14:03:14] VERBOSE[4565] logger.c: NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Call Present, peerstate Call Initiated [Jan 8 14:03:14] VERBOSE[4565] logger.c: q931.c:2893 q931_release_complete: call 135 on channel 13 enters state 0 (Null) [Jan 8 14:03:14] VERBOSE[4565] logger.c: [Jan 8 14:03:38] DEBUG[4565] chan_zap.c: Ring requested on channel 0/13 already in use or previously requested on span 5. Attempting to renegotiating channel. [Jan 8 14:03:38] VERBOSE[4565] logger.c: NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Call Present, peerstate Call Initiated [Jan 8 14:03:38] VERBOSE[4565] logger.c: q931.c:2893 q931_release_complete: call 155 on channel 13 enters state 0 (Null) [Jan 8 14:03:38] VERBOSE[4565] logger.c: [Jan 8 14:04:14] DEBUG[4565] chan_zap.c: Ring requested on channel 0/13 already in use or previously requested on span 5. Attempting to renegotiating channel. [Jan 8 14:04:14] VERBOSE[4565] logger.c: NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Call Present, peerstate Call Initiated [Jan 8 14:04:14] VERBOSE[4565] logger.c: q931.c:2893 q931_release_complete: call 171 on channel 13 enters state 0 (Null) [Jan 8 14:04:14] VERBOSE[4565] logger.c: [Jan 8 14:04:49] DEBUG[4565] chan_zap.c: Ring requested on channel 0/13 already in use or previously requested on span 5. Attempting to renegotiating channel. [Jan 8 14:04:49] VERBOSE[4565] logger.c: NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Call Present, peerstate Call Initiated [Jan 8 14:04:49] VERBOSE[4565] logger.c: q931.c:2893 q931_release_complete: call 193 on channel 13 enters state 0 (Null) [Jan 8 14:04:49] VERBOSE[4565] logger.c: [Jan 8 14:05:23] DEBUG[4565] chan_zap.c: Ring requested on channel 0/13 already in use or previously requested on span 5. Attempting to renegotiating channel. [Jan 8 14:05:23] VERBOSE[4565] logger.c: NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Call Present, peerstate Call Initiated [Jan 8 14:05:23] VERBOSE[4565] logger.c: q931.c:2893 q931_release_complete: call 214 on channel 13 enters state 0 (Null) [Jan 8 14:05:23] VERBOSE[4565] logger.c: [Jan 8 14:05:58] DEBUG[4565] chan_zap.c: Ring requested on channel 0/13 already in use or previously requested on span 5. Attempting to renegotiating channel. [Jan 8 14:05:58] VERBOSE[4565] logger.c: NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Call Present, peerstate Call Initiated [Jan 8 14:05:58] VERBOSE[4565] logger.c: q931.c:2893 q931_release_complete: call 235 on channel 13 enters state 0 (Null) [Jan 8 14:05:58] VERBOSE[4565] logger.c: [Jan 8 14:06:19] VERBOSE[4565] logger.c: -- Restarting T203 counter [Jan 8 14:06:19] VERBOSE[4565] logger.c: -- Restarting T203 counter [Jan 8 14:06:19] VERBOSE[25905] logger.c: == Spawn extension (RADIO_ROOM, s, 8) exited non-zero on 'Zap/106-1' [Jan 8 14:06:19] DEBUG[25905] chan_zap.c: Set option AUDIO MODE, value: ON(1) on Zap/106-1 [Jan 8 14:06:19] DEBUG[25905] chan_zap.c: Set option AUDIO MODE, value: OFF(0) on Zap/106-1 [Jan 8 14:06:19] VERBOSE[25905] logger.c: -- Hungup 'Zap/106-1' [Jan 8 14:06:34] VERBOSE[4565] logger.c: -- ACKing all packets from 78 to (but not including) 79 [Jan 8 14:06:34] VERBOSE[4565] logger.c: -- Since there was nothing left, stopping T200 counter [Jan 8 14:06:34] VERBOSE[4565] logger.c: -- Stopping T203 counter since we got an ACK [Jan 8 14:06:34] VERBOSE[4565] logger.c: -- Nothing left, starting T203 counter [Jan 8 14:06:34] VERBOSE[4565] logger.c: < Protocol Discriminator: Q.931 (8) len=47 [Jan 8 14:06:34] VERBOSE[4565] logger.c: < Call Ref: len= 2 (reference 260/0x104) (Originator) [Jan 8 14:06:34] VERBOSE[4565] logger.c: < Message type: SETUP (5) [Jan 8 14:06:34] VERBOSE[4565] logger.c: < [a1] [Jan 8 14:06:34] VERBOSE[4565] logger.c: < Sending Complete (len= 1) [Jan 8 14:06:34] VERBOSE[4565] logger.c: < [04 03 80 90 a3] [Jan 8 14:06:34] VERBOSE[4565] logger.c: < Bearer Capability (len= 5) [ Ext: 1 Q.931 Std: 0 Info transfer capability: Speech (0) [Jan 8 14:06:34] VERBOSE[4565] logger.c: < Ext: 1 Trans mode/rate: 64kbps, circuit-mode (16) [Jan 8 14:06:34] VERBOSE[4565] logger.c: < Ext: 1 User information layer 1: A-Law (35) [Jan 8 14:06:34] VERBOSE[4565] logger.c: < [18 03 a9 83 8d] [Jan 8 14:06:34] VERBOSE[4565] logger.c: < Channel ID (len= 5) [ Ext: 1 IntID: Implicit PRI Spare: 0 Exclusive Dchan: 0 [Jan 8 14:06:34] VERBOSE[4565] logger.c: < ChanSel: Reserved [Jan 8 14:06:34] VERBOSE[4565] logger.c: < Ext: 1 Coding: 0 Number Specified Channel Type: 3 [Jan 8 14:06:34] VERBOSE[4565] logger.c: < Ext: 1 Channel: 13 ] [Jan 8 14:06:34] VERBOSE[4565] logger.c: < [6c 0c 21 83 33 34 35 34 30 32 36 30 35 33] [Jan 8 14:06:34] VERBOSE[4565] logger.c: < Calling Number (len=14) [ Ext: 0 TON: National Number (2) NPI: ISDN/Telephony Numbering Plan (E.164/E.163) (1) [Jan 8 14:06:34] VERBOSE[4565] logger.c: < Presentation: Presentation allowed of network provided number (3) '3454026053' ] [Jan 8 14:06:34] VERBOSE[4565] logger.c: < [70 0b 81 34 35 35 34 39 30 30 34 34 34] [Jan 8 14:06:34] VERBOSE[4565] logger.c: < Called Number (len=13) [ Ext: 1 TON: Unknown Number Type (0) NPI: ISDN/Telephony Numbering Plan (E.164/E.163) (1) '4554900444' ] [Jan 8 14:06:34] VERBOSE[4565] logger.c: < [7d 02 91 81] [Jan 8 14:06:34] VERBOSE[4565] logger.c: < IE: High-layer Compatibility (len = 4) [Jan 8 14:06:34] VERBOSE[4565] logger.c: -- Making new call for cr 260 [Jan 8 14:06:34] VERBOSE[4565] logger.c: -- Processing Q.931 Call Setup [Jan 8 14:06:34] VERBOSE[4565] logger.c: -- Processing IE 161 (cs0, Sending Complete) [Jan 8 14:06:34] VERBOSE[4565] logger.c: -- Processing IE 4 (cs0, Bearer Capability) [Jan 8 14:06:34] VERBOSE[4565] logger.c: -- Processing IE 24 (cs0, Channel Identification) [Jan 8 14:06:34] VERBOSE[4565] logger.c: -- Processing IE 108 (cs0, Calling Party Number) [Jan 8 14:06:34] VERBOSE[4565] logger.c: -- Processing IE 112 (cs0, Called Party Number) [Jan 8 14:06:34] VERBOSE[4565] logger.c: -- Processing IE 125 (cs0, High-layer Compatibility) [Jan 8 14:06:34] VERBOSE[4565] logger.c: q931.c:3298 q931_receive: call 260 on channel 13 enters state 6 (Call Present) [Jan 8 14:06:34] VERBOSE[4565] logger.c: Sending Receiver Ready (122) [Jan 8 14:06:34] VERBOSE[4565] logger.c: