2005-09-30 19:49:26 VERBOSE[15344] logger.c: -- Executing Dial("IAX2/uptime-16384", "Zap/G2/191||S(7200)") in new stack 2005-09-30 19:49:26 VERBOSE[15344] logger.c: -- Setting call duration limit to 7200 seconds. 2005-09-30 19:49:26 VERBOSE[15344] logger.c: -- Making new call for cr 32770 2005-09-30 19:49:26 VERBOSE[15344] logger.c: -- Reque/sted transfer capability: 0x00 - SPEECH 2005-09-30 19:49:26 VERBOSE[15344] logger.c: > Protocol Discriminator: Q.931 (8) len=37 2005-09-30 19:49:26 VERBOSE[15344] logger.c: > Call Ref: len= 2 (reference 2/0x2) (Originator) 2005-09-30 19:49:26 VERBOSE[15344] logger.c: > Message type: SETUP (5) 2005-09-30 19:49:26 VERBOSE[15344] logger.c: > [2005-09-30 19:49:26 VERBOSE[15344] logger.c: > [042005-09-30 19:49:26 VERBOSE[15344] logger.c: > [0 4 032005-09-30 19:49:26 VERBOSE[15344] logger.c: > [04 03 802005-09-30 19:49:26 VERBOSE[15344] logger.c: > [04 03 80 902005-09-30 19:49:26 VERBOSE[ 15344] logger.c: > [04 03 80 90 a32005-09-30 19:49:26 VERBOSE[15344] logger.c: > [04 03 80 90 a3] 2005-09-30 19:49:26 VERBOSE[15344] logger.c: > Bearer Capability (len= 5) [ Ext: 1 Q.931 Std: 0 Info transfer capability: Speech (0) 2005-09-30 19:49:26 VERBOSE[15344] logger.c: > Ext: 1 Trans mode/rate: 64kbps, circuit-mode (16) 2005-09-30 19:49:26 VERBOSE[15344] logger.c: > Ext: 1 User information layer 1: A-Law (35) 2005-09-30 19:49:26 VERBOSE[15344] logger.c: > [2005-09-30 19:49:26 VERBOSE[15344] logger.c: > [182005-09-30 19:49:26 VERBOSE[15344] logger.c: > [1 8 032005-09-30 19:49:26 VERBOSE[15344] logger.c: > [18 03 a92005-09-30 19:49:26 VERBOSE[15344] logger.c: > [18 03 a9 832005-09-30 19:49:26 VERBOSE[ 15344] logger.c: > [18 03 a9 83 9f2005-09-30 19:49:26 VERBOSE[15344] logger.c: > [18 03 a9 83 9f] 2005-09-30 19:49:26 VERBOSE[15344] logger.c: > Channel ID (len= 5) [ Ext: 1 IntID: Implicit, PRI Spare: 0, Exclusive Dchan: 0 2005-09-30 19:49:26 VERBOSE[15344] logger.c: > ChanSel: Reserved 2005-09-30 19:49:26 VERBOSE[15344] logger.c: > Ext: 1 Coding: 0 Number Specified Channel Type: 3 2005-09-30 19:49:26 VERBOSE[15344] logger.c: > Ext: 1 Channel: 31 ] 2005-09-30 19:49:26 VERBOSE[15344] logger.c: > [2005-09-30 19:49:26 VERBOSE[15344] logger.c: > [282005-09-30 19:49:26 VERBOSE[15344] logger.c: > [2 8 042005-09-30 19:49:26 VERBOSE[15344] logger.c: > [28 04 452005-09-30 19:49:26 VERBOSE[15344] logger.c: > [28 04 45 7a2005-09-30 19:49:26 VERBOSE[ 15344] logger.c: > [28 04 45 7a 692005-09-30 19:49:26 VERBOSE[15344] logger.c: > [28 04 45 7a 69 6f2005-09-30 19:49:26 VERBOSE[15344] logger.c: > [ 28 04 45 7a 69 6f] 2005-09-30 19:49:26 VERBOSE[15344] logger.c: > Display (len= 4) ^QäI[ Ezio ] 2005-09-30 19:49:26 VERBOSE[15344] logger.c: > [2005-09-30 19:49:26 VERBOSE[15344] logger.c: > [6c2005-09-30 19:49:26 VERBOSE[15344] logger.c: > [6 c 082005-09-30 19:49:26 VERBOSE[15344] logger.c: > [6c 08 002005-09-30 19:49:26 VERBOSE[15344] logger.c: > [6c 08 00 a32005-09-30 19:49:26 VERBOSE[ 15344] logger.c: > [6c 08 00 a3 392005-09-30 19:49:26 VERBOSE[15344] logger.c: > [6c 08 00 a3 39 322005-09-30 19:49:26 VERBOSE[15344] logger.c: > [ 6c 08 00 a3 39 32 322005-09-30 19:49:26 VERBOSE[15344] logger.c: > [6c 08 00 a3 39 32 32 322005-09-30 19:49:26 VERBOSE[15344] logger.c: > [6c 08 00 a3 39 32 32 32 302005-09-30 19:49:26 VERBOSE[15344] logger.c: > [6c 08 00 a3 39 32 32 32 30 342005-09-30 19:49:26 VERBOSE[15344] logger.c: > [6c 0 8 00 a3 39 32 32 32 30 34] 2005-09-30 19:49:26 VERBOSE[15344] logger.c: > Calling Number (len=10) [ Ext: 0 TON: Unknown Number Type (0) NPI: Unknown Number Plan (0) 2005-09-30 19:49:26 VERBOSE[15344] logger.c: > Presentation: Presentation prohibited of network provided number (35) '922 204' ] 2005-09-30 19:49:26 VERBOSE[15344] logger.c: > [2005-09-30 19:49:26 VERBOSE[15344] logger.c: > [702005-09-30 19:49:26 VERBOSE[15344] logger.c: > [7 0 042005-09-30 19:49:26 VERBOSE[15344] logger.c: > [70 04 802005-09-30 19:49:26 VERBOSE[15344] logger.c: > [70 04 80 312005-09-30 19:49:26 VERBOSE[ 15344] logger.c: > [70 04 80 31 392005-09-30 19:49:26 VERBOSE[15344] logger.c: > [70 04 80 31 39 312005-09-30 19:49:26 VERBOSE[15344] logger.c: > [ 70 04 80 31 39 31] 2005-09-30 19:49:26 VERBOSE[15344] logger.c: > Called Number (len= 6) [ Ext: 1 TON: Unknown Number Type (0) NPI: Unknown Number Plan (0) '191' ] 2005-09-30 19:49:26 DEBUG[15321] channel.c: Avoiding initial deadlock for 'Zap/93-1' 2005-09-30 19:49:26 VERBOSE[15344] logger.c: -- Called G2/191 2005-09-30 19:49:26 DEBUG[15344] chan_iax2.c: Created trunk peer for '82.89.96.19:4569' 2005-09-30 19:49:26 DEBUG[15344] chan_iax2.c: Expanded trunk '82.89.96.19:4569' to 6400 bytes 2005-09-30 19:49:26 VERBOSE[15331] logger.c: < Protocol Discriminator: Q.931 (8) len=10 2005-09-30 19:49:26 VERBOSE[15331] logger.c: < Call Ref: len= 2 (reference 2/0x2) (Terminator) 2005-09-30 19:49:26 VERBOSE[15331] logger.c: < Message type: SETUP ACKNOWLEDGE (13) 2005-09-30 19:49:26 VERBOSE[15331] logger.c: < [2005-09-30 19:49:26 VERBOSE[15331] logger.c: < [182005-09-30 19:49:26 VERBOSE[15331] logger.c: < [1 8 032005-09-30 19:49:26 VERBOSE[15331] logger.c: < [18 03 a92005-09-30 19:49:26 VERBOSE[15331] logger.c: < [18 03 a9 832005-09-30 19:49:26 VERBOSE[ 15331] logger.c: < [18 03 a9 83 9f2005-09-30 19:49:26 VERBOSE[15331] logger.c: < [18 03 a9 83 9f] 2005-09-30 19:49:26 VERBOSE[15331] logger.c: < Channel ID (len= 5) [ Ext: 1 IntID: Implicit, PRI Spare: 0, Exclusive Dchan: 0 2005-09-30 19:49:26 VERBOSE[15331] logger.c: < ChanSel: Reserved 2005-09-30 19:49:26 VERBOSE[15331] logger.c: < Ext: 1 Coding: 0 Number Specified Channel Type: 3 2005-09-30 19:49:26 VERBOSE[15331] logger.c: < Ext: 1 Channel: 31 ] 2005-09-30 19:49:26 VERBOSE[15331] logger.c: -- Processing IE 24 (cs0, Channel Identification) 2005-09-30 19:49:26 DEBUG[15333] chan_iax2.c: Ooh, voice format changed to 1024 2005-09-30 19:49:26 DEBUG[15334] chan_sip.c: Auto destroying call '2ec75a40-19bb9ff7@192.168.1.165' 2005-09-30 19:49:27 DEBUG[15334] chan_sip.c: Stopping retransmission on '1d47d8382b077f732b772d9a5da16f9f@85.43.54.101' of Request 102: Match Found 2005-09-30 19:49:28 VERBOSE[15331] logger.c: < Protocol Discriminator: Q.931 (8) len=13 2005-09-30 19:49:28 VERBOSE[15331] logger.c: < Call Ref: len= 2 (reference 2/0x2) (Terminator) 2005-09-30 19:49:28 VERBOSE[15331] logger.c: < Message type: CALL PROCEEDING (2) 2005-09-30 19:49:28 VERBOSE[15331] logger.c: < [2005-09-30 19:49:28 VERBOSE[15331] logger.c: < [1e2005-09-30 19:49:28 VERBOSE[15331] logger.c: < [1 e 022005-09-30 19:49:28 VERBOSE[15331] logger.c: < [1e 02 822005-09-30 19:49:28 VERBOSE[15331] logger.c: < [1e 02 82 882005-09-30 19:49:28 VERBOSE[ 15331] logger.c: < [1e 02 82 88] 2005-09-30 19:49:28 VERBOSE[15331] logger.c: < Progress Indicator (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) 0: 0 Location: Public netwo rk serving the local user (2) 2005-09-30 19:49:28 VERBOSE[15331] logger.c: < Ext: 1 Progress Description: Inband information or appropriate patter n now available. (8) ] 2005-09-30 19:49:28 VERBOSE[15331] logger.c: < [2005-09-30 19:49:28 VERBOSE[15331] logger.c: < [1e2005-09-30 19:49:28 VERBOSE[15331] logger.c: < [1 e 022005-09-30 19:49:28 VERBOSE[15331] logger.c: < [1e 02 822005-09-30 19:49:28 VERBOSE[15331] logger.c: < [1e 02 82 822005-09-30 19:49:28 VERBOSE[ 15331] logger.c: < [1e 02 82 82] 2005-09-30 19:49:28 VERBOSE[15331] logger.c: < Progress Indicator (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) 0: 0 Location: Public netwo rk serving the local user (2) 2005-09-30 19:49:28 VERBOSE[15331] logger.c: < Ext: 1 Progress Description: Called equipment is non-ISDN. (2) ] 2005-09-30 19:49:28 VERBOSE[15331] logger.c: -- Processing IE 30 (cs0, Progress Indicator) 2005-09-30 19:49:28 VERBOSE[15331] logger.c: -- Processing IE 30 (cs0, Progress Indicator) 2005-09-30 19:49:28 DEBUG[15331] chan_zap.c: Queuing frame from PRI_EVENT_PROCEEDING on channel 0/31 span 3 2005-09-30 19:49:28 VERBOSE[15344] logger.c: -- Zap/93-1 is proceeding passing it to IAX2/uptime-16384 2005-09-30 19:49:28 VERBOSE[15344] logger.c: -- Zap/93-1 is making progress passing it to IAX2/uptime-16384 2005-09-30 19:49:28 VERBOSE[15331] logger.c: < Protocol Discriminator: Q.931 (8) len=9 2005-09-30 19:49:28 VERBOSE[15331] logger.c: < Call Ref: len= 2 (reference 2/0x2) (Terminator) 2005-09-30 19:49:28 VERBOSE[15331] logger.c: < Message type: PROGRESS (3) 2005-09-30 19:49:28 VERBOSE[15331] logger.c: < [2005-09-30 19:49:28 VERBOSE[15331] logger.c: < [1e2005-09-30 19:49:28 VERBOSE[15331] logger.c: < [1 e 022005-09-30 19:49:28 VERBOSE[15331] logger.c: < [1e 02 822005-09-30 19:49:28 VERBOSE[15331] logger.c: < [1e 02 82 882005-09-30 19:49:28 VERBOSE[ 15331] logger.c: < [1e 02 82 88] 2005-09-30 19:49:28 VERBOSE[15331] logger.c: < Progress Indicator (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) 0: 0 Location: Public netwo rk serving the local user (2) 2005-09-30 19:49:28 VERBOSE[15331] logger.c: < Ext: 1 Progress Description: Inband information or appropriate patter n now available. (8) ] 2005-09-30 19:49:28 VERBOSE[15331] logger.c: -- Processing IE 30 (cs0, Progress Indicator) 2005-09-30 19:49:28 DEBUG[15331] chan_zap.c: Queuing frame from PRI_EVENT_PROGRESS on channel 0/31 span 3 2005-09-30 19:49:28 VERBOSE[15344] logger.c: -- Zap/93-1 is making progress passing it to IAX2/uptime-16384 2005-09-30 19:50:05 DEBUG[15344] chan_zap.c: Ezio - In zt_digit, p->proceeding:0 p->outgoing: 1 2005-09-30 19:50:05 VERBOSE[15344] logger.c: > Protocol Discriminator: Q.931 (8) len=9 2005-09-30 19:50:05 VERBOSE[15344] logger.c: > Call Ref: len= 2 (reference 2/0x2) (Originator) 2005-09-30 19:50:05 VERBOSE[15344] logger.c: > Message type: INFORMATION (123) 2005-09-30 19:50:05 VERBOSE[15344] logger.c: > [2005-09-30 19:50:05 VERBOSE[15344] logger.c: > [702005-09-30 19:50:05 VERBOSE[15344] logger.c: > [7 0 022005-09-30 19:50:05 VERBOSE[15344] logger.c: > [70 02 802005-09-30 19:50:05 VERBOSE[15344] logger.c: > [70 02 80 312005-09-30 19:50:05 VERBOSE[ 15344] logger.c: > [70 02 80 31] 2005-09-30 19:50:05 VERBOSE[15344] logger.c: > Called Number (len= 4) [ Ext: 1 TON: Unknown Number Type (0) NPI: Unknown Number Plan (0) '1' ] 2005-09-30 19:50:05 DTMF[15344] channel.c: Zap/93-1 : 1 2005-09-30 19:50:11 DEBUG[15333] chan_iax2.c: Immediately destroying 16384, having received hangup 2005-09-30 19:50:11 DEBUG[15344] chan_zap.c: Set option AUDIO MODE, value: ON(1) on Zap/93-1 2005-09-30 19:50:11 DEBUG[15344] chan_zap.c: Hangup: channel: 93 index = 0, normal = 104, callwait = -1, thirdcall = -1 2005-09-30 19:50:11 DEBUG[15344] chan_zap.c: Not yet hungup... Calling hangup once with icause, and clearing call 2005-09-30 19:50:11 VERBOSE[15344] logger.c: NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Outgoing call Proceeding, peerstate Incoming Call Pro ceeding 2005-09-30 19:50:11 VERBOSE[15344] logger.c: > Protocol Discriminator: Q.931 (8) len=9 2005-09-30 19:50:11 VERBOSE[15344] logger.c: > Call Ref: len= 2 (reference 2/0x2) (Originator) 2005-09-30 19:50:11 VERBOSE[15344] logger.c: > Message type: DISCONNECT (69) 2005-09-30 19:50:11 VERBOSE[15344] logger.c: > [2005-09-30 19:50:11 VERBOSE[15344] logger.c: > [082005-09-30 19:50:11 VERBOSE[15344] logger.c: > [0 8 022005-09-30 19:50:11 VERBOSE[15344] logger.c: > [08 02 812005-09-30 19:50:11 VERBOSE[15344] logger.c: > [08 02 81 902005-09-30 19:50:11 VERBOSE[ 15344] logger.c: > [08 02 81 90] 2005-09-30 19:50:11 VERBOSE[15344] logger.c: > Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) 0: 0 Location: Private network serving t he local user (1) 2005-09-30 19:50:11 VERBOSE[15344] logger.c: > Ext: 1 Cause: Unknown (16), class = Normal Event (1) ] 2005-09-30 19:50:11 DEBUG[15344] chan_zap.c: disabled echo cancellation on channel 93 2005-09-30 19:50:11 DEBUG[15344] chan_zap.c: Set option TDD MODE, value: OFF(0) on Zap/93-1 2005-09-30 19:50:11 DEBUG[15344] chan_zap.c: Updated conferencing on 93, with 0 conference users 2005-09-30 19:50:11 DEBUG[15344] chan_zap.c: Set option AUDIO MODE, value: OFF(0) on Zap/93-1 2005-09-30 19:50:11 DEBUG[15344] chan_zap.c: disabled echo cancellation on channel 93 2005-09-30 19:50:11 VERBOSE[15344] logger.c: -- Hungup 'Zap/93-1' 2005-09-30 19:50:11 DEBUG[15344] app_dial.c: Exiting with DIALSTATUS=CANCEL. 2005-09-30 19:50:11 VERBOSE[15344] logger.c: == Spawn extension (extsrv-in, 191, 3) exited non-zero on 'IAX2/uptime-16384' 2005-09-30 19:50:11 DEBUG[15344] chan_iax2.c: We're hanging up IAX2/uptime-16384 now... 2005-09-30 19:50:11 DEBUG[15344] chan_iax2.c: Really destroying IAX2/uptime-16384 now... 2005-09-30 19:50:11 VERBOSE[15344] logger.c: -- Hungup 'IAX2/uptime-16384' 2005-09-30 19:50:11 VERBOSE[15331] logger.c: < Protocol Discriminator: Q.931 (8) len=5 2005-09-30 19:50:11 VERBOSE[15331] logger.c: < Call Ref: len= 2 (reference 2/0x2) (Terminator) 2005-09-30 19:50:11 VERBOSE[15331] logger.c: < Message type: RELEASE (77) 2005-09-30 19:50:11 VERBOSE[15331] logger.c: NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Null, peerstate Release Request 2005-09-30 19:50:11 VERBOSE[15331] logger.c: > Protocol Discriminator: Q.931 (8) len=9 2005-09-30 19:50:11 VERBOSE[15331] logger.c: > Call Ref: len= 2 (reference 2/0x2) (Originator) 2005-09-30 19:50:11 VERBOSE[15331] logger.c: > Message type: RELEASE COMPLETE (90) 2005-09-30 19:50:11 VERBOSE[15331] logger.c: > [2005-09-30 19:50:11 VERBOSE[15331] logger.c: > [082005-09-30 19:50:11 VERBOSE[15331] logger.c: > [0 8 022005-09-30 19:50:11 VERBOSE[15331] logger.c: > [08 02 812005-09-30 19:50:11 VERBOSE[15331] logger.c: > [08 02 81 902005-09-30 19:50:11 VERBOSE[ 15331] logger.c: > [08 02 81 90] 2005-09-30 19:50:11 VERBOSE[15331] logger.c: > Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) 0: 0 Location: Private network serving t he local user (1) 2005-09-30 19:50:11 VERBOSE[15331] logger.c: > Ext: 1 Cause: Unknown (16), class = Normal Event (1) ] 2005-09-30 19:50:11 VERBOSE[15331] logger.c: NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Null, peerstate Null 2005-09-30 19:50:11 VERBOSE[15331] logger.c: NEW_HANGUP DEBUG: Destroying the call, ourstate Null, peerstate Null