[2010-01-19 10:37:07] VERBOSE[4897] logger.c: Asterisk Event Logger restarted
[2010-01-19 10:37:07] VERBOSE[4897] logger.c: Asterisk Queue Logger restarted
[2010-01-19 10:37:14] NOTICE[22407] chan_iax2.c: ip callno count decremented to 1 for 66.246.72.34
[2010-01-19 10:37:14] NOTICE[22403] chan_iax2.c: ip callno count incremented to 2 for 66.246.72.34
[2010-01-19 10:37:14] NOTICE[22404] chan_iax2.c: schedule decrement of callno used for 66.246.72.34 in 60 seconds
[2010-01-19 10:37:14] DEBUG[22404] chan_iax2.c: Peer VoIPjetPRIMARY2: got pong, lastms 120, historicms 120, maxms 2000
[2010-01-19 10:37:20] VERBOSE[2314] logger.c: Received Softkey Event: New Call(0/0)
[2010-01-19 10:37:20] VERBOSE[2314] logger.c: skinny_new: tmp->nativeformats=268 fmt=4
[2010-01-19 10:37:20] VERBOSE[2314] chan_skinny.c: writing packet type 0088 (16 bytes) to socket 30
[2010-01-19 10:37:20] VERBOSE[2314] chan_skinny.c: writing packet type 0111 (36 bytes) to socket 30
[2010-01-19 10:37:20] VERBOSE[2314] chan_skinny.c: writing packet type 0116 (16 bytes) to socket 30
[2010-01-19 10:37:20] VERBOSE[2314] logger.c: Attempting to Clear display on Skinny 0001@SEP0006283E0E91
[2010-01-19 10:37:20] VERBOSE[2314] logger.c: Clearing Display
[2010-01-19 10:37:20] VERBOSE[2314] chan_skinny.c: writing packet type 009A (12 bytes) to socket 30
[2010-01-19 10:37:20] VERBOSE[2314] chan_skinny.c: writing packet type 0082 (28 bytes) to socket 30
[2010-01-19 10:37:20] VERBOSE[2314] chan_skinny.c: writing packet type 0110 (28 bytes) to socket 30
[2010-01-19 10:37:20] VERBOSE[2314] logger.c: RECEIVED UNKNOWN MESSAGE TYPE:  49
[2010-01-19 10:37:21] VERBOSE[2314] logger.c: Collected digit: [0]
[2010-01-19 10:37:21] VERBOSE[4898] chan_skinny.c: writing packet type 0083 (20 bytes) to socket 30
[2010-01-19 10:37:21] VERBOSE[4898] logger.c:     -- Asked to indicate 'Stop tone' condition on channel Skinny/0001@SEP0006283E0E91-49
[2010-01-19 10:37:21] VERBOSE[4898] chan_skinny.c: writing packet type 0083 (20 bytes) to socket 30
[2010-01-19 10:37:21] VERBOSE[2314] logger.c: Collected digit: [8]
[2010-01-19 10:37:21] NOTICE[22407] chan_iax2.c: ip callno count decremented to 1 for 66.246.72.34
[2010-01-19 10:37:21] NOTICE[22406] chan_iax2.c: ip callno count incremented to 2 for 66.246.72.34
[2010-01-19 10:37:21] VERBOSE[4898] chan_skinny.c: writing packet type 0083 (20 bytes) to socket 30
[2010-01-19 10:37:21] VERBOSE[4898] logger.c:     -- Asked to indicate 'Stop tone' condition on channel Skinny/0001@SEP0006283E0E91-49
[2010-01-19 10:37:21] VERBOSE[4898] chan_skinny.c: writing packet type 0083 (20 bytes) to socket 30
[2010-01-19 10:37:21] VERBOSE[2314] logger.c: Collected digit: [0]
[2010-01-19 10:37:21] NOTICE[22397] chan_iax2.c: schedule decrement of callno used for 66.246.72.34 in 60 seconds
[2010-01-19 10:37:21] DEBUG[22397] chan_iax2.c: Peer VoIPjetPRIMARY1: got pong, lastms 117, historicms 117, maxms 2000
[2010-01-19 10:37:21] VERBOSE[4898] chan_skinny.c: writing packet type 0083 (20 bytes) to socket 30
[2010-01-19 10:37:21] VERBOSE[4898] logger.c:     -- Asked to indicate 'Stop tone' condition on channel Skinny/0001@SEP0006283E0E91-49
[2010-01-19 10:37:21] VERBOSE[4898] chan_skinny.c: writing packet type 0083 (20 bytes) to socket 30
[2010-01-19 10:37:21] VERBOSE[2314] logger.c: Collected digit: [0]
[2010-01-19 10:37:21] VERBOSE[4898] chan_skinny.c: writing packet type 0083 (20 bytes) to socket 30
[2010-01-19 10:37:21] VERBOSE[4898] logger.c:     -- Asked to indicate 'Stop tone' condition on channel Skinny/0001@SEP0006283E0E91-49
[2010-01-19 10:37:21] VERBOSE[4898] chan_skinny.c: writing packet type 0083 (20 bytes) to socket 30
[2010-01-19 10:37:21] VERBOSE[2314] logger.c: Collected digit: [6]
[2010-01-19 10:37:21] VERBOSE[4898] chan_skinny.c: writing packet type 0083 (20 bytes) to socket 30
[2010-01-19 10:37:21] VERBOSE[4898] logger.c:     -- Asked to indicate 'Stop tone' condition on channel Skinny/0001@SEP0006283E0E91-49
[2010-01-19 10:37:21] VERBOSE[4898] chan_skinny.c: writing packet type 0083 (20 bytes) to socket 30
[2010-01-19 10:37:21] VERBOSE[2314] logger.c: Collected digit: [6]
[2010-01-19 10:37:22] VERBOSE[2314] logger.c: Collected digit: [4]
[2010-01-19 10:37:22] VERBOSE[4898] chan_skinny.c: writing packet type 0083 (20 bytes) to socket 30
[2010-01-19 10:37:22] VERBOSE[4898] logger.c:     -- Asked to indicate 'Stop tone' condition on channel Skinny/0001@SEP0006283E0E91-49
[2010-01-19 10:37:22] VERBOSE[4898] chan_skinny.c: writing packet type 0083 (20 bytes) to socket 30
[2010-01-19 10:37:22] VERBOSE[2314] logger.c: Collected digit: [7]
[2010-01-19 10:37:22] VERBOSE[4898] chan_skinny.c: writing packet type 0083 (20 bytes) to socket 30
[2010-01-19 10:37:22] VERBOSE[4898] logger.c:     -- Asked to indicate 'Stop tone' condition on channel Skinny/0001@SEP0006283E0E91-49
[2010-01-19 10:37:22] VERBOSE[4898] chan_skinny.c: writing packet type 0083 (20 bytes) to socket 30
[2010-01-19 10:37:22] VERBOSE[2314] logger.c: Collected digit: [5]
[2010-01-19 10:37:22] VERBOSE[4898] chan_skinny.c: writing packet type 0083 (20 bytes) to socket 30
[2010-01-19 10:37:22] VERBOSE[4898] logger.c:     -- Asked to indicate 'Stop tone' condition on channel Skinny/0001@SEP0006283E0E91-49
[2010-01-19 10:37:22] VERBOSE[4898] chan_skinny.c: writing packet type 0083 (20 bytes) to socket 30
[2010-01-19 10:37:22] VERBOSE[2314] logger.c: Collected digit: [4]
[2010-01-19 10:37:22] VERBOSE[4898] chan_skinny.c: writing packet type 0083 (20 bytes) to socket 30
[2010-01-19 10:37:22] VERBOSE[4898] logger.c:     -- Asked to indicate 'Stop tone' condition on channel Skinny/0001@SEP0006283E0E91-49
[2010-01-19 10:37:22] VERBOSE[4898] chan_skinny.c: writing packet type 0083 (20 bytes) to socket 30
[2010-01-19 10:37:22] VERBOSE[2314] logger.c: Collected digit: [3]
[2010-01-19 10:37:22] VERBOSE[4898] chan_skinny.c: writing packet type 0083 (20 bytes) to socket 30
[2010-01-19 10:37:22] VERBOSE[4898] logger.c:     -- Asked to indicate 'Stop tone' condition on channel Skinny/0001@SEP0006283E0E91-49
[2010-01-19 10:37:22] VERBOSE[4898] chan_skinny.c: writing packet type 0083 (20 bytes) to socket 30
[2010-01-19 10:37:25] VERBOSE[4898] chan_skinny.c: writing packet type 0083 (20 bytes) to socket 30
[2010-01-19 10:37:25] DEBUG[4898] devicestate.c: Notification of state change to be queued on device/channel Skinny/0001@SEP0006283E0E91
[2010-01-19 10:37:25] VERBOSE[4898] chan_skinny.c: writing packet type 0105 (100 bytes) to socket 30
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Launching 'Set'
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Launching 'Verbose'
[2010-01-19 10:37:25] VERBOSE[4898] logger.c:   Step 0 : Input pattern 0800*******
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Launching 'Goto'
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Launching 'Verbose'
[2010-01-19 10:37:25] VERBOSE[4898] logger.c:   Step 1 : Pattern 0Z. - DE National (long distance) call| remove the leading zero & add the international prefix to promote to e.164
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Expression result is '"+49800*******"'
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Launching 'Set'
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Launching 'Goto'
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Launching 'NoOp'
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Launching 'Goto'
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Launching 'Goto'
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Launching 'Verbose'
[2010-01-19 10:37:25] VERBOSE[4898] logger.c:   Step 2 : Service path selected is DAHDI
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Expression result is '"DAHDI"'
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Launching 'Set'
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Launching 'Goto'
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Launching 'NoOp'
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Launching 'Goto'
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Launching 'Verbose'
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Launching 'Set'
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Launching 'Set'
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Function result is '"******** ********" <49809********>'
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Launching 'Verbose'
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Launching 'Goto'
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Launching 'Verbose'
[2010-01-19 10:37:25] VERBOSE[4898] logger.c:   Step 3 : Pattern +49. - this is a DE national call| drop the leading 3 chars and prepend 0
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Expression result is '"0800*******"'
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Launching 'Set'
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Launching 'Goto'
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Launching 'NoOp'
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Launching 'Goto'
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Launching 'NoOp'
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Function result is '"******** ********" <49809********>'
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Launching 'Verbose'
[2010-01-19 10:37:25] VERBOSE[4898] logger.c:   Starting number : 0800******* Dial string : 0800******* Service Path DAHDI/G0 Caller ID "******** ********" <49809********>
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Launching 'System'
[2010-01-19 10:37:25] DEBUG[22394] devicestate.c: No provider found, checking channel drivers for Skinny - 0001@SEP0006283E0E91
[2010-01-19 10:37:25] DEBUG[22394] devicestate.c: Changing state for Skinny/0001@SEP0006283E0E91 - state 2 (In use)
[2010-01-19 10:37:25] VERBOSE[2314] logger.c: Received Open Receive Channel Ack
[2010-01-19 10:37:25] VERBOSE[2314] logger.c: ipaddr = 192.168.0.156:18380
[2010-01-19 10:37:25] VERBOSE[2314] logger.c: ourip = 192.168.0.200:19940
[2010-01-19 10:37:25] VERBOSE[2314] logger.c: Setting payloadType to '4' (20 ms)
[2010-01-19 10:37:25] VERBOSE[2314] chan_skinny.c: writing packet type 008A (116 bytes) to socket 30
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Launching 'System'
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Launching 'System'
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Launching 'System'
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Launching 'System'
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Launching 'System'
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Launching 'Monitor'
[2010-01-19 10:37:25] DEBUG[4898] pbx.c: Launching 'Dial'
[2010-01-19 10:37:25] DEBUG[4898] chan_dahdi.c: Using channel 4
[2010-01-19 10:37:25] DEBUG[4898] rtp.c: Channel 'DAHDI/4-1' has no RTP, not doing anything
[2010-01-19 10:37:25] DEBUG[4898] channel.c: Not copying variable DIALEDTIME.
[2010-01-19 10:37:25] DEBUG[4898] channel.c: Not copying variable ANSWEREDTIME.
[2010-01-19 10:37:25] DEBUG[4898] channel.c: Not copying variable DIALEDPEERNAME.
[2010-01-19 10:37:25] DEBUG[4898] channel.c: Not copying variable DIALEDPEERNUMBER.
[2010-01-19 10:37:25] DEBUG[4898] channel.c: Not copying variable DIALSTATUS.
[2010-01-19 10:37:25] DEBUG[4898] channel.c: Copying hard-transferable variable MONITORED.
[2010-01-19 10:37:25] DEBUG[4898] channel.c: Not copying variable SYSTEMSTATUS.
[2010-01-19 10:37:25] DEBUG[4898] channel.c: Not copying variable dialString.
[2010-01-19 10:37:25] DEBUG[4898] channel.c: Not copying variable svcPath.
[2010-01-19 10:37:25] DEBUG[4898] channel.c: Not copying variable e164exten.
[2010-01-19 10:37:25] DEBUG[4898] channel.c: Not copying variable ~~EXTEN~~.
[2010-01-19 10:37:25] DEBUG[4898] chan_dahdi.c: Dialing '0800*******'
[2010-01-19 10:37:25] DEBUG[4898] chan_dahdi.c: Deferring dialing...
[2010-01-19 10:37:25] DEBUG[4898] devicestate.c: Notification of state change to be queued on device/channel DAHDI/4
[2010-01-19 10:37:25] DEBUG[22394] devicestate.c: No provider found, checking channel drivers for DAHDI - 4
[2010-01-19 10:37:25] DEBUG[22394] devicestate.c: Changing state for DAHDI/4 - state 2 (In use)
[2010-01-19 10:37:25] DEBUG[4898] chan_skinny.c: Oooh, format changed to 4
[2010-01-19 10:37:25] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:25] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:25] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:25] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:25] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:25] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:25] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:25] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:25] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:25] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:25] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:25] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:25] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:25] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:25] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:25] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:25] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:25] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:25] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:25] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:25] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Exception on 20, channel 4
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Got event Hook Transition Complete(12) on channel 4 (index 0)
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Sent deferred digit string: T0800*******w
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:26] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[22410] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP)
[2010-01-19 10:37:27] DEBUG[22410] acl.c: ##### Testing 192.168.0.199 with 192.168.0.0
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[22410] chan_sip.c: = Found Their Call ID: 29084e4c4dc18d63597dd77312401809@brkhlo.dyndns.org Their Tag  Our tag: as4a1147f0
[2010-01-19 10:37:27] DEBUG[22410] chan_sip.c: Stopping retransmission on '29084e4c4dc18d63597dd77312401809@brkhlo.dyndns.org' of Request 102: Match Found
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] VERBOSE[22410] logger.c: Really destroying SIP dialog '29084e4c4dc18d63597dd77312401809@brkhlo.dyndns.org' Method: OPTIONS
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:27] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:28] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:29] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:29] DEBUG[4898] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/4-1...
[2010-01-19 10:37:29] DEBUG[4898] chan_dahdi.c: Exception on 20, channel 4
[2010-01-19 10:37:29] DEBUG[4898] chan_dahdi.c: Got event Dial Complete(9) on channel 4 (index 0)
[2010-01-19 10:37:29] DEBUG[4898] chan_dahdi.c: Enabled echo cancellation on channel 4
[2010-01-19 10:37:29] DEBUG[4898] chan_dahdi.c: Done dialing, but waiting for progress detection before doing more...
[2010-01-19 10:37:29] DEBUG[4898] rtp.c: Ooh, format changed from unknown to ulaw
[2010-01-19 10:37:29] DEBUG[4898] rtp.c: Created smoother: format: 4 ms: 20 len: 160
[2010-01-19 10:37:38] DEBUG[22410] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP)
[2010-01-19 10:37:38] DEBUG[22410] acl.c: ##### Testing 192.168.0.197 with 192.168.0.0
[2010-01-19 10:37:38] DEBUG[22410] chan_sip.c: = Found Their Call ID: 4fc2dcea1f703dd317df1d1b4bb4f880@brkhlo.dyndns.org Their Tag  Our tag: as13614239
[2010-01-19 10:37:38] DEBUG[22410] chan_sip.c: Stopping retransmission on '4fc2dcea1f703dd317df1d1b4bb4f880@brkhlo.dyndns.org' of Request 102: Match Found
[2010-01-19 10:37:38] VERBOSE[22410] logger.c: Really destroying SIP dialog '4fc2dcea1f703dd317df1d1b4bb4f880@brkhlo.dyndns.org' Method: OPTIONS
[2010-01-19 10:37:47] VERBOSE[2314] logger.c: Collected digit: [5]
[2010-01-19 10:37:47] VERBOSE[2314] logger.c: Collected digit: [6]
[2010-01-19 10:37:47] VERBOSE[2314] logger.c: Collected digit: [3]
[2010-01-19 10:37:48] VERBOSE[2314] logger.c: Collected digit: [3]
[2010-01-19 10:37:48] VERBOSE[2314] logger.c: Collected digit: [6]
[2010-01-19 10:37:48] VERBOSE[2314] logger.c: Collected digit: [5]
[2010-01-19 10:37:49] VERBOSE[2314] logger.c: Collected digit: [15]
[2010-01-19 10:37:51] VERBOSE[2314] logger.c: Received Softkey Event: End Call(1/49)
[2010-01-19 10:37:51] VERBOSE[2314] chan_skinny.c: writing packet type 0106 (28 bytes) to socket 30
[2010-01-19 10:37:51] VERBOSE[2314] chan_skinny.c: writing packet type 008B (32 bytes) to socket 30
[2010-01-19 10:37:51] VERBOSE[2314] chan_skinny.c: writing packet type 0088 (16 bytes) to socket 30
[2010-01-19 10:37:51] VERBOSE[2314] logger.c: Clearing Prompt
[2010-01-19 10:37:51] VERBOSE[2314] chan_skinny.c: writing packet type 0113 (20 bytes) to socket 30
[2010-01-19 10:37:51] VERBOSE[2314] chan_skinny.c: writing packet type 0111 (36 bytes) to socket 30
[2010-01-19 10:37:51] VERBOSE[2314] chan_skinny.c: writing packet type 0110 (28 bytes) to socket 30
[2010-01-19 10:37:51] VERBOSE[2314] chan_skinny.c: writing packet type 0116 (16 bytes) to socket 30
[2010-01-19 10:37:51] VERBOSE[2314] logger.c: Skinny 0001@SEP0006283E0E91 went on hook
[2010-01-19 10:37:51] VERBOSE[2314] chan_skinny.c: writing packet type 0094 (48 bytes) to socket 30
[2010-01-19 10:37:51] DEBUG[4898] rtp.c: Channel '<unspecified>' has no RTP, not doing anything
[2010-01-19 10:37:51] DEBUG[4898] channel.c: Hanging up channel 'DAHDI/4-1'
[2010-01-19 10:37:51] DEBUG[4898] chan_dahdi.c: dahdi_hangup(DAHDI/4-1)
[2010-01-19 10:37:51] DEBUG[4898] chan_dahdi.c: Hangup: channel: 4 index = 0, normal = 20, callwait = -1, thirdcall = -1
[2010-01-19 10:37:51] DEBUG[4898] chan_dahdi.c: disabled echo cancellation on channel 4
[2010-01-19 10:37:51] DEBUG[4898] chan_dahdi.c: Set option TDD MODE, value: OFF(0) on DAHDI/4-1
[2010-01-19 10:37:51] DEBUG[4898] chan_dahdi.c: Updated conferencing on 4, with 0 conference users
[2010-01-19 10:37:51] DEBUG[4898] devicestate.c: Notification of state change to be queued on device/channel DAHDI/4
[2010-01-19 10:37:51] DEBUG[4898] app_dial.c: Exiting with DIALSTATUS=CANCEL.
[2010-01-19 10:37:51] DEBUG[4898] pbx.c: Spawn extension (inHouseLines,_.,17) exited non-zero on 'Skinny/0001@SEP0006283E0E91-49'
[2010-01-19 10:37:51] DEBUG[4898] channel.c: Soft-Hanging up channel 'Skinny/0001@SEP0006283E0E91-49'
[2010-01-19 10:37:51] DEBUG[4898] pbx.c: Launching 'Set'
[2010-01-19 10:37:51] DEBUG[4898] pbx.c: Launching 'Verbose'
[2010-01-19 10:37:51] VERBOSE[4898] logger.c:   Step 0 : Input pattern h
[2010-01-19 10:37:51] DEBUG[4898] pbx.c: Launching 'Goto'
[2010-01-19 10:37:51] DEBUG[4898] pbx.c: Launching 'Verbose'
[2010-01-19 10:37:51] VERBOSE[4898] logger.c:  Step 1 : BUGCHECK.. DEFAULT triggered| invalid dial pattern attempted 0800******* Call ID 1263893840.639
[2010-01-19 10:37:51] DEBUG[4898] pbx.c: Launching 'Playback'
[2010-01-19 10:37:51] DEBUG[4898] pbx.c: Spawn extension (inHouseLines,sw-1-h,11) exited non-zero on 'Skinny/0001@SEP0006283E0E91-49'
[2010-01-19 10:37:51] DEBUG[4898] channel.c: Hanging up channel 'Skinny/0001@SEP0006283E0E91-49'
[2010-01-19 10:37:51] VERBOSE[4898] logger.c: skinny_hangup(Skinny/0001@SEP0006283E0E91-49) on 0001@SEP0006283E0E91
[2010-01-19 10:37:51] VERBOSE[4898] chan_skinny.c: writing packet type 0083 (20 bytes) to socket 30
[2010-01-19 10:37:51] VERBOSE[4898] chan_skinny.c: writing packet type 0106 (28 bytes) to socket 30
[2010-01-19 10:37:51] VERBOSE[4898] chan_skinny.c: writing packet type 008B (32 bytes) to socket 30
[2010-01-19 10:37:51] VERBOSE[4898] chan_skinny.c: writing packet type 0088 (16 bytes) to socket 30
[2010-01-19 10:37:51] VERBOSE[4898] logger.c: Clearing Prompt
[2010-01-19 10:37:51] VERBOSE[4898] chan_skinny.c: writing packet type 0113 (20 bytes) to socket 30
[2010-01-19 10:37:51] VERBOSE[4898] chan_skinny.c: writing packet type 0111 (36 bytes) to socket 30
[2010-01-19 10:37:51] VERBOSE[4898] chan_skinny.c: writing packet type 0110 (28 bytes) to socket 30
[2010-01-19 10:37:51] VERBOSE[4898] chan_skinny.c: writing packet type 0116 (16 bytes) to socket 30
[2010-01-19 10:37:51] VERBOSE[4898] logger.c: Setting ringer mode to '1'.
[2010-01-19 10:37:51] VERBOSE[4898] chan_skinny.c: writing packet type 0085 (32 bytes) to socket 30
[2010-01-19 10:37:51] VERBOSE[4898] chan_skinny.c: writing packet type 0086 (24 bytes) to socket 30
[2010-01-19 10:37:51] VERBOSE[4898] chan_skinny.c: writing packet type 0094 (48 bytes) to socket 30
[2010-01-19 10:37:51] DEBUG[4898] pbx.c: Function result is '"******** ********" <+4980922559018>'
[2010-01-19 10:37:51] DEBUG[4898] pbx.c: Function result is '+4980922559018'
[2010-01-19 10:37:51] DEBUG[4898] pbx.c: Function result is '_.'
[2010-01-19 10:37:51] DEBUG[4898] pbx.c: Function result is 'inHouseLines'
[2010-01-19 10:37:51] DEBUG[4898] pbx.c: Function result is 'Skinny/0001@SEP0006283E0E91-49'
[2010-01-19 10:37:51] DEBUG[4898] pbx.c: Function result is 'DAHDI/4-1'
[2010-01-19 10:37:51] DEBUG[4898] pbx.c: Function result is 'Dial'
[2010-01-19 10:37:51] DEBUG[4898] pbx.c: Function result is 'DAHDI/G0/0800*******|14400|g'
[2010-01-19 10:37:51] DEBUG[4898] pbx.c: Function result is '2010-01-19 10:37:20'
[2010-01-19 10:37:51] DEBUG[4898] pbx.c: Function result is '(null)'
[2010-01-19 10:37:51] DEBUG[4898] pbx.c: Function result is '2010-01-19 10:37:51'
[2010-01-19 10:37:51] DEBUG[4898] pbx.c: Function result is '31'
[2010-01-19 10:37:51] DEBUG[4898] pbx.c: Function result is '0'
[2010-01-19 10:37:51] DEBUG[4898] pbx.c: Function result is 'NO ANSWER'
[2010-01-19 10:37:51] DEBUG[4898] pbx.c: Function result is 'DOCUMENTATION'
[2010-01-19 10:37:51] DEBUG[4898] pbx.c: Function result is '(null)'
[2010-01-19 10:37:51] DEBUG[4898] pbx.c: Function result is '1263893840.639'
[2010-01-19 10:37:51] DEBUG[4898] pbx.c: Function result is '(null)'
[2010-01-19 10:37:51] DEBUG[4898] res_monitor.c: monitor executing /usr/local/etc/asterisk/record "/var/spool/asterisk/monitor/1263893840.639-in.WAV" "/var/spool/asterisk/monitor/1263893840.639-out.WAV" "/var/spool/asterisk/monitor/1263893840.639.WAV"  &
[2010-01-19 10:37:51] DEBUG[22394] devicestate.c: No provider found, checking channel drivers for DAHDI - 4
[2010-01-19 10:37:51] DEBUG[4898] devicestate.c: Notification of state change to be queued on device/channel Skinny/0001@SEP0006283E0E91
[2010-01-19 10:37:51] DEBUG[22394] devicestate.c: Changing state for DAHDI/4 - state 0 (Unknown)
[2010-01-19 10:37:51] DEBUG[22394] devicestate.c: No provider found, checking channel drivers for Skinny - 0001@SEP0006283E0E91
[2010-01-19 10:37:51] DEBUG[22394] devicestate.c: Changing state for Skinny/0001@SEP0006283E0E91 - state 0 (Unknown)
[2010-01-19 10:37:51] VERBOSE[2314] logger.c: RECEIVED UNKNOWN MESSAGE TYPE:  49
[2010-01-19 10:37:56] NOTICE[22407] chan_iax2.c: ip callno count decremented to 0 for 208.72.186.66
[2010-01-19 10:37:56] NOTICE[22399] chan_iax2.c: ip callno count incremented to 1 for 208.72.186.66
[2010-01-19 10:37:56] NOTICE[22400] chan_iax2.c: schedule decrement of callno used for 208.72.186.66 in 60 seconds
[2010-01-19 10:37:56] DEBUG[22400] chan_iax2.c: Peer VoIPjetBACKUP: got pong, lastms 115, historicms 115, maxms 2000