Hi, I have configuring a new FreeRadius 3.0.6 on Centos7 and MariaDB. Is has been working ok (had to increase max connextion and other values) but now I'm getting the radius down every time. MariaDB has radacct with over 10.000.000 rows. I'm connecting 10.000 PPTP users authentication with this Radius, Interim every 30seconds and client-pptp-session 10minutes, but after start mariadb and freeradius exits with this message: [root@rad ~]# systemctl status radiusd radiusd.service - FreeRADIUS high performance RADIUS server. Loaded: loaded (/usr/lib/systemd/system/radiusd.service; disabled) Active: failed (Result: signal) since mar 2015-10-27 22:41:14 CET; 17min ago Process: 12086 ExecStart=/usr/sbin/radiusd -d /etc/raddb (code=exited, status=0/SUCCESS) Process: 12083 ExecStartPre=/usr/sbin/radiusd -C (code=exited, status=0/SUCCESS) Process: 12080 ExecStartPre=/bin/chown -R radiusd.radiusd /var/run/radiusd (code=exited, status=0/SUCCESS) Main PID: 12090 (code=killed, signal=ABRT) CGroup: /system.slice/radiusd.service oct 27 22:36:16 rad.aaa.com systemd[1]: Starting FreeRADIUS high performance RADIUS server.... oct 27 22:36:17 rad.aaa.com systemd[1]: Started FreeRADIUS high performance RADIUS server.. oct 27 22:41:14 rad.aaa.com systemd[1]: radiusd.service: main process exited, code=killed, status=6/ABRT oct 27 22:41:14 rad.aaa.com systemd[1]: Unit radiusd.service entered failed state. Last Lines from radius.log Tue Oct 27 23:14:20 2015 : ERROR: (73758) ERROR: <queue> : Received conflicting packet from client 0.0.0.0/0 port 53359 - ID: 220 due to unfinished request. Giving up on old request. Tue Oct 27 23:14:20 2015 : ERROR: (73736) ERROR: detail : Received conflicting packet from client 0.0.0.0/0 port 48163 - ID: 146 due to unfinished request. Giving up on old request. Tue Oct 27 23:14:20 2015 : ERROR: (73737) ERROR: detail : Received conflicting packet from client 0.0.0.0/0 port 59445 - ID: 144 due to unfinished request. Giving up on old request. Tue Oct 27 23:14:20 2015 : Warning: No such configuration item .type..query Tue Oct 27 23:14:20 2015 : Warning: No such configuration item .type..query Tue Oct 27 23:14:20 2015 : ERROR: (73751) ERROR: <queue> : Received conflicting packet from client 0.0.0.0/0 port 33445 - ID: 148 due to unfinished request. Giving up on old request. Tue Oct 27 23:14:20 2015 : ERROR: (73757) ERROR: <queue> : Received conflicting packet from client 0.0.0.0/0 port 53686 - ID: 147 due to unfinished request. Giving up on old request. Tue Oct 27 23:14:20 2015 : Warning: No such configuration item .type..query Tue Oct 27 23:14:20 2015 : ERROR: (73752) ERROR: detail : Received conflicting packet from client 0.0.0.0/0 port 43723 - ID: 144 due to unfinished request. Giving up on old request. Tue Oct 27 23:14:20 2015 : ERROR: (73753) ERROR: sql : Received conflicting packet from client 0.0.0.0/0 port 44422 - ID: 145 due to unfinished request. Giving up on old request. Also I have all this warnings/errors on log. What is really important to fix and how ??? 1) START RADIUS Tue Oct 27 22:36:17 2015 : Warning: No 'ipaddr' or 'ipv4addr' or 'ipv6addr' field found in client 0.0.0.0/0. Please fix your configuration Tue Oct 27 22:36:17 2015 : Warning: Support for old-style clients will be removed in a future release Tue Oct 27 22:36:17 2015 : Info: rlm_sql (sql): Driver rlm_sql_mysql (module rlm_sql_mysql) loaded and linked Tue Oct 27 22:36:17 2015 : Info: rlm_sql (sql): Attempting to connect to database "radius" Tue Oct 27 22:36:17 2015 : Info: Loaded virtual server <default> Tue Oct 27 22:36:17 2015 : Warning: Ignoring "ldap" (see raddb/mods-available/README.rst) Tue Oct 27 22:36:17 2015 : Info: Loaded virtual server default Tue Oct 27 22:36:17 2015 : Info: Loaded virtual server inner-tunnel Tue Oct 27 22:36:17 2015 : Warning: No 'ipaddr' or 'ipv4addr' or 'ipv6addr' field found in client 0.0.0.0/0. Please fix your configuration Tue Oct 27 22:36:17 2015 : Warning: Support for old-style clients will be removed in a future release Tue Oct 27 22:36:17 2015 : Info: rlm_sql (sql): Driver rlm_sql_mysql (module rlm_sql_mysql) loaded and linked Tue Oct 27 22:36:17 2015 : Info: rlm_sql (sql): Attempting to connect to database "radius" Tue Oct 27 22:36:17 2015 : Info: rlm_sql (sql): Opening additional connection (0) Tue Oct 27 22:36:17 2015 : Info: Loaded virtual server <default> Tue Oct 27 22:36:17 2015 : Warning: Ignoring "ldap" (see raddb/mods-available/README.rst) Tue Oct 27 22:36:17 2015 : Info: Loaded virtual server default Tue Oct 27 22:36:17 2015 : Info: Loaded virtual server inner-tunnel Tue Oct 27 22:36:17 2015 : Info: Ready to process requests 2) Tue Oct 27 22:36:17 2015 : Warning: rlm_sql (sql): 1 of 1 connections in use. You probably need to increase "spare" Tue Oct 27 22:36:17 2015 : Info: rlm_sql (sql): Opening additional connection (1) Tue Oct 27 22:36:17 2015 : Warning: rlm_sql (sql): 2 of 2 connections in use. You probably need to increase "spare" Tue Oct 27 22:36:17 2015 : Info: rlm_sql (sql): Opening additional connection (2) Tue Oct 27 22:36:17 2015 : Warning: rlm_sql (sql): 3 of 3 connections in use. You probably need to increase "spare" Tue Oct 27 22:36:17 2015 : Info: rlm_sql (sql): Opening additional connection (3) Tue Oct 27 22:36:17 2015 : Info: rlm_sql (sql): 3 of 4 connections in use. Need more spares Tue Oct 27 22:36:17 2015 : Info: rlm_sql (sql): Opening additional connection (4) Tue Oct 27 22:36:17 2015 : Info: rlm_sql (sql): 2 of 4 connections in use. Need more spares 3) Tue Oct 27 22:36:51 2015 : ERROR: (4217) ERROR: sql : Received conflicting packet from client 0.0.0.0/0 port 39418 - ID: 59 due to unfinished request. Giving up on old request. Tue Oct 27 22:36:51 2015 : ERROR: (4220) ERROR: sql : Received conflicting packet from client 0.0.0.0/0 port 50628 - ID: 62 due to unfinished request. Giving up on old request. Tue Oct 27 22:36:51 2015 : ERROR: (4221) ERROR: sql : Received conflicting packet from client 0.0.0.0/0 port 55753 - ID: 63 due to unfinished request. Giving up on old request. Tue Oct 27 22:36:51 2015 : ERROR: (4224) ERROR: sql : Received conflicting packet from client 0.0.0.0/0 port 41959 - ID: 66 due to unfinished request. Giving up on old request. Tue Oct 27 22:36:51 2015 : ERROR: (4229) ERROR: sql : Received conflicting packet from client 0.0.0.0/0 port 57022 - ID: 71 due to unfinished request. Giving up on old request. Tue Oct 27 22:36:52 2015 : ERROR: (4260) ERROR: sql : Received conflicting packet from client 0.0.0.0/0 port 45267 - ID: 104 due to unfinished request. Giving up on old request. Tue Oct 27 22:36:52 2015 : ERROR: (4287) ERROR: sql : Received conflicting packet from client 0.0.0.0/0 port 47887 - ID: 120 due to unfinished request. Giving up on old request. Tue Oct 27 22:36:52 2015 : ERROR: (4292) ERROR: sql : Received conflicting packet from client 0.0.0.0/0 port 40463 - ID: 128 due to unfinished request. Giving up on old request. Tue Oct 27 22:36:52 2015 : ERROR: (4294) ERROR: sql : Received conflicting packet from client 0.0.0.0/0 port 44484 - ID: 129 due to unfinished request. Giving up on old request. Tue Oct 27 22:36:52 2015 : ERROR: (4303) ERROR: sql : Received conflicting packet from client 0.0.0.0/0 port 47015 - ID: 137 due to unfinished request. Giving up on old request. Tue Oct 27 22:36:52 2015 : ERROR: (4304) ERROR: sql : Received conflicting packet from client 0.0.0.0/0 port 48617 - ID: 138 due to unfinished request. Giving up on old request. 4) Tue Oct 27 22:36:54 2015 : Warning: No such configuration item .type..query Tue Oct 27 22:36:54 2015 : Warning: No such configuration item .type..query Tue Oct 27 22:36:54 2015 : Warning: No such configuration item .type..query Tue Oct 27 22:36:54 2015 : Warning: No such configuration item .type..query Tue Oct 27 22:36:54 2015 : Warning: No such configuration item .type..query Tue Oct 27 22:36:54 2015 : Warning: No such configuration item .type..query Tue Oct 27 22:36:54 2015 : Warning: No such configuration item .type..query Tue Oct 27 22:36:54 2015 : Warning: No such configuration item .type..query Tue Oct 27 22:36:54 2015 : Warning: No such configuration item .type..query Tue Oct 27 22:36:54 2015 : Warning: No such configuration item .type..query 5) Tue Oct 27 22:37:04 2015 : Error: (7162) Ignoring duplicate packet from client 0.0.0.0/0 port 47432 - ID: 116 due to unfinished request in component <core> module <queue> 6) Tue Oct 27 22:37:09 2015 : Error: rlm_sql (sql): Duplicate entry '30a1ada7fbf7328ec740200d6042f02b' for key 'acctuniqueid' Tue Oct 27 22:37:09 2015 : Error: rlm_sql_mysql: Cannot store result Tue Oct 27 22:37:09 2015 : Error: rlm_sql_mysql: MySQL error 'Duplicate entry '30a1ada7fbf7328ec740200d6042f02b' for key 'acctuniqueid'' Tue Oct 27 22:40:14 2015 : Error: rlm_sql (sql): Duplicate entry '51208897d76ba70d93d0a5d4486b3622' for key 'acctuniqueid' Tue Oct 27 22:40:14 2015 : Error: rlm_sql_mysql: Cannot store result Tue Oct 27 22:40:14 2015 : Error: rlm_sql_mysql: MySQL error 'Duplicate entry '51208897d76ba70d93d0a5d4486b3622' for key 'acctuniqueid'' Tue Oct 27 22:40:14 2015 : Error: rlm_sql (sql): Duplicate entry 'a2ccf69a14f3eb13105c3a5df8dcb81f' for key 'acctuniqueid' Tue Oct 27 22:40:14 2015 : Error: rlm_sql_mysql: Cannot store result Tue Oct 27 22:40:14 2015 : Error: rlm_sql_mysql: MySQL error 'Duplicate entry 'a2ccf69a14f3eb13105c3a5df8dcb81f' for key 'acctuniqueid'' Tue Oct 27 22:40:14 2015 : Error: rlm_sql (sql): Duplicate entry 'b92b5f282a678d6edfec278fc07a057a' for key 'acctuniqueid' Tue Oct 27 22:40:14 2015 : Error: rlm_sql_mysql: Cannot store result Tue Oct 27 22:40:14 2015 : Error: rlm_sql_mysql: MySQL error 'Duplicate entry 'b92b5f282a678d6edfec278fc07a057a' for key 'acctuniqueid'' Tue Oct 27 22:40:16 2015 : Error: rlm_sql (sql): Duplicate entry '4b8983776731b1f5da36b35a1a53d9fa' for key 'acctuniqueid' Tue Oct 27 22:40:16 2015 : Error: rlm_sql_mysql: Cannot store result Tue Oct 27 22:40:16 2015 : Error: rlm_sql_mysql: MySQL error 'Duplicate entry '4b8983776731b1f5da36b35a1a53d9fa' for key 'acctuniqueid'' Tue Oct 27 22:40:17 2015 : Error: rlm_sql (sql): Duplicate entry '61cb092a85b6a15acf5d79cfb60855d6' for key 'acctuniqueid' Tue Oct 27 22:40:17 2015 : Error: rlm_sql_mysql: Cannot store result Tue Oct 27 22:40:17 2015 : Error: rlm_sql_mysql: MySQL error 'Duplicate entry '61cb092a85b6a15acf5d79cfb60855d6' for key 'acctuniqueid'' Tue Oct 27 22:40:17 2015 : Error: rlm_sql (sql): Duplicate entry '39df97f43a022814b698ebfa18065f02' for key 'acctuniqueid' Tue Oct 27 22:40:17 2015 : Error: rlm_sql_mysql: Cannot store result Tue Oct 27 22:40:17 2015 : Error: rlm_sql_mysql: MySQL error 'Duplicate entry '39df97f43a022814b698ebfa18065f02' for key 'acctuniqueid'' Tue Oct 27 22:40:17 2015 : Error: rlm_sql (sql): Duplicate entry '370a69125a04214aae019cecdccac86d' for key 'acctuniqueid' Tue Oct 27 22:40:17 2015 : Error: rlm_sql_mysql: Cannot store result Tue Oct 27 22:40:17 2015 : Error: rlm_sql_mysql: MySQL error 'Duplicate entry '370a69125a04214aae019cecdccac86d' for key 'acctuniqueid'' Tue Oct 27 22:40:17 2015 : Error: rlm_sql (sql): Duplicate entry '78108b526c3d18d0fbb5c330fae5b770' for key 'acctuniqueid' Tue Oct 27 22:40:17 2015 : Error: rlm_sql_mysql: Cannot store result Tue Oct 27 22:40:17 2015 : Error: rlm_sql_mysql: MySQL error 'Duplicate entry '78108b526c3d18d0fbb5c330fae5b770' for key 'acctuniqueid'' Tue Oct 27 22:40:17 2015 : Error: rlm_sql (sql): Duplicate entry '337e085c9a8d7cde42499a130cb2d6fb' for key 'acctuniqueid' Tue Oct 27 22:40:17 2015 : Error: rlm_sql_mysql: Cannot store result 7) Tue Oct 27 22:38:36 2015 : Error: Unresponsive child for request 11202, in component <core> module Tue Oct 27 22:38:36 2015 : Error: Unresponsive child for request 11201, in component <core> module Tue Oct 27 22:38:36 2015 : Error: Unresponsive child for request 11199, in component <core> module Tue Oct 27 22:38:36 2015 : Error: Unresponsive child for request 11206, in component <core> module Tue Oct 27 22:38:36 2015 : Error: Unresponsive child for request 11205, in component <core> module Tue Oct 27 22:38:36 2015 : Error: Unresponsive child for request 11212, in component <core> module Thanks.
On Oct 27, 2015, at 6:50 PM, Oscar Jofre <oscar@jofre.com> wrote:
I have configuring a new FreeRadius 3.0.6 on Centos7 and MariaDB.
I would suggest 3.0.10. It has a lot of bugs fixed over 3.0.6.
Also I have all this warnings/errors on log. What is really important to fix and how ???
If they're warning messages, fix them. Error messages will cause the server to not start.
1) START RADIUS
Tue Oct 27 22:36:17 2015 : Warning: No 'ipaddr' or 'ipv4addr' or 'ipv6addr' field found in client 0.0.0.0/0. Please fix your configuration
What part of that message is unclear?
2)
Tue Oct 27 22:36:17 2015 : Warning: rlm_sql (sql): 1 of 1 connections in use. You probably need to increase "spare"
What part of that message us unclear?
3)
Tue Oct 27 22:36:51 2015 : ERROR: (4217) ERROR: sql : Received conflicting packet from client 0.0.0.0/0 port 39418 - ID: 59 due to unfinished request.
This happens because your database is slow. Fix it. It's not a FreeRADIUS problem.
4)
Tue Oct 27 22:36:54 2015 : Warning: No such configuration item .type..query
What part of that message is unclear? Find the configuration which has ".type.query", and fix it. Note that the default configuration does *not* have these errors. This problem is because of something you changed on your local system.\
5)
Tue Oct 27 22:37:04 2015 : Error: (7162) Ignoring duplicate packet from client 0.0.0.0/0 port 47432 - ID: 116 due to unfinished request in component <core> module <queue>
This is the same problem as #3.
6)
Tue Oct 27 22:37:09 2015 : Error: rlm_sql (sql): Duplicate entry '30a1ada7fbf7328ec740200d6042f02b' for key 'acctuniqueid' Tue Oct 27 22:37:09 2015 : Error: rlm_sql_mysql: Cannot store result Tue Oct 27 22:37:09 2015 : Error: rlm_sql_mysql: MySQL error 'Duplicate entry '30a1ada7fbf7328ec740200d6042f02b' for key 'acctuniqueid''
3.0.10 has updates to the queries which work around this issue.
7)
Tue Oct 27 22:38:36 2015 : Error: Unresponsive child for request 11202, in component <core> module Tue Oct 27 22:38:36 2015 : Error: Unresponsive child for request 11201, in component <core> module
This is probably the same issue as #3. Alan DeKok.
participants (2)
-
Alan DeKok -
Oscar Jofre