Hi All, I'm having a problem that I can't find a solution to. The process I'm using is as follows. User connects to landing page, landing page sends access-request to server with users details. FreeRADIUS then sends a COA to the NAS to change the state and apply attributes. However when FreeRADIUS gets the accounting-start packet, it does nothing with it. Can someone please tell me how I can log this normally in radacct table? In my accounting section i have accounting { sql } sql_xlat finished rlm_sql (sql): Released sql socket id: 4 expand: %{sql:SELECT IFNULL((SELECT IF(ims.vouchers.`data`= 0, 0,IF((ims.vouchers.`data` - (SUM(radius.radacct.acctinputoctets)+SUM(radius.radacct.acctoutputoctets))) < 0,-1, ims.vouchers.`data` - (SUM(radius.radacct.acctinputoctets)+SUM(radius.radacct.acctoutputoctets)))) AS voucherdata FROM radius.radacct,ims.vouchers WHERE radius.radacct.username='%{request:User-Name}' AND radius.radacct.username = ims.vouchers.voucher AND radius.radacct.acctterminatecause<>'Hotspot Restart'),(SELECT ims.vouchers.`data` FROM ims.vouchers WHERE ims.vouchers.voucher='%{request:User-Name}')) as voucherdata} -> 1048576 ++[control] returns noop sql_xlat expand: %{User-Name} -> 10269783 sql_set_user escaped user --> '10269783' expand: SELECT IFNULL((SELECT IF(ims.user_account.`data`= 0, 0,IF((ims.user_account.`data` - (SUM(radius.radacct.acctinputoctets)+SUM(radius.radacct.acctoutputoctets))) < 0,-1, ims.user_account.`data` - (SUM(radius.radacct.acctinputoctets)+SUM(radius.radacct.acctoutputoctets)))) AS voucherdata FROM radius.radacct,ims.user_account WHERE radius.radacct.username='%{request:User-Name}' AND radius.radacct.username = ims.user_account.username AND radius.radacct.acctterminatecause<>'Hotspot Restart'),(SELECT ims.user_account.`data` FROM ims.user_account WHERE ims.user_account.username='%{request:User-Name}')) as voucherdata -> SELECT IFNULL((SELECT IF(ims.user_account.`data`= 0, 0,IF((ims.user_account.`data` - (SUM(radius.radacct.acctinputoctets)+SUM(radius.radacct.acctoutputoctets))) < 0,-1, ims.user_account.`data` - (SUM(radius.radacct.acctinputoctets)+SUM(radius.radacct.acctoutputoctets)))) AS voucherdata FROM radius.radacct,ims.user_account WHERE radius.radacct.username='10269783' AND radius.radacct.username = rlm_sql (sql): Reserving sql socket id: 3 row[0] returned NULL rlm_sql (sql): Released sql socket id: 3 expand: %{sql:SELECT IFNULL((SELECT IF(ims.user_account.`data`= 0, 0,IF((ims.user_account.`data` - (SUM(radius.radacct.acctinputoctets)+SUM(radius.radacct.acctoutputoctets))) < 0,-1, ims.user_account.`data` - (SUM(radius.radacct.acctinputoctets)+SUM(radius.radacct.acctoutputoctets)))) AS voucherdata FROM radius.radacct,ims.user_account WHERE radius.radacct.username='%{request:User-Name}' AND radius.radacct.username = ims.user_account.username AND radius.radacct.acctterminatecause<>'Hotspot Restart'),(SELECT ims.user_account.`data` FROM ims.user_account WHERE ims.user_account.username='%{request:User-Name}')) as voucherdata} -> ++[control] returns noop ++? if (control:IMS-ActiveDirectory == 0) ? Evaluating (control:IMS-ActiveDirectory == 0) -> FALSE ++? if (control:IMS-ActiveDirectory == 0) -> FALSE ++? if (control:IMS-Timeout < 0) ? Evaluating (control:IMS-Timeout < 0) -> FALSE ++? if (control:IMS-Timeout < 0) -> FALSE ++? elsif (control:IMS-Timeout > 0) ? Evaluating (control:IMS-Timeout > 0) -> FALSE ++? elsif (control:IMS-Timeout > 0) -> FALSE ++? if (control:IMS-Data < 0) ? Evaluating (control:IMS-Data < 0) -> FALSE ++? if (control:IMS-Data < 0) -> FALSE ++? if (control:IMS-Data > 0) ? Evaluating (control:IMS-Data > 0) -> TRUE ++? if (control:IMS-Data > 0) -> TRUE ++- entering if (control:IMS-Data > 0) {...} expand: %{control:IMS-Data} -> 1048576 +++[reply] returns noop ++- if (control:IMS-Data > 0) returns noop ++? if (control:IMS-UserData < 0) ? Evaluating (control:IMS-UserData < 0) -> FALSE ++? if (control:IMS-UserData < 0) -> FALSE ++? if (control:IMS-UserData > 0) ? Evaluating (control:IMS-UserData > 0) -> FALSE ++? if (control:IMS-UserData > 0) -> FALSE ++[reply] returns noop } # server ims Sending Access-Accept of id 79 to 127.0.0.1 port 51340 Trapeze-Qos-Profile = "MB100" Mikrotik-Total-Limit = 1048576 Acct-Interim-Interval = 120 # Executing section pre-proxy from file /etc/freeradius/sites-enabled/ims +- entering group pre-proxy {...} [detail] expand: /var/log/freeradius/radacct/%{Client-IP-Address}/detail-%Y%m%d -> /var/log/freeradius/radacct/127.0.0.1/detail-20130501 [detail] /var/log/freeradius/radacct/%{Client-IP-Address}/detail-%Y%m%d expands to /var/log/freeradius/radacct/127.0.0.1/detail-20130501 [detail] expand: %t -> Wed May 1 09:58:20 2013 ++[detail] returns ok Sending CoA-Request of id 91 to 172.16.255.35 port 3799 Calling-Station-Id = "04:54:53:85:ca:82" NAS-IP-Address = 172.16.255.35 Trapeze-COA-Replace-Username = "10269783" Filter-Id = "MB100" Finished request 3. Going to the next request Waking up in 2.4 seconds. rad_recv: CoA-ACK packet from host 172.16.255.35 port 3799, id=91, length=26 Event-Timestamp = "May 1 2013 09:58:34 SAST" # Executing section post-proxy from file /etc/freeradius/sites-enabled/ims +- entering group post-proxy {...} [detail] expand: /var/log/freeradius/radacct/%{Client-IP-Address}/detail-%Y%m%d -> /var/log/freeradius/radacct/127.0.0.1/detail-20130501 [detail] /var/log/freeradius/radacct/%{Client-IP-Address}/detail-%Y%m%d expands to /var/log/freeradius/radacct/127.0.0.1/detail-20130501 [detail] expand: %t -> Wed May 1 09:58:20 2013 ++[detail] returns ok server ims { } # server ims Finished request 3. Going to the next request Waking up in 4.9 seconds. rad_recv: Accounting-Request packet from host 172.16.255.35 port 20000, id=200, length=244 Acct-Status-Type = Start Acct-Multi-Session-Id = "SESS-464-72c952-395089-4201e" Acct-Session-Id = "SESS-464-72c952-395089-4201e" User-Name = "10269783" Event-Timestamp = "May 1 2013 09:58:34 SAST" Trapeze-VLAN-Name = "DataA" Calling-Station-Id = "04-54-53-85-CA-82" NAS-Port-Id = "AP13/2" Called-Station-Id = "AC-4B-C8-02-23-41:BTC HOTSPOT - FAIRGROUND" Trapeze-Attr-19 = 0x69706164 Trapeze-Attr-21 = 0x696f73 NAS-Port = 464 Framed-IP-Address = 172.16.100.18 NAS-Port-Type = Wireless-802.11 NAS-IP-Address = 172.16.255.35 NAS-Identifier = "XON" Acct-Delay-Time = 0 WARNING: Empty preacct section. Using default return values. WARNING: Empty accounting section. Using default return values. Finished request 4. Cleaning up request 4 ID 200 with timestamp +47 Going to the next request Waking up in 4.9 seconds. Cleaning up request 3 ID 79 with timestamp +47 rad_recv: Accounting-Request packet from host 172.16.255.35 port 20000, id=201, length=244 Acct-Status-Type = Start Acct-Multi-Session-Id = "SESS-464-72c952-395089-4201e" Acct-Session-Id = "SESS-464-72c952-395089-4201e" User-Name = "10269783" Event-Timestamp = "May 1 2013 09:58:34 SAST" Trapeze-VLAN-Name = "DataA" Calling-Station-Id = "04-54-53-85-CA-82" NAS-Port-Id = "AP13/2" Called-Station-Id = "AC-4B-C8-02-23-41:BTC HOTSPOT - FAIRGROUND" Trapeze-Attr-19 = 0x69706164 Trapeze-Attr-21 = 0x696f73 NAS-Port = 464 Framed-IP-Address = 172.16.100.18 NAS-Port-Type = Wireless-802.11 NAS-IP-Address = 172.16.255.35 NAS-Identifier = "XON" Acct-Delay-Time = 5 WARNING: Empty preacct section. Using default return values. WARNING: Empty accounting section. Using default return values. Finished request 5. Cleaning up request 5 ID 201 with timestamp +52 Going to the next request Ready to process requests. rad_recv: Accounting-Request packet from host 172.16.255.35 port 20000, id=202, length=244 Acct-Status-Type = Start Acct-Multi-Session-Id = "SESS-464-72c952-395089-4201e" Acct-Session-Id = "SESS-464-72c952-395089-4201e" User-Name = "10269783" Event-Timestamp = "May 1 2013 09:58:34 SAST" Trapeze-VLAN-Name = "DataA" Calling-Station-Id = "04-54-53-85-CA-82" NAS-Port-Id = "AP13/2" Called-Station-Id = "AC-4B-C8-02-23-41:BTC HOTSPOT - FAIRGROUND" Trapeze-Attr-19 = 0x69706164 Trapeze-Attr-21 = 0x696f73 NAS-Port = 464 Framed-IP-Address = 172.16.100.18 NAS-Port-Type = Wireless-802.11 NAS-IP-Address = 172.16.255.35 NAS-Identifier = "XON" Acct-Delay-Time = 10 WARNING: Empty preacct section. Using default return values. WARNING: Empty accounting section. Using default return values. Finished request 6. Cleaning up request 6 ID 202 with timestamp +57 Going to the next request Ready to process requests. rad_recv: Accounting-Request packet from host 172.16.255.35 port 20000, id=203, length=274 Acct-Status-Type = Stop Acct-Multi-Session-Id = "SESS-464-72c952-395089-4201e" Acct-Session-Id = "SESS-464-72c952-395089-4201e" User-Name = "10269783" Event-Timestamp = "May 1 2013 10:03:16 SAST" Trapeze-VLAN-Name = "DataA" Calling-Station-Id = "04-54-53-85-CA-82" NAS-Port-Id = "AP13/2" Called-Station-Id = "AC-4B-C8-02-23-41:BTC HOTSPOT - FAIRGROUND" Trapeze-Attr-19 = 0x69706164 Trapeze-Attr-21 = 0x696f73 NAS-Port = 464 Framed-IP-Address = 172.16.100.18 NAS-Identifier = "XON" Acct-Session-Time = 282 Acct-Output-Octets = 58993 Acct-Input-Octets = 35737 Acct-Output-Packets = 177 Acct-Input-Packets = 393 NAS-Port-Type = Wireless-802.11 NAS-IP-Address = 172.16.255.35 Acct-Delay-Time = 0 WARNING: Empty preacct section. Using default return values. WARNING: Empty accounting section. Using default return values. Finished request 7. Cleaning up request 7 ID 203 with timestamp +329 Going to the next request Ready to process requests. rad_recv: Accounting-Request packet from host 172.16.255.35 port 20000, id=204, length=274 Acct-Status-Type = Stop Acct-Multi-Session-Id = "SESS-464-72c952-395089-4201e" Acct-Session-Id = "SESS-464-72c952-395089-4201e" User-Name = "10269783" Event-Timestamp = "May 1 2013 10:03:16 SAST" Trapeze-VLAN-Name = "DataA" Calling-Station-Id = "04-54-53-85-CA-82" NAS-Port-Id = "AP13/2" Called-Station-Id = "AC-4B-C8-02-23-41:BTC HOTSPOT - FAIRGROUND" Trapeze-Attr-19 = 0x69706164 Trapeze-Attr-21 = 0x696f73 NAS-Port = 464 Framed-IP-Address = 172.16.100.18 NAS-Identifier = "XON" Acct-Session-Time = 282 Acct-Output-Octets = 58993 Acct-Input-Octets = 35737 Acct-Output-Packets = 177 Acct-Input-Packets = 393 NAS-Port-Type = Wireless-802.11 NAS-IP-Address = 172.16.255.35 Acct-Delay-Time = 5 WARNING: Empty preacct section. Using default return values. WARNING: Empty accounting section. Using default return values. Finished request 8. Cleaning up request 8 ID 204 with timestamp +334 Going to the next request Ready to process requests. rad_recv: Accounting-Request packet from host 172.16.255.35 port 20000, id=205, length=274 Acct-Status-Type = Stop Acct-Multi-Session-Id = "SESS-464-72c952-395089-4201e" Acct-Session-Id = "SESS-464-72c952-395089-4201e" User-Name = "10269783" Event-Timestamp = "May 1 2013 10:03:16 SAST" Trapeze-VLAN-Name = "DataA" Calling-Station-Id = "04-54-53-85-CA-82" NAS-Port-Id = "AP13/2" Called-Station-Id = "AC-4B-C8-02-23-41:BTC HOTSPOT - FAIRGROUND" Trapeze-Attr-19 = 0x69706164 Trapeze-Attr-21 = 0x696f73 NAS-Port = 464 Framed-IP-Address = 172.16.100.18 NAS-Identifier = "XON" Acct-Session-Time = 282 Acct-Output-Octets = 58993 Acct-Input-Octets = 35737 Acct-Output-Packets = 177 Acct-Input-Packets = 393 NAS-Port-Type = Wireless-802.11 NAS-IP-Address = 172.16.255.35 Acct-Delay-Time = 10 WARNING: Empty preacct section. Using default return values. WARNING: Empty accounting section. Using default return values. Finished request 9. Cleaning up request 9 ID 205 with timestamp +339 Going to the next request Ready to process requests.
Ok, so the problem lies somewhere in the originate-coa file. If I remove that file from the sites-enable accounting-messages are handled fine. But if I don't have that defined I get this error when trying to send CoA Wed May 1 12:39:03 2013 : Info: WARNING: Unknown destination 172.16.255.35:3799 for CoA request. Can anyone tell me how I can both send a CoA to a NAS and process the accounting-start/accounting-stop packet? On Wed, May 1, 2013 at 10:10 AM, Tyller D <tyllerd@gmail.com> wrote:
Hi All,
I'm having a problem that I can't find a solution to.
The process I'm using is as follows. User connects to landing page, landing page sends access-request to server with users details. FreeRADIUS then sends a COA to the NAS to change the state and apply attributes. However when FreeRADIUS gets the accounting-start packet, it does nothing with it. Can someone please tell me how I can log this normally in radacct table? In my accounting section i have accounting { sql }
sql_xlat finished rlm_sql (sql): Released sql socket id: 4 expand: %{sql:SELECT IFNULL((SELECT IF(ims.vouchers.`data`= 0, 0,IF((ims.vouchers.`data` - (SUM(radius.radacct.acctinputoctets)+SUM(radius.radacct.acctoutputoctets))) < 0,-1, ims.vouchers.`data` - (SUM(radius.radacct.acctinputoctets)+SUM(radius.radacct.acctoutputoctets)))) AS voucherdata FROM radius.radacct,ims.vouchers WHERE radius.radacct.username='%{request:User-Name}' AND radius.radacct.username = ims.vouchers.voucher AND radius.radacct.acctterminatecause<>'Hotspot Restart'),(SELECT ims.vouchers.`data` FROM ims.vouchers WHERE ims.vouchers.voucher='%{request:User-Name}')) as voucherdata} -> 1048576 ++[control] returns noop sql_xlat expand: %{User-Name} -> 10269783 sql_set_user escaped user --> '10269783' expand: SELECT IFNULL((SELECT IF(ims.user_account.`data`= 0, 0,IF((ims.user_account.`data` - (SUM(radius.radacct.acctinputoctets)+SUM(radius.radacct.acctoutputoctets))) < 0,-1, ims.user_account.`data` - (SUM(radius.radacct.acctinputoctets)+SUM(radius.radacct.acctoutputoctets)))) AS voucherdata FROM radius.radacct,ims.user_account WHERE radius.radacct.username='%{request:User-Name}' AND radius.radacct.username = ims.user_account.username AND radius.radacct.acctterminatecause<>'Hotspot Restart'),(SELECT ims.user_account.`data` FROM ims.user_account WHERE ims.user_account.username='%{request:User-Name}')) as voucherdata -> SELECT IFNULL((SELECT IF(ims.user_account.`data`= 0, 0,IF((ims.user_account.`data` - (SUM(radius.radacct.acctinputoctets)+SUM(radius.radacct.acctoutputoctets))) < 0,-1, ims.user_account.`data` - (SUM(radius.radacct.acctinputoctets)+SUM(radius.radacct.acctoutputoctets)))) AS voucherdata FROM radius.radacct,ims.user_account WHERE radius.radacct.username='10269783' AND radius.radacct.username = rlm_sql (sql): Reserving sql socket id: 3 row[0] returned NULL rlm_sql (sql): Released sql socket id: 3 expand: %{sql:SELECT IFNULL((SELECT IF(ims.user_account.`data`= 0, 0,IF((ims.user_account.`data` - (SUM(radius.radacct.acctinputoctets)+SUM(radius.radacct.acctoutputoctets))) < 0,-1, ims.user_account.`data` - (SUM(radius.radacct.acctinputoctets)+SUM(radius.radacct.acctoutputoctets)))) AS voucherdata FROM radius.radacct,ims.user_account WHERE radius.radacct.username='%{request:User-Name}' AND radius.radacct.username = ims.user_account.username AND radius.radacct.acctterminatecause<>'Hotspot Restart'),(SELECT ims.user_account.`data` FROM ims.user_account WHERE ims.user_account.username='%{request:User-Name}')) as voucherdata} -> ++[control] returns noop ++? if (control:IMS-ActiveDirectory == 0) ? Evaluating (control:IMS-ActiveDirectory == 0) -> FALSE ++? if (control:IMS-ActiveDirectory == 0) -> FALSE ++? if (control:IMS-Timeout < 0) ? Evaluating (control:IMS-Timeout < 0) -> FALSE ++? if (control:IMS-Timeout < 0) -> FALSE ++? elsif (control:IMS-Timeout > 0) ? Evaluating (control:IMS-Timeout > 0) -> FALSE ++? elsif (control:IMS-Timeout > 0) -> FALSE ++? if (control:IMS-Data < 0) ? Evaluating (control:IMS-Data < 0) -> FALSE ++? if (control:IMS-Data < 0) -> FALSE ++? if (control:IMS-Data > 0) ? Evaluating (control:IMS-Data > 0) -> TRUE ++? if (control:IMS-Data > 0) -> TRUE ++- entering if (control:IMS-Data > 0) {...} expand: %{control:IMS-Data} -> 1048576 +++[reply] returns noop ++- if (control:IMS-Data > 0) returns noop ++? if (control:IMS-UserData < 0) ? Evaluating (control:IMS-UserData < 0) -> FALSE ++? if (control:IMS-UserData < 0) -> FALSE ++? if (control:IMS-UserData > 0) ? Evaluating (control:IMS-UserData > 0) -> FALSE ++? if (control:IMS-UserData > 0) -> FALSE ++[reply] returns noop } # server ims Sending Access-Accept of id 79 to 127.0.0.1 port 51340 Trapeze-Qos-Profile = "MB100" Mikrotik-Total-Limit = 1048576 Acct-Interim-Interval = 120 # Executing section pre-proxy from file /etc/freeradius/sites-enabled/ims +- entering group pre-proxy {...} [detail] expand: /var/log/freeradius/radacct/%{Client-IP-Address}/detail-%Y%m%d -> /var/log/freeradius/radacct/127.0.0.1/detail-20130501 [detail] /var/log/freeradius/radacct/%{Client-IP-Address}/detail-%Y%m%d expands to /var/log/freeradius/radacct/127.0.0.1/detail-20130501 [detail] expand: %t -> Wed May 1 09:58:20 2013 ++[detail] returns ok Sending CoA-Request of id 91 to 172.16.255.35 port 3799 Calling-Station-Id = "04:54:53:85:ca:82" NAS-IP-Address = 172.16.255.35 Trapeze-COA-Replace-Username = "10269783" Filter-Id = "MB100" Finished request 3. Going to the next request Waking up in 2.4 seconds. rad_recv: CoA-ACK packet from host 172.16.255.35 port 3799, id=91, length=26 Event-Timestamp = "May 1 2013 09:58:34 SAST" # Executing section post-proxy from file /etc/freeradius/sites-enabled/ims +- entering group post-proxy {...} [detail] expand: /var/log/freeradius/radacct/%{Client-IP-Address}/detail-%Y%m%d -> /var/log/freeradius/radacct/127.0.0.1/detail-20130501 [detail] /var/log/freeradius/radacct/%{Client-IP-Address}/detail-%Y%m%d expands to /var/log/freeradius/radacct/127.0.0.1/detail-20130501 [detail] expand: %t -> Wed May 1 09:58:20 2013 ++[detail] returns ok server ims { } # server ims Finished request 3. Going to the next request Waking up in 4.9 seconds. rad_recv: Accounting-Request packet from host 172.16.255.35 port 20000, id=200, length=244 Acct-Status-Type = Start Acct-Multi-Session-Id = "SESS-464-72c952-395089-4201e" Acct-Session-Id = "SESS-464-72c952-395089-4201e" User-Name = "10269783" Event-Timestamp = "May 1 2013 09:58:34 SAST" Trapeze-VLAN-Name = "DataA" Calling-Station-Id = "04-54-53-85-CA-82" NAS-Port-Id = "AP13/2" Called-Station-Id = "AC-4B-C8-02-23-41:BTC HOTSPOT - FAIRGROUND" Trapeze-Attr-19 = 0x69706164 Trapeze-Attr-21 = 0x696f73 NAS-Port = 464 Framed-IP-Address = 172.16.100.18 NAS-Port-Type = Wireless-802.11 NAS-IP-Address = 172.16.255.35 NAS-Identifier = "XON" Acct-Delay-Time = 0 WARNING: Empty preacct section. Using default return values. WARNING: Empty accounting section. Using default return values. Finished request 4. Cleaning up request 4 ID 200 with timestamp +47 Going to the next request Waking up in 4.9 seconds. Cleaning up request 3 ID 79 with timestamp +47 rad_recv: Accounting-Request packet from host 172.16.255.35 port 20000, id=201, length=244 Acct-Status-Type = Start Acct-Multi-Session-Id = "SESS-464-72c952-395089-4201e" Acct-Session-Id = "SESS-464-72c952-395089-4201e" User-Name = "10269783" Event-Timestamp = "May 1 2013 09:58:34 SAST" Trapeze-VLAN-Name = "DataA" Calling-Station-Id = "04-54-53-85-CA-82" NAS-Port-Id = "AP13/2" Called-Station-Id = "AC-4B-C8-02-23-41:BTC HOTSPOT - FAIRGROUND" Trapeze-Attr-19 = 0x69706164 Trapeze-Attr-21 = 0x696f73 NAS-Port = 464 Framed-IP-Address = 172.16.100.18 NAS-Port-Type = Wireless-802.11 NAS-IP-Address = 172.16.255.35 NAS-Identifier = "XON" Acct-Delay-Time = 5 WARNING: Empty preacct section. Using default return values. WARNING: Empty accounting section. Using default return values. Finished request 5. Cleaning up request 5 ID 201 with timestamp +52 Going to the next request Ready to process requests. rad_recv: Accounting-Request packet from host 172.16.255.35 port 20000, id=202, length=244 Acct-Status-Type = Start Acct-Multi-Session-Id = "SESS-464-72c952-395089-4201e" Acct-Session-Id = "SESS-464-72c952-395089-4201e" User-Name = "10269783" Event-Timestamp = "May 1 2013 09:58:34 SAST" Trapeze-VLAN-Name = "DataA" Calling-Station-Id = "04-54-53-85-CA-82" NAS-Port-Id = "AP13/2" Called-Station-Id = "AC-4B-C8-02-23-41:BTC HOTSPOT - FAIRGROUND" Trapeze-Attr-19 = 0x69706164 Trapeze-Attr-21 = 0x696f73 NAS-Port = 464 Framed-IP-Address = 172.16.100.18 NAS-Port-Type = Wireless-802.11 NAS-IP-Address = 172.16.255.35 NAS-Identifier = "XON" Acct-Delay-Time = 10 WARNING: Empty preacct section. Using default return values. WARNING: Empty accounting section. Using default return values. Finished request 6. Cleaning up request 6 ID 202 with timestamp +57 Going to the next request Ready to process requests. rad_recv: Accounting-Request packet from host 172.16.255.35 port 20000, id=203, length=274 Acct-Status-Type = Stop Acct-Multi-Session-Id = "SESS-464-72c952-395089-4201e" Acct-Session-Id = "SESS-464-72c952-395089-4201e" User-Name = "10269783" Event-Timestamp = "May 1 2013 10:03:16 SAST" Trapeze-VLAN-Name = "DataA" Calling-Station-Id = "04-54-53-85-CA-82" NAS-Port-Id = "AP13/2" Called-Station-Id = "AC-4B-C8-02-23-41:BTC HOTSPOT - FAIRGROUND" Trapeze-Attr-19 = 0x69706164 Trapeze-Attr-21 = 0x696f73 NAS-Port = 464 Framed-IP-Address = 172.16.100.18 NAS-Identifier = "XON" Acct-Session-Time = 282 Acct-Output-Octets = 58993 Acct-Input-Octets = 35737 Acct-Output-Packets = 177 Acct-Input-Packets = 393 NAS-Port-Type = Wireless-802.11 NAS-IP-Address = 172.16.255.35 Acct-Delay-Time = 0 WARNING: Empty preacct section. Using default return values. WARNING: Empty accounting section. Using default return values. Finished request 7. Cleaning up request 7 ID 203 with timestamp +329 Going to the next request Ready to process requests. rad_recv: Accounting-Request packet from host 172.16.255.35 port 20000, id=204, length=274 Acct-Status-Type = Stop Acct-Multi-Session-Id = "SESS-464-72c952-395089-4201e" Acct-Session-Id = "SESS-464-72c952-395089-4201e" User-Name = "10269783" Event-Timestamp = "May 1 2013 10:03:16 SAST" Trapeze-VLAN-Name = "DataA" Calling-Station-Id = "04-54-53-85-CA-82" NAS-Port-Id = "AP13/2" Called-Station-Id = "AC-4B-C8-02-23-41:BTC HOTSPOT - FAIRGROUND" Trapeze-Attr-19 = 0x69706164 Trapeze-Attr-21 = 0x696f73 NAS-Port = 464 Framed-IP-Address = 172.16.100.18 NAS-Identifier = "XON" Acct-Session-Time = 282 Acct-Output-Octets = 58993 Acct-Input-Octets = 35737 Acct-Output-Packets = 177 Acct-Input-Packets = 393 NAS-Port-Type = Wireless-802.11 NAS-IP-Address = 172.16.255.35 Acct-Delay-Time = 5 WARNING: Empty preacct section. Using default return values. WARNING: Empty accounting section. Using default return values. Finished request 8. Cleaning up request 8 ID 204 with timestamp +334 Going to the next request Ready to process requests. rad_recv: Accounting-Request packet from host 172.16.255.35 port 20000, id=205, length=274 Acct-Status-Type = Stop Acct-Multi-Session-Id = "SESS-464-72c952-395089-4201e" Acct-Session-Id = "SESS-464-72c952-395089-4201e" User-Name = "10269783" Event-Timestamp = "May 1 2013 10:03:16 SAST" Trapeze-VLAN-Name = "DataA" Calling-Station-Id = "04-54-53-85-CA-82" NAS-Port-Id = "AP13/2" Called-Station-Id = "AC-4B-C8-02-23-41:BTC HOTSPOT - FAIRGROUND" Trapeze-Attr-19 = 0x69706164 Trapeze-Attr-21 = 0x696f73 NAS-Port = 464 Framed-IP-Address = 172.16.100.18 NAS-Identifier = "XON" Acct-Session-Time = 282 Acct-Output-Octets = 58993 Acct-Input-Octets = 35737 Acct-Output-Packets = 177 Acct-Input-Packets = 393 NAS-Port-Type = Wireless-802.11 NAS-IP-Address = 172.16.255.35 Acct-Delay-Time = 10 WARNING: Empty preacct section. Using default return values. WARNING: Empty accounting section. Using default return values. Finished request 9. Cleaning up request 9 ID 205 with timestamp +339 Going to the next request Ready to process requests.
Tyller D wrote:
The process I'm using is as follows. User connects to landing page, landing page sends access-request to server with users details. FreeRADIUS then sends a COA to the NAS to change the state and apply attributes. However when FreeRADIUS gets the accounting-start packet, it does nothing with it. Can someone please tell me how I can log this normally in radacct table? In my accounting section i have accounting { sql }
So... you butchered the configuration files, and now are wondering why it doesn't work.
rad_recv: Accounting-Request packet from host 172.16.255.35 port 20000, id=200, length=244 Acct-Status-Type = Start Acct-Multi-Session-Id = "SESS-464-72c952-395089-4201e" Acct-Session-Id = "SESS-464-72c952-395089-4201e" User-Name = "10269783" Event-Timestamp = "May 1 2013 09:58:34 SAST" Trapeze-VLAN-Name = "DataA" Calling-Station-Id = "04-54-53-85-CA-82" NAS-Port-Id = "AP13/2" Called-Station-Id = "AC-4B-C8-02-23-41:BTC HOTSPOT - FAIRGROUND" Trapeze-Attr-19 = 0x69706164 Trapeze-Attr-21 = 0x696f73 NAS-Port = 464 Framed-IP-Address = 172.16.100.18 NAS-Port-Type = Wireless-802.11 NAS-IP-Address = 172.16.255.35 NAS-Identifier = "XON" Acct-Delay-Time = 0 WARNING: Empty preacct section. Using default return values. WARNING: Empty accounting section. Using default return values.
Maybe that's a hint. The entire point of the debug output is to READ IT. It's not rocket science. There's a bunch of stuff, followed by WARNING ARE YOU SURE THIS IS RIGHT Which may be a message you want to read and think about. My suggestion is this: 1) don't butcher the default configurations. It's clear you don't know what they do, but you destroyed them anyways 2) do use the default examples, with only minor edits. Use the method suggested in "man radiusd". It's really very simple 3) read the debug output. Look for WARNING or ERROR. It's that easy Alan DeKok.
participants (2)
-
Alan DeKok -
Tyller D