Strange proxied accounting errors

Tony Spencer tony at eurisp.co.uk
Thu Feb 14 11:06:06 CET 2008


We proxy some authentication and accounting to another company.

After installing freeradius version 2.0.1 they have said they are getting
errors in their log file:

 

02/13/2008 00:01:06 Missing Acct-Status-Type attribute in request
02/13/2008 00:01:06 Request has invalid syntax (e.g. invalid, missing or
duplicate attributes), Silently discarding

 

We get the accounting info fine in our sql database.

Here is the part from the debugging that sends the accounting info to the
other company.

 

Wed Feb 13 15:17:00 2008 : Debug: rlm_sql (sql): Released sql socket id: 4

Wed Feb 13 15:17:00 2008 : Debug:   modsingle[accounting]: returned from sql
(rlm_sql) for request 0

Wed Feb 13 15:17:00 2008 : Debug: ++[sql] returns ok

Wed Feb 13 15:17:00 2008 : Debug:   modsingle[accounting]: calling
attr_filter.accounting_response (rlm_attr_filter) for request 0

Wed Feb 13 15:17:00 2008 : Debug:       expand: %{User-Name} ->
user1 at dsl.realm1.co.uk

Wed Feb 13 15:17:00 2008 : Debug:  attr_filter: Matched entry DEFAULT at
line 12

Wed Feb 13 15:17:00 2008 : Debug:   modsingle[accounting]: returned from
attr_filter.accounting_response (rlm_attr_filter) for request 0

Wed Feb 13 15:17:00 2008 : Debug: ++[attr_filter.accounting_response]
returns updated

Wed Feb 13 15:17:00 2008 : Debug: +- entering group pre-proxy

Wed Feb 13 15:17:00 2008 : Debug:   modsingle[pre-proxy]: calling
pre_proxy_log (rlm_detail) for request 0

Wed Feb 13 15:17:00 2008 : Debug:       expand:
/usr/local/var/log/radius/radacct/%{Client-IP-Address}/pre-proxy-detail-%Y%m
%d ->
/usr/local/var/log/radius/radacct/192.168.1.88/pre-proxy-detail-20080213

Wed Feb 13 15:17:00 2008 : Debug: rlm_detail:
/usr/local/var/log/radius/radacct/%{Client-IP-Address}/pre-proxy-detail-%Y%m
%d expands to
/usr/local/var/log/radius/radacct/192.168.1.88/pre-proxy-detail-20080213

Wed Feb 13 15:17:00 2008 : Debug:       expand: %t -> Wed Feb 13 15:17:00
2008

Wed Feb 13 15:17:00 2008 : Debug:   modsingle[pre-proxy]: returned from
pre_proxy_log (rlm_detail) for request 0

Wed Feb 13 15:17:00 2008 : Debug: ++[pre_proxy_log] returns ok

Wed Feb 13 15:17:00 2008 : Debug:  proxy: allocating destination 10.0.3.4
port 1646 - Id 128

Sending Accounting-Request of id 128 to 10.0.3.4 port 1646

        Cisco-AVPair = "connect-progress=LAN Ses Up"

        Cisco-AVPair = "nas-tx-speed=2261000"

        Cisco-AVPair = "nas-rx-speed=2261000"

        Proxy-State = 0x313235

Wed Feb 13 15:17:00 2008 : Debug: Proxying request 0 to home server 10.0.3.4
port 1646

Sending Accounting-Request of id 128 to 10.0.3.4 port 1646

        Cisco-AVPair = "connect-progress=LAN Ses Up"

        Cisco-AVPair = "nas-tx-speed=2261000"

        Cisco-AVPair = "nas-rx-speed=2261000"

        Realm = "dsl.realm1.co.uk"

        Proxy-State = 0x313235

 

 

It does seem to be sending the correct info.

 

The version of freeradius we had installed before used to send:

 

Sending Accounting-Request of id 0 to 10.0.3.4:1646

        Acct-Session-Id = "0016CCEC"

        Tunnel-Type:0 = L2TP

        Tunnel-Medium-Type:0 = IP

        Tunnel-Server-Endpoint:0 = "192.168.1.88"

        Tunnel-Client-Endpoint:0 = "212.248.197.74"

        Tunnel-Assignment-Id:0 = "1"

        Tunnel-Client-Auth-Id:0 = "RTMAN-HATH-BROAD-05"

        Tunnel-Server-Auth-Id:0 = " VPDN1-ADSL"

        Acct-Tunnel-Connection = "2931893097"

        Framed-Protocol = PPP

        Framed-IP-Address = 85.92.161.203

        User-Name = "user1 at dsl.realm1.co.uk"

        Cisco-AVPair = "connect-progress=LAN Ses Up"

        Cisco-AVPair = "nas-tx-speed=5088000"

        Cisco-AVPair = "nas-rx-speed=5088000"

        Acct-Session-Time = 50249

        Acct-Input-Octets = 123755364

        Acct-Output-Octets = 3820769896

        Acct-Input-Packets = 1905005

        Acct-Output-Packets = 2718597

        Acct-Authentic = RADIUS

        Acct-Status-Type = Alive

        NAS-Port-Type = Virtual

        NAS-Port = 1349

        NAS-Port-Id = "Uniq-Sess-ID1349"

        Class =
0x5342522d434c20444e3d22323034393136222041543d22323030222055533d22222053493d
22383139362200

        Service-Type = Framed-User

        NAS-IP-Address = 192.168.1.88

        Acct-Delay-Time = 5

        Proxy-State = 0x3936

 

Any help appreciated.

 

Thanks

Tony


No virus found in this outgoing message.
Checked by AVG Free Edition. 
Version: 7.5.516 / Virus Database: 269.20.4/1277 - Release Date: 13/02/2008
20:00
 
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.freeradius.org/pipermail/freeradius-users/attachments/20080214/899dba2b/attachment.html>


More information about the Freeradius-Users mailing list