127101983810448
=====================
Setup-- on channel 15

[Nov 15 12:27:39] VERBOSE[17876] logger.c: > Call Ref: len= 2 (reference 294/0x126) (Originator)
[Nov 15 12:27:39] VERBOSE[17876] logger.c: > Message type: SETUP (5)
[Nov 15 12:27:39] VERBOSE[17876] logger.c: > [04 03 80 90 a3]
[Nov 15 12:27:39] VERBOSE[17876] logger.c: > Bearer Capability (len= 5) [ Ext: 1  Q.931 Std: 0  Info transfer capability: Speech (0)
[Nov 15 12:27:39] VERBOSE[17876] logger.c: >                              Ext: 1  Trans mode/rate: 64kbps, circuit-mode (16)
[Nov 15 12:27:39] VERBOSE[17876] logger.c: >                                User information layer 1: A-Law (35)
[Nov 15 12:27:39] VERBOSE[17876] logger.c: > [18 03 a1 83 8f]
[Nov 15 12:27:39] VERBOSE[17876] logger.c: > Channel ID (len= 5) [ Ext: 1  IntID: Implicit  PRI  Spare: 0  Preferred  Dchan: 0
[Nov 15 12:27:39] VERBOSE[17876] logger.c: >                        ChanSel: As indicated in following octets
[Nov 15 12:27:39] VERBOSE[17876] logger.c: >                       Ext: 1  Coding: 0  Number Specified  Channel Type: 3
[Nov 15 12:27:39] VERBOSE[17876] logger.c: >                       Ext: 1  Channel: 15 ]
[Nov 15 12:27:39] VERBOSE[17876] logger.c: > [6c 0c 00 80 30 38 34 35 34 35 39 36 31 33]
[Nov 15 12:27:39] VERBOSE[17876] logger.c: > Calling Number (len=14) [ Ext: 0  TON: Unknown Number Type (0)  NPI: Unknown Number Plan (0)
[Nov 15 12:27:39] VERBOSE[17876] logger.c: >                           Presentation: Presentation permitted, user number not screened (0)  '0845459613' ]
[Nov 15 12:27:39] VERBOSE[17876] logger.c: > [70 10 80 31 32 37 31 30 31 39 38 33 38 31 30 34 34 38]
[Nov 15 12:27:39] VERBOSE[17876] logger.c: > Called Number (len=18) [ Ext: 1  TON: Unknown Number Type (0)  NPI: Unknown Number Plan (0)  '127101983810448' ]
[Nov 15 12:27:39] VERBOSE[17876] logger.c: > [a1]
[Nov 15 12:27:39] VERBOSE[17876] logger.c: > Sending Complete (len= 1)
[Nov 15 12:27:39] VERBOSE[17876] logger.c: q931.c:3134 q931_setup: call 33062 on channel 15 enters state 1 (Call Initiated)



Proceeding.. came on channel 20

[Nov 15 12:27:39] VERBOSE[26762] logger.c: < Message type: CALL PROCEEDING (2)
[Nov 15 12:27:39] VERBOSE[26762] logger.c: < [18 03 a9 83 94]
[Nov 15 12:27:39] VERBOSE[26762] logger.c: < Channel ID (len= 5) [ Ext: 1  IntID: Implicit  PRI  Spare: 0  Exclusive  Dchan: 0
[Nov 15 12:27:39] VERBOSE[26762] logger.c: <                        ChanSel: As indicated in following octets
[Nov 15 12:27:39] VERBOSE[26762] logger.c: <                       Ext: 1  Coding: 0  Number Specified  Channel Type: 3
[Nov 15 12:27:39] VERBOSE[26762] logger.c: <                       Ext: 1  Channel: 20 ]
[Nov 15 12:27:39] VERBOSE[26762] logger.c: -- Processing IE 24 (cs0, Channel Identification)
[Nov 15 12:27:39] VERBOSE[26762] logger.c: q931.c:3683 q931_receive: call 33062 on channel 20 enters state 3 (Outgoing call  


alerting---

[Nov 15 12:27:45] VERBOSE[26762] logger.c: < Message type: ALERTING (1)
[Nov 15 12:27:45] VERBOSE[26762] logger.c: q931.c:3596 q931_receive: call 33062 on channel 20 enters state 4 (Call Delivered)
[Nov 15 12:27:45] VERBOSE[26762] logger.c: Sending Receiver Ready (8)
[Nov 15 12:27:45] VERBOSE[26762] logger.c:
> [ 02 01 01 10 ]
[Nov 15 12:27:45] VERBOSE[26762] logger.c:
> Supervisory frame:
[Nov 15 12:27:45] VERBOSE[26762] logger.c: > SAPI: 00  C/R: 1 EA: 0
>  TEI: 000        EA: 1
[Nov 15 12:27:45] VERBOSE[26762] logger.c: > Zero: 0     S: 0 01: 1  [ RR (receive ready) ]
> N(R): 008 P/F: 0
> 0 bytes of data
[Nov 15 12:27:45] VERBOSE[26762] logger.c: -- Restarting T203 timer
[Nov 15 12:27:45] VERBOSE[26762] logger.c:     -- Moving call from channel 15 to channel 20

[Nov 15 12:27:45] WARNING[26762] chan_dahdi.c: Can't fix up channel from 15 to 20 because 20 is already in use
[Nov 15 12:27:45] WARNING[26762] chan_dahdi.c: Ringing requested on channel 0/20 not in use on span 1
[Nov 15 12:27:45] VERBOSE[26762] logger.c: T203 counter expired, sending RR and scheduling T203 again
[Nov 15 12:27:45] VERBOSE[26762] logger.c: Sending Receiver Ready (8)


Connect--

[Nov 15 12:27:55] VERBOSE[26762] logger.c: < Message type: CONNECT (7)
[Nov 15 12:27:55] VERBOSE[26762] logger.c: q931.c:3626 q931_receive: call 33062 on channel 20 enters state 10 (Active)
[Nov 15 12:27:55] VERBOSE[26762] logger.c:
> [ 00 01 fc 44 08 02 01 26 0f ]
[Nov 15 12:27:55] VERBOSE[26762] logger.c:
> Informational frame:
[Nov 15 12:27:55] VERBOSE[26762] logger.c: > SAPI: 00  C/R: 0 EA: 0
>  TEI: 000        EA: 1
[Nov 15 12:27:55] VERBOSE[26762] logger.c: > N(S): 126   0: 0
> N(R): 034   P: 0
> 5 bytes of data
[Nov 15 12:27:55] VERBOSE[26762] logger.c: Stopping T_203 timer
[Nov 15 12:27:55] VERBOSE[26762] logger.c: Starting T_200 timer
[Nov 15 12:27:55] VERBOSE[26762] logger.c: -- Restarting T200 timer
[Nov 15 12:27:55] VERBOSE[26762] logger.c: > Protocol Discriminator: Q.931 (8)  len=5
[Nov 15 12:27:55] VERBOSE[26762] logger.c: > Call Ref: len= 2 (reference 294/0x126) (Originator)
[Nov 15 12:27:55] VERBOSE[26762] logger.c: > Message type: CONNECT ACKNOWLEDGE (15)
[Nov 15 12:27:55] VERBOSE[26762] logger.c: -- Restarting T203 timer
[Nov 15 12:27:55] VERBOSE[26762] logger.c:     -- Moving call from channel 15 to channel 20

[Nov 15 12:27:55] VERBOSE[17972] logger.c:     -- Executing [8365@default:1] Playback("Local/9101983810448@default-6aa0,1", "silence") in new stack

[Nov 15 12:27:55] VERBOSE[17972] logger.c:     -- Executing [8365@default:2] AGI("DAHDI/0:20-1", "transfer_agi|192.168.20.174|192.168.20.10|local") in new stack

[Nov 15 12:27:55] VERBOSE[17972] logger.c:     -- Executing [8365@default:3] AGI("DAHDI/0:20-1", "transfer_sleep|192.168.20.174|192.168.20.10|contaque") in new stack

[Nov 15 12:28:16] VERBOSE[17972] logger.c:     -- Executing [8365@default:4] Hangup("DAHDI/0:20-1", "") in new stack
[Nov 15 12:28:16] VERBOSE[17972] logger.c:   == Spawn extension (default, 8365, 4) exited non-zero on 'DAHDI/0:20-1'


[Nov 15 12:28:16] VERBOSE[17972] logger.c:     -- Executing [h@default:1] DeadAGI("DAHDI/0:20-1", "hangup|192.168.20.174|192.168.20.10|16||n") in new stack


Disconnect---

[Nov 15 12:28:16] VERBOSE[17972] logger.c: NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Active, peerstate Connect Request
[Nov 15 12:28:16] VERBOSE[17972] logger.c: q931.c:3015 q931_disconnect: call 33062 on channel 20 enters state 11 (Disconnect Request)
[Nov 15 12:28:16] VERBOSE[17972] logger.c:
> [ 00 01 3a 92 08 02 01 26 45 08 02 81 90 ]
[Nov 15 12:28:16] VERBOSE[17972] logger.c:
> Informational frame:
[Nov 15 12:28:16] VERBOSE[17972] logger.c: > SAPI: 00  C/R: 0 EA: 0
>  TEI: 000        EA: 1
[Nov 15 12:28:16] VERBOSE[17972] logger.c: > N(S): 029   0: 0
> N(R): 073   P: 0
> 9 bytes of data
[Nov 15 12:28:16] VERBOSE[17972] logger.c: Stopping T_203 timer
[Nov 15 12:28:16] VERBOSE[17972] logger.c: Starting T_200 timer
[Nov 15 12:28:16] VERBOSE[17972] logger.c: -- Restarting T200 timer
[Nov 15 12:28:16] VERBOSE[17972] logger.c: > Protocol Discriminator: Q.931 (8)  len=9
[Nov 15 12:28:16] VERBOSE[17972] logger.c: > Call Ref: len= 2 (reference 294/0x126) (Originator)
[Nov 15 12:28:16] VERBOSE[17972] logger.c: > Message type: DISCONNECT (69)
[Nov 15 12:28:16] VERBOSE[17972] logger.c: > [08 02 81 90]
[Nov 15 12:28:16] VERBOSE[17972] logger.c: > Cause (len= 4) [ Ext: 1  Coding: CCITT (ITU) standard (0)  Spare: 0  Location: Private network serving the local user (1)
[Nov 15 12:28:16] VERBOSE[17972] logger.c: >                  Ext: 1  Cause: Normal Clearing (16), class = Normal Event (1) ]
[Nov 15 12:28:16] DEBUG[17972] chan_dahdi.c: Set option AUDIO MODE, value: OFF(0) on DAHDI/0:20-1
[Nov 15 12:28:16] VERBOSE[17972] logger.c:     -- Hungup 'DAHDI/0:20-1'