07-06/15:12:27 INFO [pool-2-thread-9] radius - ACCOUNT:
Type=ACCOUNTING_REQUEST
Attributes:
User-Name=31xxxxx
NAS-IP-Address=xx.xx.xx.xx
NAS-Port=0
Acct-Status-Type=2
Acct-Delay-Time=0
Acct-Session-Time=16
Calling-Station-Id=31xxxxx
Acct-Session-Id=1278414537.14
Called-Station-Id=8xxxxxxxxxx
Asterisk-Unique-ID=1278414537.14
Asterisk-Dst-Ctx=outgoing-e1
Asterisk-User-Field="originate"
Asterisk-Clid="voip-user" <31xxxxx>
Asterisk-Disposition=ANSWERED
Asterisk-Chan=SIP/xxxxxxx-00000004
Asterisk-AMA-Flags=DOCUMENTATION
Asterisk-Dst-Chan=DAHDI/1-1
Asterisk-Last-App=Dial
h323-disconnect-cause=0
Asterisk-Last-Data=DAHDI/g1/8xxxxxxx
h323-connect-time=2010-07-06 15:09:04 +0400
h323-disconnect-time=2010-07-06 15:09:20 +0400
h323-conf-id=1278414537.14
h323-setup-time=2010-07-06 15:08:57 +0400
h323-call-origin=originate
h323-call-type=VOIP
Asterisk-Start-Time=2010-07-06 15:08:57 +0400
Asterisk-Bill-Sec=16
Asterisk-Duration=23
Asterisk-Dst=8xxxxxxx
Asterisk-End-Time=2010-07-06 15:09:20 +0400
Asterisk-Src=31xxxxx
Asterisk-Answer-Time=2010-07-06 15:09:04 +0400

07-06/15:12:27 DEBUG [pool-2-thread-9] VoiceIpProcessor - Process accounting, flag=1
Type=ACCOUNTING_REQUEST
Attributes:
User-Name=31xxxxx
NAS-IP-Address=xx.xx.xx.xx
NAS-Port=0
Acct-Status-Type=2
Acct-Delay-Time=0
Acct-Session-Time=16
Calling-Station-Id=31xxxxx
Acct-Session-Id=1278414537.14
Called-Station-Id=8xxxxxxx
Asterisk-Unique-ID=1278414537.14
Asterisk-Dst-Ctx=outgoing-e1
Asterisk-User-Field="originate"
Asterisk-Clid="voip-user" <31xxxxx>
Asterisk-Disposition=ANSWERED
Asterisk-Chan=SIP/3138292-00000004
Asterisk-AMA-Flags=DOCUMENTATION
Asterisk-Dst-Chan=DAHDI/1-1
Asterisk-Last-App=Dial
h323-disconnect-cause=0
Asterisk-Last-Data=DAHDI/g1/8xxxxxxx
h323-connect-time=2010-07-06 15:09:04 +0400
h323-disconnect-time=2010-07-06 15:09:20 +0400
h323-conf-id=1278414537.14
h323-setup-time=2010-07-06 15:08:57 +0400
h323-call-origin=originate
h323-call-type=VOIP
Asterisk-Start-Time=2010-07-06 15:08:57 +0400
Asterisk-Bill-Sec=16
Asterisk-Duration=23
Asterisk-Dst=8xxxxxxx
Asterisk-End-Time=2010-07-06 15:09:20 +0400
Asterisk-Src=31xxxxx
Asterisk-Answer-Time=2010-07-06 15:09:04 +0400

07-06/15:12:27 DEBUG [pool-2-thread-9] VoiceIpProcessor - Saved connection not found
07-06/15:12:27 INFO [pool-2-thread-9] radius - RESPONSE:
Type=ACCOUNTING_RESPONSE
Process time stop: 40
Attributes:

total 934
drwxr-xr-x 2 root wheel 512 Jun 28 00:40 .
drwxr-xr-x 5 root wheel 512 Jun 28 00:30 ..
-rw-r--r-- 1 root wheel 0 Jun 28 02:42 connection.log
-rw-r--r-- 1 root wheel 0 Jun 28 02:42 error.log
-rw-r--r-- 1 root wheel 529 Jun 28 02:42 processor.log
-rw-r--r-- 1 root wheel 930228 Jul 6 15:19 radius.log
-rw-r--r-- 1 root wheel 0 Jun 28 02:42 radius.out
-rw-r--r-- 1 root wheel 0 Jun 28 02:42 script.log

stat# cat processor.log
06-28/02:42:38 INFO [main] processor - Loading NAS list...
06-28/02:42:38 INFO [main] processor - LOADED NAS: [ NAS-Identifier: Asterisk; NAS-IP-Address: xx.xx.xx.xx; SECRET: <sec>; Vendor: 9 ]
CONFIG: service=12,13,14,15
auth.in=VOIP/answer
auth.out=VOIP/originate
acct.in=VOIP/answer
acct.out=VOIP/originate
06-28/02:42:38 INFO [main] VoiceIpProcessor - [ NAS-Identifier: Asterisk; NAS-IP-Address: xx.xx.xx.xx; SECRET: <sec>; Vendor: 9 ] find modes: User-Name=LOGIN User-Name=ALIAS Calling-Station-Id=ALIAS