Simple Accounting 'radrelay' functionality - Version 2.1.6

Craig Campbell craig at ccraft.ca
Mon Aug 31 21:38:27 CEST 2009


Here is some more of the log file - I didn't realize what to look for.. (I 
did a string search for "proxy" below this point - nothing..  same for 
"192.168.1.126" and "radius-b" strings.)

Thanks,
-craig

Listening on proxy address * port 1814
Waking up in 0.9 seconds.
rad_recv: Accounting-Request packet from host 192.168.1.101 port 50125, 
id=180, length=241
        Acct-Status-Type = Start
        User-Name = "nana1 at comfort"
        Event-Timestamp = "Aug 31 2009 15:33:05 AST"
        Acct-Delay-Time = 0
        NAS-Identifier = "ERX-2"
        Acct-Session-Id = "0314486542"
        NAS-IP-Address = 192.168.1.101
        Service-Type = Framed-User
        Framed-Protocol = PPP
        Framed-Compression = None
        ERX-Pppoe-Description = "pppoe 00:90:d0:63:df:6d"
        Framed-IP-Address = 199.2.117.119
        Framed-IP-Netmask = 255.255.255.255
        ERX-Ingress-Policy-Name = "COMFORT_UP"
        ERX-Egress-Policy-Name = "COMFORT_DOWN"
        Calling-Station-Id = "ERX-09000000261"
        NAS-Port-Type = Ethernet
        NAS-Port = 2415919365
        NAS-Port-Id = "GigabitEthernet 9/0.261:261"
        Acct-Authentic = RADIUS
+- entering group preacct {...}
++[preprocess] returns ok
[acct_unique] Hashing 'NAS-Port = 2415919365,Client-IP-Address = 
192.168.1.101,NAS-IP-Address = 192.168.1.101,Acct-Session-Id = 
"0314486542",User-Name = "nana1 at comfort"'
[acct_unique] Acct-Unique-Session-ID = "a805b61e88cd3fe2".
++[acct_unique] returns ok
[sanenasport]   expand: ^.* -> ^.*
[sanenasport]   expand: %{Acct-Session-Id} -> 0314486542
sanenasport: Changed value for attribute NAS-Port from '?' to '0314486542'
sanenasport: Could not find value pair for attribute NAS-Port
++[sanenasport] returns ok
[hexconvert]    expand: ^.*@ftth.aw$ -> ^.*@ftth.aw$
hexconvert: Does not match: User-Name = nana1 at comfort
++[hexconvert] returns ok
[suffix] Looking up realm "comfort" for User-Name = "nana1 at comfort"
[suffix] No such realm "comfort"
++[suffix] returns noop
++[files] returns noop
+- entering group accounting {...}
[detail]        expand: 
/var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d -> 
/var/log/radius/radacct/192.168.1.101/detail-20090831
[detail] /var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d expands 
to /var/log/radius/radacct/192.168.1.101/detail-20090831
[detail]        expand: %t -> Mon Aug 31 15:32:59 2009
++[detail] returns ok
++[unix] returns ok
[nameonly]      expand: @.*$ -> @.*$
nameonly: Changed value for attribute User-Name from 'nana1 at comfort' to 
'nana1'
++[nameonly] returns ok
[radutmp]       expand: /var/log/radius/radutmp -> /var/log/radius/radutmp
[radutmp]       expand: %{User-Name} -> nana1
++[radutmp] returns ok
[attr_filter.accounting_response]       expand: %{User-Name} -> nana1
 attr_filter: Matched entry DEFAULT at line 12
++[attr_filter.accounting_response] returns updated
Sending Accounting-Response of id 180 to 192.168.1.101 port 50125
Finished request 0.
Cleaning up request 0 ID 180 with timestamp +1
Going to the next request
Waking up in 0.4 seconds.
Polling for detail file 
/var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d
Waking up in 1.1 seconds.
Polling for detail file 
/var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d
Waking up in 0.8 seconds.
Polling for detail file 
/var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d
Waking up in 1.2 seconds.
rad_recv: Accounting-Request packet from host 192.168.1.101 port 50125, 
id=181, length=250
        Acct-Status-Type = Start
        User-Name = "jmartinez91 at comfort"
        Event-Timestamp = "Aug 31 2009 15:33:07 AST"
        Acct-Delay-Time = 0
        NAS-Identifier = "ERX-2"
        Acct-Session-Id = "0314486551"
        NAS-IP-Address = 192.168.1.101
        Service-Type = Framed-User
        Framed-Protocol = PPP
        Framed-Compression = None
        ERX-Pppoe-Description = "pppoe 00:08:5c:89:2c:20"
        Framed-IP-Address = 199.2.118.252
        Framed-IP-Netmask = 255.255.255.255
        ERX-Ingress-Policy-Name = "COMFORT_UP"
        ERX-Egress-Policy-Name = "COMFORT_DOWN"
        Calling-Station-Id = "ERX-01317600067"
        Connect-Info = "speed:UBR"
        NAS-Port-Type = xDSL
        NAS-Port = 330301507
        NAS-Port-Id = "atm 1/3.3300:176.67"
        Acct-Authentic = RADIUS
+- entering group preacct {...}
++[preprocess] returns ok
[acct_unique] Hashing 'NAS-Port = 330301507,Client-IP-Address = 
192.168.1.101,NAS-IP-Address = 192.168.1.101,Acct-Session-Id = 
"0314486551",User-Name = "jmartinez91 at comfort"'
[acct_unique] Acct-Unique-Session-ID = "21e39488e0f55f2c".
++[acct_unique] returns ok
[sanenasport]   expand: ^.* -> ^.*
[sanenasport]   expand: %{Acct-Session-Id} -> 0314486551
sanenasport: Changed value for attribute NAS-Port from '?°' to '0314486551'
sanenasport: Could not find value pair for attribute NAS-Port
++[sanenasport] returns ok
[hexconvert]    expand: ^.*@ftth.aw$ -> ^.*@ftth.aw$
hexconvert: Does not match: User-Name = jmartinez91 at comfort
++[hexconvert] returns ok
[suffix] Looking up realm "comfort" for User-Name = "jmartinez91 at comfort"
[suffix] No such realm "comfort"
++[suffix] returns noop
++[files] returns noop
+- entering group accounting {...}
[detail]        expand: 
/var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d -> 
/var/log/radius/radacct/192.168.1.101/detail-20090831
[detail] /var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d expands 
to /var/log/radius/radacct/192.168.1.101/detail-20090831
[detail]        expand: %t -> Mon Aug 31 15:33:01 2009
++[detail] returns ok
++[unix] returns ok
[nameonly]      expand: @.*$ -> @.*$
nameonly: Changed value for attribute User-Name from 'jmartinez91 at comfort' 
to 'jmartinez91'
++[nameonly] returns ok
[radutmp]       expand: /var/log/radius/radutmp -> /var/log/radius/radutmp
[radutmp]       expand: %{User-Name} -> jmartinez91
++[radutmp] returns ok
[attr_filter.accounting_response]       expand: %{User-Name} -> jmartinez91
 attr_filter: Matched entry DEFAULT at line 12
++[attr_filter.accounting_response] returns updated
Sending Accounting-Response of id 181 to 192.168.1.101 port 50125
Finished request 1.
Cleaning up request 1 ID 181 with timestamp +3
Going to the next request
Waking up in 1.1 seconds.
rad_recv: Accounting-Request packet from host 192.168.1.101 port 50125, 
id=182, length=304
        Acct-Status-Type = Stop
        User-Name = "rocky at lite"
        Event-Timestamp = "Aug 31 2009 15:30:56 AST"
        Acct-Delay-Time = 0
        NAS-Identifier = "ERX-2"
        Acct-Session-Id = "0314485987"
        NAS-IP-Address = 192.168.1.101
        Service-Type = Framed-User
        Framed-Protocol = PPP
        Framed-Compression = None
        ERX-Pppoe-Description = "pppoe 00:30:0a:14:f9:33"
        Framed-IP-Address = 201.229.25.147
        Framed-IP-Netmask = 255.255.255.255
        ERX-Ingress-Policy-Name = "LITE_UP"
        ERX-Egress-Policy-Name = "LITE_DOWN"
        Calling-Station-Id = "ERX-05000000274"
        Acct-Input-Gigawords = 0
        Acct-Input-Octets = 60
        Acct-Output-Gigawords = 0
        Acct-Output-Octets = 418
        ERX-Input-Gigapkts = 0
        Acct-Input-Packets = 0
        ERX-Output-Gigapkts = 0
        Acct-Output-Packets = 1
        NAS-Port-Type = Ethernet
        NAS-Port = 1342177554
        NAS-Port-Id = "GigabitEthernet 5/0.274:274"
        Acct-Authentic = RADIUS
        Acct-Session-Time = 20
        Acct-Terminate-Cause = User-Request
+- entering group preacct {...}
++[preprocess] returns ok
[acct_unique] Hashing 'NAS-Port = 1342177554,Client-IP-Address = 
192.168.1.101,NAS-IP-Address = 192.168.1.101,Acct-Session-Id = 
"0314485987",User-Name = "rocky at lite"'
[acct_unique] Acct-Unique-Session-ID = "092533c54e78489c".
++[acct_unique] returns ok
[sanenasport]   expand: ^.* -> ^.*
[sanenasport]   expand: %{Acct-Session-Id} -> 0314485987
sanenasport: Changed value for attribute NAS-Port from 'P' to '0314485987'
sanenasport: Could not find value pair for attribute NAS-Port
++[sanenasport] returns ok
[hexconvert]    expand: ^.*@ftth.aw$ -> ^.*@ftth.aw$
hexconvert: Does not match: User-Name = rocky at lite
++[hexconvert] returns ok
[suffix] Looking up realm "lite" for User-Name = "rocky at lite"
[suffix] No such realm "lite"
++[suffix] returns noop
[files] acct_users: Matched entry DEFAULT at line 33
[files] WARNING: Deprecated conditional expansion ":-".  See "man unlang" 
for details
[files]         expand: /usr/local/sbin/acctstop.sh %{Acct-Status-Type} 
%{User-Name} %{Acct-Session-Id} %{Acct-Delay-Time} %{Acct-Session-Time} 
%{Acct-Input-Octets} %{Acct-Output-Octets} %{Called-Station-Id:-unknown} 
%{Calling-Station-Id} %{Framed-IP-Address} %{NAS-Port-Type} -> 
/usr/local/sbin/acctstop.sh Stop rocky at lite 0314485987 0 20 60 418 unknown 
ERX-05000000274 201.229.25.147 Ethernet
++[files] returns ok
+- entering group accounting {...}
[detail]        expand: 
/var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d -> 
/var/log/radius/radacct/192.168.1.101/detail-20090831
[detail] /var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d expands 
to /var/log/radius/radacct/192.168.1.101/detail-20090831
[detail]        expand: %t -> Mon Aug 31 15:33:02 2009
++[detail] returns ok
++[unix] returns ok
[nameonly]      expand: @.*$ -> @.*$
nameonly: Changed value for attribute User-Name from 'rocky at lite' to 'rocky'
++[nameonly] returns ok
[radutmp]       expand: /var/log/radius/radutmp -> /var/log/radius/radutmp
[radutmp]       expand: %{User-Name} -> rocky
rlm_radutmp: Logout for NAS BRAS_100 port 314485987, but no Login record
++[radutmp] returns ok
[attr_filter.accounting_response]       expand: %{User-Name} -> rocky
 attr_filter: Matched entry DEFAULT at line 12
++[attr_filter.accounting_response] returns updated
Sending Accounting-Response of id 182 to 192.168.1.101 port 50125
Finished request 2.
Cleaning up request 2 ID 182 with timestamp +4
Going to the next request
Waking up in 0.5 seconds.
Polling for detail file 
/var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d
Waking up in 0.8 seconds.
rad_recv: Accounting-Request packet from host 192.168.1.101 port 50125, 
id=183, length=254
        Acct-Status-Type = Start
        User-Name = "dynamicmotorsports at comfort"
        Event-Timestamp = "Aug 31 2009 15:32:59 AST"
        Acct-Delay-Time = 10
        NAS-Identifier = "ERX-2"
        Acct-Session-Id = "0314486523"
        NAS-IP-Address = 192.168.1.101
        Service-Type = Framed-User
        Framed-Protocol = PPP
        Framed-Compression = None
        ERX-Pppoe-Description = "pppoe 00:90:d0:63:df:76"
        Framed-IP-Address = 201.229.44.92
        Framed-IP-Netmask = 255.255.255.255
        ERX-Ingress-Policy-Name = "COMFORT_UP"
        ERX-Egress-Policy-Name = "COMFORT_DOWN"
        Calling-Station-Id = "ERX-05000000268"
        NAS-Port-Type = Ethernet
        NAS-Port = 1342177548
        NAS-Port-Id = "GigabitEthernet 5/0.268:268"
        Acct-Authentic = RADIUS
+- entering group preacct {...}
++[preprocess] returns ok
[acct_unique] Hashing 'NAS-Port = 1342177548,Client-IP-Address = 
192.168.1.101,NAS-IP-Address = 192.168.1.101,Acct-Session-Id = 
"0314486523",User-Name = "dynamicmotorsports at comfort"'
[acct_unique] Acct-Unique-Session-ID = "c0916259420caf72".
++[acct_unique] returns ok
[sanenasport]   expand: ^.* -> ^.*
[sanenasport]   expand: %{Acct-Session-Id} -> 0314486523
sanenasport: Changed value for attribute NAS-Port from 'P' to '0314486523'
sanenasport: Could not find value pair for attribute NAS-Port
++[sanenasport] returns ok
[hexconvert]    expand: ^.*@ftth.aw$ -> ^.*@ftth.aw$
hexconvert: Does not match: User-Name = dynamicmotorsports at comfort
++[hexconvert] returns ok
[suffix] Looking up realm "comfort" for User-Name = 
"dynamicmotorsports at comfort"
[suffix] No such realm "comfort"
++[suffix] returns noop
++[files] returns noop
+- entering group accounting {...}
[detail]        expand: 
/var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d -> 
/var/log/radius/radacct/192.168.1.101/detail-20090831
[detail] /var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d expands 
to /var/log/radius/radacct/192.168.1.101/detail-20090831
[detail]        expand: %t -> Mon Aug 31 15:33:03 2009
++[detail] returns ok
++[unix] returns ok
[nameonly]      expand: @.*$ -> @.*$
nameonly: Changed value for attribute User-Name from 
'dynamicmotorsports at comfort' to 'dynamicmotorsports'
++[nameonly] returns ok
[radutmp]       expand: /var/log/radius/radutmp -> /var/log/radius/radutmp
[radutmp]       expand: %{User-Name} -> dynamicmotorsports
++[radutmp] returns ok
[attr_filter.accounting_response]       expand: %{User-Name} -> 
dynamicmotorsports
 attr_filter: Matched entry DEFAULT at line 12
++[attr_filter.accounting_response] returns updated
Sending Accounting-Response of id 183 to 192.168.1.101 port 50125
Finished request 3.
Cleaning up request 3 ID 183 with timestamp +5
Going to the next request
Waking up in 0.3 seconds.
rad_recv: Accounting-Request packet from host 192.168.1.101 port 50125, 
id=184, length=320
        Acct-Status-Type = Stop
        User-Name = "lebgroup at comfort"
        Event-Timestamp = "Aug 31 2009 15:33:09 AST"
        Acct-Delay-Time = 0
        NAS-Identifier = "ERX-2"
        Acct-Session-Id = "0314192765"
        NAS-IP-Address = 192.168.1.101
        Service-Type = Framed-User
        Framed-Protocol = PPP
        Framed-Compression = None
        ERX-Pppoe-Description = "pppoe 00:00:02:03:04:05"
        Framed-IP-Address = 204.212.126.171
        Framed-IP-Netmask = 255.255.255.255
        ERX-Ingress-Policy-Name = "COMFORT_UP"
        ERX-Egress-Policy-Name = "COMFORT_DOWN"
        Calling-Station-Id = "ERX-01317600222"
        Acct-Input-Gigawords = 0
        Acct-Input-Octets = 18401158
        Acct-Output-Gigawords = 0
        Acct-Output-Octets = 518904956
        ERX-Input-Gigapkts = 0
        Acct-Input-Packets = 212213
        ERX-Output-Gigapkts = 0
        Acct-Output-Packets = 380569
        Connect-Info = "speed:UBR"
        NAS-Port-Type = xDSL
        NAS-Port = 330301662
        NAS-Port-Id = "atm 1/3.4068:176.222"
        Acct-Authentic = RADIUS
        Acct-Session-Time = 86400
        Acct-Terminate-Cause = Session-Timeout
+- entering group preacct {...}
++[preprocess] returns ok
[acct_unique] Hashing 'NAS-Port = 330301662,Client-IP-Address = 
192.168.1.101,NAS-IP-Address = 192.168.1.101,Acct-Session-Id = 
"0314192765",User-Name = "lebgroup at comfort"'
[acct_unique] Acct-Unique-Session-ID = "ba551c799377431e".
++[acct_unique] returns ok
[sanenasport]   expand: ^.* -> ^.*
[sanenasport]   expand: %{Acct-Session-Id} -> 0314192765
sanenasport: Changed value for attribute NAS-Port from '?°' to '0314192765'
sanenasport: Could not find value pair for attribute NAS-Port
++[sanenasport] returns ok
[hexconvert]    expand: ^.*@ftth.aw$ -> ^.*@ftth.aw$
hexconvert: Does not match: User-Name = lebgroup at comfort
++[hexconvert] returns ok
[suffix] Looking up realm "comfort" for User-Name = "lebgroup at comfort"
[suffix] No such realm "comfort"
++[suffix] returns noop
[files] acct_users: Matched entry DEFAULT at line 33
[files] WARNING: Deprecated conditional expansion ":-".  See "man unlang" 
for details
[files]         expand: /usr/local/sbin/acctstop.sh %{Acct-Status-Type} 
%{User-Name} %{Acct-Session-Id} %{Acct-Delay-Time} %{Acct-Session-Time} 
%{Acct-Input-Octets} %{Acct-Output-Octets} %{Called-Station-Id:-unknown} 
%{Calling-Station-Id} %{Framed-IP-Address} %{NAS-Port-Type} -> 
/usr/local/sbin/acctstop.sh Stop lebgroup at comfort 0314192765 0 86400 
18401158 518904956 unknown ERX-01317600222 204.212.126.171 xDSL
++[files] returns ok
+- entering group accounting {...}
[detail]        expand: 
/var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d -> 
/var/log/radius/radacct/192.168.1.101/detail-20090831
[detail] /var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d expands 
to /var/log/radius/radacct/192.168.1.101/detail-20090831
[detail]        expand: %t -> Mon Aug 31 15:33:03 2009
++[detail] returns ok
++[unix] returns ok
[nameonly]      expand: @.*$ -> @.*$
nameonly: Changed value for attribute User-Name from 'lebgroup at comfort' to 
'lebgroup'
++[nameonly] returns ok
[radutmp]       expand: /var/log/radius/radutmp -> /var/log/radius/radutmp
[radutmp]       expand: %{User-Name} -> lebgroup
rlm_radutmp: Logout for NAS BRAS_100 port 314192765, but no Login record
++[radutmp] returns ok
[attr_filter.accounting_response]       expand: %{User-Name} -> lebgroup
 attr_filter: Matched entry DEFAULT at line 12
++[attr_filter.accounting_response] returns updated
Sending Accounting-Response of id 184 to 192.168.1.101 port 50125
Finished request 4.
Cleaning up request 4 ID 184 with timestamp +5
Going to the next request
Polling for detail file 
/var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d
Waking up in 1.1 seconds.
rad_recv: Accounting-Request packet from host 192.168.1.101 port 50125, 
id=185, length=232
        Acct-Status-Type = Start
        User-Name = "rocky at lite"
        Event-Timestamp = "Aug 31 2009 15:33:10 AST"
        Acct-Delay-Time = 0
        NAS-Identifier = "ERX-2"
        Acct-Session-Id = "0314486561"
        NAS-IP-Address = 192.168.1.101
        Service-Type = Framed-User
        Framed-Protocol = PPP
        Framed-Compression = None
        ERX-Pppoe-Description = "pppoe 00:30:0a:14:f9:33"
        Framed-IP-Address = 66.247.204.147
        Framed-IP-Netmask = 255.255.255.255
        ERX-Ingress-Policy-Name = "LITE_UP"
        ERX-Egress-Policy-Name = "LITE_DOWN"
        Calling-Station-Id = "ERX-05000000274"
        NAS-Port-Type = Ethernet
        NAS-Port = 1342177554
        NAS-Port-Id = "GigabitEthernet 5/0.274:274"
        Acct-Authentic = RADIUS
+- entering group preacct {...}
++[preprocess] returns ok
[acct_unique] Hashing 'NAS-Port = 1342177554,Client-IP-Address = 
192.168.1.101,NAS-IP-Address = 192.168.1.101,Acct-Session-Id = 
"0314486561",User-Name = "rocky at lite"'
[acct_unique] Acct-Unique-Session-ID = "906ea3537a67a98e".
++[acct_unique] returns ok
[sanenasport]   expand: ^.* -> ^.*
[sanenasport]   expand: %{Acct-Session-Id} -> 0314486561
sanenasport: Changed value for attribute NAS-Port from 'P' to '0314486561'
sanenasport: Could not find value pair for attribute NAS-Port
++[sanenasport] returns ok
[hexconvert]    expand: ^.*@ftth.aw$ -> ^.*@ftth.aw$
hexconvert: Does not match: User-Name = rocky at lite
++[hexconvert] returns ok
[suffix] Looking up realm "lite" for User-Name = "rocky at lite"
[suffix] No such realm "lite"
++[suffix] returns noop
++[files] returns noop
+- entering group accounting {...}
[detail]        expand: 
/var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d -> 
/var/log/radius/radacct/192.168.1.101/detail-20090831
[detail] /var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d expands 
to /var/log/radius/radacct/192.168.1.101/detail-20090831
[detail]        expand: %t -> Mon Aug 31 15:33:04 2009
++[detail] returns ok
++[unix] returns ok
[nameonly]      expand: @.*$ -> @.*$
nameonly: Changed value for attribute User-Name from 'rocky at lite' to 'rocky'
++[nameonly] returns ok
[radutmp]       expand: /var/log/radius/radutmp -> /var/log/radius/radutmp
[radutmp]       expand: %{User-Name} -> rocky
++[radutmp] returns ok
[attr_filter.accounting_response]       expand: %{User-Name} -> rocky
 attr_filter: Matched entry DEFAULT at line 12
++[attr_filter.accounting_response] returns updated
Sending Accounting-Response of id 185 to 192.168.1.101 port 50125
Finished request 5.
Cleaning up request 5 ID 185 with timestamp +6
Going to the next request
Waking up in 0.6 seconds.
rad_recv: Accounting-Request packet from host 192.168.1.101 port 50125, 
id=186, length=317
        Acct-Status-Type = Stop
        User-Name = "seabreeze at comfort"
        Event-Timestamp = "Aug 31 2009 15:33:10 AST"
        Acct-Delay-Time = 0
        NAS-Identifier = "ERX-2"
        Acct-Session-Id = "0314192771"
        NAS-IP-Address = 192.168.1.101
        Service-Type = Framed-User
        Framed-Protocol = PPP
        Framed-Compression = None
        ERX-Pppoe-Description = "pppoe 00:30:0a:14:f9:e9"
        Framed-IP-Address = 66.247.204.101
        Framed-IP-Netmask = 255.255.255.255
        ERX-Ingress-Policy-Name = "COMFORT_UP"
        ERX-Egress-Policy-Name = "COMFORT_DOWN"
        Calling-Station-Id = "ERX-05000000287"
        Acct-Input-Gigawords = 0
        Acct-Input-Octets = 12862659
        Acct-Output-Gigawords = 0
        Acct-Output-Octets = 401442146
        ERX-Input-Gigapkts = 0
        Acct-Input-Packets = 191866
        ERX-Output-Gigapkts = 0
        Acct-Output-Packets = 314993
        NAS-Port-Type = Ethernet
        NAS-Port = 1342177567
        NAS-Port-Id = "GigabitEthernet 5/0.287:287"
        Acct-Authentic = RADIUS
        Acct-Session-Time = 86400
        Acct-Terminate-Cause = Session-Timeout
+- entering group preacct {...}
++[preprocess] returns ok
[acct_unique] Hashing 'NAS-Port = 1342177567,Client-IP-Address = 
192.168.1.101,NAS-IP-Address = 192.168.1.101,Acct-Session-Id = 
"0314192771",User-Name = "seabreeze at comfort"'
[acct_unique] Acct-Unique-Session-ID = "d4d9464ddc5dcc8e".
++[acct_unique] returns ok
[sanenasport]   expand: ^.* -> ^.*
[sanenasport]   expand: %{Acct-Session-Id} -> 0314192771
sanenasport: Changed value for attribute NAS-Port from 'P' to '0314192771'
sanenasport: Could not find value pair for attribute NAS-Port
++[sanenasport] returns ok
[hexconvert]    expand: ^.*@ftth.aw$ -> ^.*@ftth.aw$
hexconvert: Does not match: User-Name = seabreeze at comfort
++[hexconvert] returns ok

----- Original Message ----- 
From: "Ivan Kalik" <tnt at kalik.net>
To: "FreeRadius users mailing list" <freeradius-users at lists.freeradius.org>
Sent: Monday, August 31, 2009 3:25 PM
Subject: Re: Simple Accounting 'radrelay' functionality - Version 2.1.6


>> Sending Accounting-Response of id 70 to 192.168.1.101 port 50125
>> Finished request 0.
>> Cleaning up request 0 ID 70 with timestamp +1
>> Going to the next request
>> Waking up in 0.3 seconds.
>
> You have cut off the debug at the interesting point. Does it poll the
> detail file after these 0.3 seconds. It should.
>
> Ivan Kalik
> Kalik Informatika ISP


__________ Information from ESET Smart Security, version of virus signature database 4385 (20090831) __________

The message was checked by ESET Smart Security.

http://www.eset.com






More information about the Freeradius-Users mailing list