== Parsing '/etc/asterisk/asterisk.conf': Found == Parsing '/etc/asterisk/extconfig.conf': Found Asterisk 1.2.9.1, Copyright (C) 1999 - 2006 Digium, Inc. and others. Created by Mark Spencer Asterisk comes with ABSOLUTELY NO WARRANTY; type 'show warranty' for details. This is free software, with components licensed under the GNU General Public License version 2 and other licenses; you are welcome to redistribute it under certain conditions. Type 'show license' for details. ========================================================================= Connected to Asterisk 1.2.9.1 currently running on asterisk (pid = 3510) asterisk*CLI> Verbosity is at least 35 asterisk*CLI> < Protocol Discriminator: Q.931 (8) len=36 < Call Ref: len= 2 (reference 31/0x1F) (Originator) < Message type: SETUP (5) < [a1] < Sending Complete (len= 1) < [04 03 80 90 a3] < Bearer Capability (len= 5) [ Ext: 1 Q.931 Std: 0 Info transfer capability: Speech (0) < Ext: 1 Trans mode/rate: 64kbps, circuit-mode (16) < Ext: 1 User information layer 1: A-Law (35) < [18 03 a9 83 99] < 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: 25 ] < [6c 0b 21 83 36 35 30 33 34 36 33 39 32] < Calling Number (len=13) [ Ext: 0 TON: National Number (2) NPI: ISDN/Telephony Numbering Plan (E.164/E.163) (1) < Presentation: Presentation allowed of network provided number (3) '650346392' ] < [70 05 a1 30 30 33 31] < Called Number (len= 7) [ Ext: 1 TON: National Number (2) NPI: ISDN/Telephony Numbering Plan (E.164/E.163) (1) '0031' ] -- Making new call for cr 31 -- Processing Q.931 Call Setup -- Processing IE 161 (cs0, Sending Complete) -- Processing IE 4 (cs0, Bearer Capability) -- Processing IE 24 (cs0, Channel Identification) -- Processing IE 108 (cs0, Calling Party Number) -- Processing IE 112 (cs0, Called Party Number) > Protocol Discriminator: Q.931 (8) len=10 > Call Ref: len= 2 (reference 31/0x1F) (Terminator) > Message type: CALL PROCEEDING (2) > [18 03 a9 83 99] > 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: 25 ] -- Executing SetGlobalVar("Zap/25-1", "DIALEDPEERNUMBER=0031") in new stack == Setting global variable 'DIALEDPEERNUMBER' to '0031' asterisk*CLI> -- Executing NoOp("Zap/25-1", "0031") in new stack -- Executing Set("Zap/25-1", "CALLERID(number)=70650346392") in new stack -- Executing Gosub("Zap/25-1", "default-telco-generic|0031|1") in new stack -- Executing Goto("Zap/25-1", "callback|650346392|1") in new stack -- Goto (callback,650346392,1) -- Executing SetVar("Zap/25-1", "callbacknb=650346392") in new stack -- Executing SetVar("Zap/25-1", "PRI_CAUSE=16") in new stack -- Executing Hangup("Zap/25-1", "") in new stack == Spawn extension (callback, 650346392, 3) exited non-zero on 'Zap/25-1' -- Executing System("Zap/25-1", "/space/script/callback.sh 650346392 6") in new stack asterisk*CLI> -- Accepting call from '650346392' to '0031' on channel 0/25, span 1 asterisk*CLI> NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Incoming Call Proceeding, peerstate Outgoing call Proceeding asterisk*CLI> > Protocol Discriminator: Q.931 (8) len=9 asterisk*CLI> > Call Ref: len= 2 (reference 31/0x1F) (Terminator) asterisk*CLI> > Message type: DISCONNECT (69) asterisk*CLI> > [08 02 81 90] asterisk*CLI> > Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) 0: 0 Location: Private network serving the local user (1) asterisk*CLI> > Ext: 1 Cause: Unknown (16), class = Normal Event (1) ] asterisk*CLI> -- Hungup 'Zap/25-1' asterisk*CLI> < Protocol Discriminator: Q.931 (8) len=5 < Call Ref: len= 2 (reference 31/0x1F) (Originator) < Message type: RELEASE (77) NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Null, peerstate Release Request > Protocol Discriminator: Q.931 (8) len=9 > Call Ref: len= 2 (reference 31/0x1F) (Terminator) > Message type: RELEASE COMPLETE (90) > [08 02 81 90] > Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) 0: 0 Location: Private network serving the local user (1) > Ext: 1 Cause: Unknown (16), class = Normal Event (1) ] NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Null, peerstate Null NEW_HANGUP DEBUG: Destroying the call, ourstate Null, peerstate Null asterisk*CLI> -- Registered SIP 'rn' at 10.242.42.43 port 5060 expires 120 asterisk*CLI> -- Attempting call on ZAP/g1/0650346392 for 0@callback-with-pass:1 (Retry 1) -- Making new call for cr 35349 -- Requested transfer capability: 0x00 - SPEECH > Protocol Discriminator: Q.931 (8) len=42 > Call Ref: len= 2 (reference 2581/0xA15) (Originator) > Message type: SETUP (5) > [04 03 80 90 a3] > Bearer Capability (len= 5) [ Ext: 1 Q.931 Std: 0 Info transfer capability: Speech (0) > Ext: 1 Trans mode/rate: 64kbps, circuit-mode (16) > Ext: 1 User information layer 1: A-Law (35) > [18 03 a9 83 81] > 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: 1 ] > [6c 0b 00 81 31 34 34 30 38 30 30 33 31] > Calling Number (len=13) [ Ext: 0 TON: Unknown Number Type (0) NPI: Unknown Number Plan (0) > Presentation: Presentation permitted, user number passed network screening (1) '144080031' ] > [70 0b 80 30 36 35 30 33 34 36 33 39 32] > Called Number (len=13) [ Ext: 1 TON: Unknown Number Type (0) NPI: Unknown Number Plan (0) '0650346392' ] > [a1] > Sending Complete (len= 1) asterisk*CLI> < Protocol Discriminator: Q.931 (8) len=10 < Call Ref: len= 2 (reference 2581/0xA15) (Terminator) < Message type: CALL PROCEEDING (2) < [18 03 a9 83 81] < 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: 1 ] -- Processing IE 24 (cs0, Channel Identification) asterisk*CLI> Jul 19 23:42:18 NOTICE[10090]: channel.c:2424 __ast_request_and_dial: Don't know what to do with control frame 15 asterisk*CLI> < Protocol Discriminator: Q.931 (8) len=9 < Call Ref: len= 2 (reference 2581/0xA15) (Terminator) < Message type: ALERTING (1) < [1e 02 84 88] < Progress Indicator (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) 0: 0 Location: Public network serving the remote user (4) < Ext: 1 Progress Description: Inband information or appropriate pattern now available. (8) ] -- Processing IE 30 (cs0, Progress Indicator) asterisk*CLI> < Protocol Discriminator: Q.931 (8) len=9 < Call Ref: len= 2 (reference 2581/0xA15) (Terminator) < Message type: CONNECT (7) < [4c 02 00 a3] < Connected Number (len= 4) [ Ext: 0 TON: Unknown Number Type (0) NPI: Unknown Number Plan (0) < Ext: 1 Presentation: Presentation prohibited of network provided number (35) '' ] -- Processing IE 76 (cs0, Connected Number) > Protocol Discriminator: Q.931 (8) len=5 > Call Ref: len= 2 (reference 2581/0xA15) (Originator) > Message type: CONNECT ACKNOWLEDGE (15) asterisk*CLI> > Channel Zap/1-1 was answered. -- Executing DigitTimeout("Zap/1-1", "10") in new stack -- Set Digit Timeout to 10 -- Executing ResponseTimeout("Zap/1-1", "10") in new stack -- Set Response Timeout to 10 -- Executing Read("Zap/1-1", "mypass|beep|20") in new stack -- Accepting a maximum of 20 digits. -- Playing 'beep' (language 'fr') asterisk*CLI> -- User entered '4242' -- Executing GotoIf("Zap/1-1", "1?5:3") in new stack -- Goto (callback-with-pass,0,5) -- Executing Read("Zap/1-1", "mynum|beep|20") in new stack -- Accepting a maximum of 20 digits. -- Playing 'beep' (language 'fr') asterisk*CLI> < Protocol Discriminator: Q.931 (8) len=41 < Call Ref: len= 2 (reference 32/0x20) (Originator) < Message type: SETUP (5) < [a1] < Sending Complete (len= 1) < [04 03 88 90 a6] < Bearer Capability (len= 5) [ Ext: 1 Q.931 Std: 0 Info transfer capability: Unrestricted digital information (8) < Ext: 1 Trans mode/rate: 64kbps, circuit-mode (16) < Ext: 1 User information layer 1: G.7xx 384k Video (38) < [18 03 a9 83 9a] < 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: 26 ] < [6c 0b 21 83 36 32 31 31 36 31 30 39 37] < Calling Number (len=13) [ Ext: 0 TON: National Number (2) NPI: ISDN/Telephony Numbering Plan (E.164/E.163) (1) < Presentation: Presentation allowed of network provided number (3) '621161097' ] < [70 05 a1 30 31 34 30] < Called Number (len= 7) [ Ext: 1 TON: National Number (2) NPI: ISDN/Telephony Numbering Plan (E.164/E.163) (1) '0140' ] < [7c 03 88 90 a6] < IE: Low-layer Compatibility (len = 5) -- Making new call for cr 32 -- Processing Q.931 Call Setup -- Processing IE 161 (cs0, Sending Complete) -- Processing IE 4 (cs0, Bearer Capability) -- Processing IE 24 (cs0, Channel Identification) -- Processing IE 108 (cs0, Calling Party Number) -- Processing IE 112 (cs0, Called Party Number) asterisk*CLI> -- Processing IE 124 (cs0, Low-layer Compatibility) asterisk*CLI> > Protocol Discriminator: Q.931 (8) len=10 > Call Ref: len= 2 (reference 32/0x20) (Terminator) > Message type: CALL PROCEEDING (2) > [18 03 a9 83 9a] > 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: 26 ] -- Executing SetGlobalVar("Zap/26-1", "DIALEDPEERNUMBER=0140") in new stack == Setting global variable 'DIALEDPEERNUMBER' to '0140' -- Executing NoOp("Zap/26-1", "0140") in new stack -- Executing Set("Zap/26-1", "CALLERID(number)=70621161097") in new stack -- Executing Gosub("Zap/26-1", "default-telco-generic|0140|1") in new stack -- Executing Dial("Zap/26-1", "Sip/0140&Sip/4020|20|Ttr") in new stack -- Called 0140 -- Called 4020 -- Accepting call from '621161097' to '0140' on channel 0/26, span 1 asterisk*CLI> > Protocol Discriminator: Q.931 (8) len=5 asterisk*CLI> > Call Ref: len= 2 (reference 32/0x20) (Terminator) asterisk*CLI> > Message type: ALERTING (1) asterisk*CLI> -- SIP/0140-f634 is ringing asterisk*CLI> -- SIP/4020-2a9b is ringing asterisk*CLI> -- SIP/4020-2a9b is ringing asterisk*CLI> -- User entered '0621632543' -- Executing Set("Zap/1-1", "CALLERID(number)=650346392") in new stack -- Executing Dial("Zap/1-1", "Local/0621632543@callback-dial-plan") in new stack -- Executing Dial("Local/0621632543@callback-dial-plan-ad05,2", "Zap/g1/0621632543|120|Ttr") in new stack -- Making new call for cr 35350 -- Requested transfer capability: 0x00 - SPEECH > Protocol Discriminator: Q.931 (8) len=42 > Call Ref: len= 2 (reference 2582/0xA16) (Originator) > Message type: SETUP (5) > [04 03 80 90 a3] > Bearer Capability (len= 5) [ Ext: 1 Q.931 Std: 0 Info transfer capability: Speech (0) > Ext: 1 Trans mode/rate: 64kbps, circuit-mode (16) > Ext: 1 User information layer 1: A-Law (35) > [18 03 a9 83 82] > 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: 2 ] > [6c 0b 00 81 36 35 30 33 34 36 33 39 32] > Calling Number (len=13) [ Ext: 0 TON: Unknown Number Type (0) NPI: Unknown Number Plan (0) > Presentation: Presentation permitted, user number passed network screening (1) '650346392' ] > [70 0b 80 30 36 32 31 36 33 32 35 34 33] > Called Number (len=13) [ Ext: 1 TON: Unknown Number Type (0) NPI: Unknown Number Plan (0) '0621632543' ] > [a1] > Sending Complete (len= 1) -- Called g1/0621632543 -- Called 0621632543@callback-dial-plan asterisk*CLI> -- Local/0621632543@callback-dial-plan-ad05,1 is ringing asterisk*CLI> Jul 19 23:42:39 NOTICE[10103]: channel.c:1904 ast_read: Dropping incompatible voice frame on Local/0621632543@callback-dial-plan-ad05,2 of format alaw since our native format has changed to slin asterisk*CLI> < Protocol Discriminator: Q.931 (8) len=10 < Call Ref: len= 2 (reference 2582/0xA16) (Terminator) < Message type: CALL PROCEEDING (2) < [18 03 a9 83 82] < 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: 2 ] -- Processing IE 24 (cs0, Channel Identification) asterisk*CLI> -- Zap/2-1 is proceeding passing it to Local/0621632543@callback-dial-plan-ad05,2 asterisk*CLI> < Protocol Discriminator: Q.931 (8) len=13 < Call Ref: len= 2 (reference 2582/0xA16) (Terminator) < Message type: ALERTING (1) < [1e 02 8a 88] < Progress Indicator (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) 0: 0 Location: Network beyond the interworking point (10) < Ext: 1 Progress Description: Inband information or appropriate pattern now available. (8) ] < [1e 02 8a 81] < Progress Indicator (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) 0: 0 Location: Network beyond the interworking point (10) < Ext: 1 Progress Description: Call is not end-to-end ISDN; further call progress information may be available inband. (1) ] -- Processing IE 30 (cs0, Progress Indicator) -- Processing IE 30 (cs0, Progress Indicator) asterisk*CLI> -- Zap/2-1 is ringing asterisk*CLI> < Protocol Discriminator: Q.931 (8) len=9 < Call Ref: len= 2 (reference 2582/0xA16) (Terminator) < Message type: CONNECT (7) < [4c 02 00 c3] < Connected Number (len= 4) [ Ext: 0 TON: Unknown Number Type (0) NPI: Unknown Number Plan (0) < Ext: 1 Presentation: Number not available (67) '' ] -- Processing IE 76 (cs0, Connected Number) > Protocol Discriminator: Q.931 (8) len=5 > Call Ref: len= 2 (reference 2582/0xA16) (Originator) > Message type: CONNECT ACKNOWLEDGE (15) asterisk*CLI> -- Zap/2-1 answered Local/0621632543@callback-dial-plan-ad05,2 asterisk*CLI> -- Local/0621632543@callback-dial-plan-ad05,1 stopped sounds -- Local/0621632543@callback-dial-plan-ad05,1 answered Zap/1-1 asterisk*CLI> -- Attempting native bridge of Zap/1-1 and Zap/2-1 == Spawn extension (callback-with-pass, 0, 7) exited non-zero on 'Local/0621632543@callback-dial-plan-ad05,2' Jul 19 23:42:49 NOTICE[10090]: pbx_spool.c:279 attempt_thread: Call completed to ZAP/g1/0650346392 asterisk*CLI> -- Nobody picked up in 20000 ms -- Executing Dial("Zap/26-1", "Sip/0169|20|Ttr") in new stack -- Called 0169 asterisk*CLI> -- SIP/0169-7743 is ringing asterisk*CLI> -- SIP/0141-93c6 answered Zap/26-1 > Protocol Discriminator: Q.931 (8) len=10 > Call Ref: len= 2 (reference 32/0x20) (Terminator) > Message type: CONNECT (7) > [18 03 a9 83 9a] > 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: 26 ] asterisk*CLI> < Protocol Discriminator: Q.931 (8) len=5 < Call Ref: len= 2 (reference 32/0x20) (Originator) < Message type: CONNECT ACKNOWLEDGE (15) asterisk*CLI> Jul 19 23:43:09 NOTICE[10099]: rtp.c:331 process_rfc3389: Comfort noise support incomplete in Asterisk (RFC 3389). Please turn off on client if possible. Client IP: 10.242.184.141 asterisk*CLI> == Spawn extension (default-telco-generic, 0140, 2) exited non-zero on 'Zap/26-1' NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Active, peerstate Active > Protocol Discriminator: Q.931 (8) len=9 > Call Ref: len= 2 (reference 32/0x20) (Terminator) > Message type: DISCONNECT (69) > [08 02 81 90] > Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) 0: 0 Location: Private network serving the local user (1) > Ext: 1 Cause: Unknown (16), class = Normal Event (1) ] -- Hungup 'Zap/26-1' asterisk*CLI> < Protocol Discriminator: Q.931 (8) len=5 < Call Ref: len= 2 (reference 32/0x20) (Originator) < Message type: RELEASE (77) NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Null, peerstate Release Request > Protocol Discriminator: Q.931 (8) len=9 > Call Ref: len= 2 (reference 32/0x20) (Terminator) > Message type: RELEASE COMPLETE (90) > [08 02 81 90] > Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) 0: 0 Location: Private network serving the local user (1) > Ext: 1 Cause: Unknown (16), class = Normal Event (1) ] NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Null, peerstate Null NEW_HANGUP DEBUG: Destroying the call, ourstate Null, peerstate Null asterisk*CLI> < Protocol Discriminator: Q.931 (8) len=9 < Call Ref: len= 2 (reference 2581/0xA15) (Terminator) < Message type: DISCONNECT (69) < [08 02 80 90] < Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) 0: 0 Location: User (0) < Ext: 1 Cause: Unknown (16), class = Normal Event (1) ] -- Processing IE 8 (cs0, Cause) -- Channel 0/1, span 1 got hangup request asterisk*CLI> NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Active, peerstate Connect Request > Protocol Discriminator: Q.931 (8) len=9 > Call Ref: len= 2 (reference 2582/0xA16) (Originator) > Message type: DISCONNECT (69) > [08 02 81 90] > Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) 0: 0 Location: Private network serving the local user (1) > Ext: 1 Cause: Unknown (16), class = Normal Event (1) ] -- Hungup 'Zap/2-1' == Spawn extension (callback-dial-plan, 0621632543, 1) exited non-zero on 'Zap/1-1' NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Disconnect Indication, peerstate Disconnect Request > Protocol Discriminator: Q.931 (8) len=9 > Call Ref: len= 2 (reference 2581/0xA15) (Originator) > Message type: RELEASE (77) > [08 02 81 90] > Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) 0: 0 Location: Private network serving the local user (1) > Ext: 1 Cause: Unknown (16), class = Normal Event (1) ] -- Hungup 'Zap/1-1' asterisk*CLI> < Protocol Discriminator: Q.931 (8) len=5 < Call Ref: len= 2 (reference 2581/0xA15) (Terminator) < Message type: RELEASE COMPLETE (90) NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Null, peerstate Null NEW_HANGUP DEBUG: Destroying the call, ourstate Null, peerstate Null asterisk*CLI> < Protocol Discriminator: Q.931 (8) len=5 < Call Ref: len= 2 (reference 2582/0xA16) (Terminator) < Message type: RELEASE (77) NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Null, peerstate Release Request > Protocol Discriminator: Q.931 (8) len=9 > Call Ref: len= 2 (reference 2582/0xA16) (Originator) > Message type: RELEASE COMPLETE (90) > [08 02 81 90] > Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) 0: 0 Location: Private network serving the local user (1) > Ext: 1 Cause: Unknown (16), class = Normal Event (1) ] NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Null, peerstate Null NEW_HANGUP DEBUG: Destroying the call, ourstate Null, peerstate Null asterisk*CLI>