-- Attempting call on Zap/19/2400399 for s@2400399:1 (Retry 1) -- Making new call for cr 32787 > Protocol Discriminator: Q.931 (8) len=32 > Call Ref: len= 2 (reference 19/0x13) (Originator) > Message type: SETUP (5) > Bearer Capability (len= 3) [ Ext: 1 Q.931 Std: 0 Info transfer capability: 3.1kHz audio (16) > Ext: 1 Trans mode/rate: 64kbps, circuit-mode (16) > Ext: 1 User information layer 1: A-Law (35) > Channel ID (len= 5) [ Ext: 1 IntID: Implicit, PRI Spare: 0, Exclusive Dchan: 0 > ChanSel: Reserved > Ext: 1 Coding: 0 Number Specified Channel Type: 3 > Ext: 1 Channel: 19 ] > Calling Number (len= 6) [ Ext: 0 TON: Unknown Number Type (0) NPI: Unknown Number Plan (0) > Presentation: Presentation permitted, user number passed network screening (1) '99' ] > Called Number (len=10) [ Ext: 1 TON: Unknown Number Type (0) NPI: Unknown Number Plan (0) '2400399' ] > Sending Complete (len= 0) Apr 6 04:11:44 DEBUG[1133742896]: chan_sip.c:615 __sip_ack: Stopping retransmission on '5dc0eb606634986058319689695c7488@211.24.146.13' of Request 102: Found asterisk*CLI> zap show channel 5 Channel: 5LI> File Descriptor: 24 Span: 1 Extension: Context: default Caller ID string: Destroy: 0 Signalling Type: PRI Signalling Owner: Real: Callwait: Threeway: Confno: -1 Propagated Conference: -1 Real in conference: 0 DSP: no Relax DTMF: no Dialing/CallwaitCAS: 0/0 Default law: alaw Fax Handled: no Pulse phone: no Echo Cancellation: 0 taps unless TDM bridged, currently OFF PRI Flags: Call Apr 6 04:11:50 WARNING[1284811568]: chan_zap.c:7119 zap_show_channel: Failed to get conference info on channel 5 Apr 6 04:11:50 WARNING[1284811568]: chan_zap.c:7125 zap_show_channel: Failed to get confmute info on channel 5 Apr 6 04:11:54 DEBUG[1133742896]: chan_sip.c:615 __sip_ack: Stopping retransmission on '047ea6ba1a1506f37f94c09a1269010f@211.24.146.13' of Request 102: Found Apr 6 04:12:04 DEBUG[1133742896]: chan_sip.c:615 __sip_ack: Stopping retransmission on '2b12720351652d5a5102e442513ab536@211.24.146.13' of Request 102: Found Apr 6 04:12:15 DEBUG[1133742896]: chan_sip.c:615 __sip_ack: Stopping retransmission on '555caa83352856d345a1268d21677bc8@211.24.146.13' of Request 102: Found Apr 6 04:12:25 DEBUG[1133742896]: chan_sip.c:615 __sip_ack: Stopping retransmission on '0451adfc18991d232ccc2f99117779ac@211.24.146.13' of Request 102: Found Apr 6 04:12:28 DEBUG[1234455344]: chan_zap.c:2208 zt_setoption: Set option AUDIO MODE, value: ON(1) on Zap/19-1 Apr 6 04:12:28 DEBUG[1234455344]: chan_zap.c:1736 zt_hangup: Hangup: channel: 19 index = 0, normal = 37, callwait = -1, thirdcall = -1 NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Call Initiated, peerstate Overlap sending > Protocol Discriminator: Q.931 (8) len=9 > Call Ref: len= 2 (reference 19/0x13) (Originator) > Message type: DISCONNECT (69) > Cause (len= 2) [ Ext: 1 Coding: CCITT (ITU) standard (0) 0: 0 Location: Private network serving the local user (1) > Ext: 1 Cause: Normal Clearing (16), class = Normal Event (1) ] Apr 6 04:12:28 DEBUG[1234455344]: chan_zap.c:2118 zt_setoption: Set option TDD MODE, value: OFF(0) on Zap/19-1 Apr 6 04:12:28 DEBUG[1234455344]: chan_zap.c:1096 update_conf: Updated conferencing on 19, with 0 conference users Apr 6 04:12:28 DEBUG[1234455344]: chan_zap.c:2202 zt_setoption: Set option AUDIO MODE, value: OFF(0) on Zap/19-1 -- Hungup 'Zap/19-1' -- Executing SendDTMF("OutgoingSpoolFailed", "") in new stack Apr 6 04:12:28 WARNING[1234455344]: app_senddtmf.c:49 senddtmf_exec: SendDTMF requires an argument (digits or *#abcd) == Spawn extension (2400399, failed, 1) exited non-zero on 'OutgoingSpoolFailed' -- Executing SendDTMF("OutgoingSpoolFailed", "") in new stack Apr 6 04:12:28 WARNING[1234455344]: app_senddtmf.c:49 senddtmf_exec: SendDTMF requires an argument (digits or *#abcd) == Spawn extension (2400399, h, 1) exited non-zero on 'OutgoingSpoolFailed' Apr 6 04:12:28 NOTICE[1234455344]: pbx_spool.c:228 attempt_thread: Call failed to go through, reason 0 Apr 6 04:12:35 DEBUG[1133742896]: chan_sip.c:615 __sip_ack: Stopping retransmission on '16d5f13b1e80c5695ef7a28259a32ef7@211.24.146.13' of Request 102: Found Apr 6 04:12:45 DEBUG[1133742896]: chan_sip.c:615 __sip_ack: Stopping retransmission on '4da9e4a37b2f9f3a0d88064e3be2db87@211.24.146.13' of Request 102: Found Apr 6 04:12:56 DEBUG[1133742896]: chan_sip.c:615 __sip_ack: Stopping retransmission on '32b5ef9e1ee11eef22127c54133e9407@211.24.146.13' of Request 102: Found Timed out looking for release > Protocol Discriminator: Q.931 (8) len=9 > Call Ref: len= 2 (reference 19/0x13) (Originator) > Message type: RELEASE (77) > Cause (len= 2) [ Ext: 1 Coding: CCITT (ITU) standard (0) 0: 0 Location: Private network serving the local user (1) > Ext: 1 Cause: Normal Clearing (16), class = Normal Event (1) ] Timed out looking for release complete > Protocol Discriminator: Q.931 (8) len=9 > Call Ref: len= 2 (reference 19/0x13) (Originator) > Message type: RELEASE (77) > Cause (len= 2) [ Ext: 1 Coding: CCITT (ITU) standard (0) 0: 0 Location: Private network serving the local user (1) > Ext: 1 Cause: Normal Clearing (16), class = Normal Event (1) ] Apr 6 04:13:06 DEBUG[1133742896]: chan_sip.c:615 __sip_ack: Stopping retransmission on '2ea45aaa754406a62b41db3c3fdca633@211.24.146.13' of Request 102: Found Final time-out looking for release complete Apr 6 04:13:16 DEBUG[1133742896]: chan_sip.c:615 __sip_ack: Stopping retransmission on '5099f2b15cb585e67b589d0256c7c7ae@211.24.146.13' of Request 102: Found Apr 6 04:13:27 DEBUG[1133742896]: chan_sip.c:615 __sip_ack: Stopping retransmission on '6d98db93062bf60038c25fa90eeffde4@211.24.146.13' of Request 102: Found Apr 6 04:13:37 DEBUG[1133742896]: chan_sip.c:615 __sip_ack: Stopping retransmission on '1948f171224db2f95ad2e3d522938582@211.24.146.13' of Request 102: Found Apr 6 04:13:47 DEBUG[1133742896]: chan_sip.c:615 __sip_ack: Stopping retransmission on '7ebe017933230dc77c8d711c71ca7b90@211.24.146.13' of Request 102: Found Apr 6 04:13:58 DEBUG[1133742896]: chan_sip.c:615 __sip_ack: Stopping retransmission on '5a6956160f655dcb084c18b73cb8fc0b@211.24.146.13' of Request 102: Found Apr 6 04:14:08 DEBUG[1133742896]: chan_sip.c:615 __sip_ack: Stopping retransmission on '4563d57742ccfba43fe39b363d415a4a@211.24.146.13' of Request 102: Found Apr 6 04:14:18 DEBUG[1133742896]: chan_sip.c:615 __sip_ack: Stopping retransmission on '4417361260a5b6510246747041618531@211.24.146.13' of Request 102: Found Apr 6 04:14:29 DEBUG[1133742896]: chan_sip.c:615 __sip_ack: Stopping retransmission on '72812b876b7fdbc968a7f7e135f2c699@211.24.146.13' of Request 102: Found Apr 6 04:14:39 DEBUG[1133742896]: chan_sip.c:615 __sip_ack: Stopping retransmission on '1ce3e6525f12d35908e87a3e45467023@211.24.146.13' of Request 102: Found Apr 6 04:14:49 DEBUG[1133742896]: chan_sip.c:615 __sip_ack: Stopping retransmission on '269257c26cde7861657fcd011f01cd58@211.24.146.13' of Request 102: Found asterisk*CLI> zap show channel 19 Channel: 19I> File Descriptor: 37 Span: 1 Extension: Context: default Caller ID string: Destroy: 0 Signalling Type: PRI Signalling Owner: Real: Callwait: Threeway: Confno: -1 Propagated Conference: -1 Real in conference: 0 DSP: no Relax DTMF: no Dialing/CallwaitCAS: 0/0 Default law: alaw Fax Handled: no Pulse phone: no Echo Cancellation: 0 taps unless TDM bridged, currently OFF PRI Flags: Call Apr 6 04:14:57 WARNING[1284811568]: chan_zap.c:7119 zap_show_channel: Failed to get conference info on channel 19 Apr 6 04:14:57 WARNING[1284811568]: chan_zap.c:7125 zap_show_channel: Failed to get confmute info on channel 19