September 2011 - Freeradius-Users - lists.freeradius.org

Proxy(-like)+Cache configuration
by Lorenzo Milesi 19 Sep '11

19 Sep '11

hi. can I make a configuration where I have a radius server which authenticates over an external radius (basically a proxy), but caches the successful logins, so that known users won't get asked upstream (at least for a certain time)? I don't want to replicate the backend database. Thanks. -- Lorenzo Milesi - lorenzo.milesi(a)yetopen.it YetOpen S.r.l. - http://www.yetopen.it/ Via Carlo Torri Tarelli 19 - 23900 Lecco - ITALY - Tel 0341 220 205 - Fax 178 6070 222 GPG/PGP Key-Id: 0xE704E230 - http://keyserver.linux.it -------- D.Lgs. 196/2003 -------- Si avverte che tutte le informazioni contenute in questo messaggio sono riservate ed a uso esclusivo del destinatario. Nel caso in cui questo messaggio Le fosse pervenuto per errore, La invitiamo ad eliminarlo senza copiarlo, a non inoltrarlo a terzi e ad avvertirci non appena possibile. Grazie.

3 2

TWO NAS but NASIPAddress is 127.0.0.1 ?
by sekchel lee 19 Sep '11

19 Sep '11

client 127.0.0.1 { secret = test123 shortname = localhost nastype = other } client 175.222.xxx.xx { secret = test111 shortname = 175.222.xxx.xx } NAS localhost user select * from radippool where UserName='nas1user'; NASIPAddress=127.0.0.1 NAS 175.222.xxx.xx user select * from radippool where UserName='nas2user'; NASIPAddress=127.0.0.1

2 1

Dialup Admin
by shawky skaff 19 Sep '11

19 Sep '11

Hi, I am having issues viewing content on the dialup screen, I can see the html links, when I select one of them say acconuting I just receive a error saying DEBUG(SQL,MYSQL DRIVER): Connect: User=root,Password=**** I have allowed all sql options in site-enabled default file. Running radiusd -X gives me the following output [root@radius conf]# radiusd -X FreeRADIUS Version 2.1.7, for host i686-redhat-linux-gnu, built on Mar 31 2010 at 00:25:31 Copyright (C) 1999-2009 The FreeRADIUS server project and contributors. There is NO warranty; not even for MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. You may redistribute copies of FreeRADIUS under the terms of the GNU General Public License v2. Starting - reading configuration files ... including configuration file /etc/raddb/radiusd.conf including configuration file /etc/raddb/proxy.conf including configuration file /etc/raddb/clients.conf including files in directory /etc/raddb/modules/ including configuration file /etc/raddb/modules/counter including configuration file /etc/raddb/modules/etc_group including configuration file /etc/raddb/modules/attr_rewrite including configuration file /etc/raddb/modules/smbpasswd including configuration file /etc/raddb/modules/mschap including configuration file /etc/raddb/modules/logintime including configuration file /etc/raddb/modules/always including configuration file /etc/raddb/modules/ippool including configuration file /etc/raddb/modules/sql_log including configuration file /etc/raddb/modules/detail.log including configuration file /etc/raddb/modules/expiration including configuration file /etc/raddb/modules/echo including configuration file /etc/raddb/modules/checkval including configuration file /etc/raddb/modules/acct_unique including configuration file /etc/raddb/modules/sradutmp including configuration file /etc/raddb/modules/unix including configuration file /etc/raddb/modules/exec including configuration file /etc/raddb/modules/attr_filter including configuration file /etc/raddb/modules/wimax including configuration file /etc/raddb/modules/sqlcounter_expire_on_login including configuration file /etc/raddb/modules/perl including configuration file /etc/raddb/modules/preprocess including configuration file /etc/raddb/modules/pam including configuration file /etc/raddb/modules/files including configuration file /etc/raddb/modules/linelog including configuration file /etc/raddb/modules/expr including configuration file /etc/raddb/modules/otp including configuration file /etc/raddb/modules/inner-eap including configuration file /etc/raddb/modules/detail.example.com including configuration file /etc/raddb/modules/digest including configuration file /etc/raddb/modules/mac2ip including configuration file /etc/raddb/modules/realm including configuration file /etc/raddb/modules/radutmp including configuration file /etc/raddb/modules/detail including configuration file /etc/raddb/modules/cui including configuration file /etc/raddb/modules/smsotp including configuration file /etc/raddb/modules/mac2vlan including configuration file /etc/raddb/modules/chap including configuration file /etc/raddb/modules/passwd including configuration file /etc/raddb/modules/policy including configuration file /etc/raddb/modules/pap including configuration file /etc/raddb/eap.conf including configuration file /etc/raddb/sql.conf including configuration file /etc/raddb/sql/mysql/dialup.conf including configuration file /etc/raddb/policy.conf including files in directory /etc/raddb/sites-enabled/ including configuration file /etc/raddb/sites-enabled/inner-tunnel including configuration file /etc/raddb/sites-enabled/control-socket including configuration file /etc/raddb/sites-enabled/default group = radiusd user = radiusd including dictionary file /etc/raddb/dictionary main { prefix = "/usr" localstatedir = "/var" logdir = "/var/log/radius" libdir = "/usr/lib/freeradius" radacctdir = "/var/log/radius/radacct" hostname_lookups = no max_request_time = 30 cleanup_delay = 5 max_requests = 1024 allow_core_dumps = no pidfile = "/var/run/radiusd/radiusd.pid" checkrad = "/usr/sbin/checkrad" debug_level = 0 proxy_requests = yes log { stripped_names = no auth = no auth_badpass = no auth_goodpass = no } security { max_attributes = 200 reject_delay = 1 status_server = yes } } radiusd: #### Loading Realms and Home Servers #### proxy server { retry_delay = 5 retry_count = 3 default_fallback = no dead_time = 120 wake_all_if_all_dead = no } home_server localhost { ipaddr = 127.0.0.1 port = 1812 type = "auth" secret = "testing123" response_window = 20 max_outstanding = 65536 require_message_authenticator = no zombie_period = 40 status_check = "status-server" ping_interval = 30 check_interval = 30 num_answers_to_alive = 3 num_pings_to_alive = 3 revive_interval = 120 status_check_timeout = 4 irt = 2 mrt = 16 mrc = 5 mrd = 30 } home_server_pool my_auth_failover { type = fail-over home_server = localhost } realm example.com { auth_pool = my_auth_failover } realm LOCAL { } radiusd: #### Loading Clients #### client radiust { ipaddr = 27.34.225.33 require_message_authenticator = no secret = "testing123" nastype = "other" } radiusd: #### Instantiating modules #### instantiate { Module: Linked to module rlm_exec Module: Instantiating exec exec { wait = no input_pairs = "request" shell_escape = yes } Module: Linked to module rlm_expr Module: Instantiating expr Module: Linked to module rlm_expiration Module: Instantiating expiration expiration { reply-message = "Password Has Expired " } Module: Linked to module rlm_logintime Module: Instantiating logintime logintime { reply-message = "You are calling outside your allowed timespan " minimum-timeout = 60 } } radiusd: #### Loading Virtual Servers #### server inner-tunnel { modules { Module: Checking authenticate {...} for more modules to load Module: Linked to module rlm_pap Module: Instantiating pap pap { encryption_scheme = "auto" auto_header = no } Module: Linked to module rlm_chap Module: Instantiating chap Module: Linked to module rlm_mschap Module: Instantiating mschap mschap { use_mppe = yes require_encryption = no require_strong = no with_ntdomain_hack = no } Module: Linked to module rlm_unix Module: Instantiating unix unix { radwtmp = "/var/log/radius/radwtmp" } Module: Linked to module rlm_eap Module: Instantiating eap eap { default_eap_type = "md5" timer_expire = 60 ignore_unknown_eap_types = no cisco_accounting_username_bug = no max_sessions = 2048 } Module: Linked to sub-module rlm_eap_md5 Module: Instantiating eap-md5 Module: Linked to sub-module rlm_eap_leap Module: Instantiating eap-leap Module: Linked to sub-module rlm_eap_gtc Module: Instantiating eap-gtc gtc { challenge = "Password: " auth_type = "PAP" } Module: Linked to sub-module rlm_eap_tls Module: Instantiating eap-tls tls { rsa_key_exchange = no dh_key_exchange = yes rsa_key_length = 512 dh_key_length = 512 verify_depth = 0 pem_file_type = yes private_key_file = "/etc/raddb/certs/server.pem" certificate_file = "/etc/raddb/certs/server.pem" CA_file = "/etc/raddb/certs/ca.pem" private_key_password = "whatever" dh_file = "/etc/raddb/certs/dh" random_file = "/etc/raddb/certs/random" fragment_size = 1024 include_length = yes check_crl = no cipher_list = "DEFAULT" make_cert_command = "/etc/raddb/certs/bootstrap" cache { enable = no lifetime = 24 max_entries = 255 } } Module: Linked to sub-module rlm_eap_ttls Module: Instantiating eap-ttls ttls { default_eap_type = "md5" copy_request_to_tunnel = no use_tunneled_reply = no virtual_server = "inner-tunnel" include_length = yes } Module: Linked to sub-module rlm_eap_peap Module: Instantiating eap-peap peap { default_eap_type = "mschapv2" copy_request_to_tunnel = no use_tunneled_reply = no proxy_tunneled_request_as_eap = yes virtual_server = "inner-tunnel" } Module: Linked to sub-module rlm_eap_mschapv2 Module: Instantiating eap-mschapv2 mschapv2 { with_ntdomain_hack = no } Module: Checking authorize {...} for more modules to load Module: Linked to module rlm_realm Module: Instantiating suffix realm suffix { format = "suffix" delimiter = "@" ignore_default = no ignore_null = no } Module: Linked to module rlm_files Module: Instantiating files files { usersfile = "/etc/raddb/users" acctusersfile = "/etc/raddb/acct_users" preproxy_usersfile = "/etc/raddb/preproxy_users" compat = "no" } Module: Checking session {...} for more modules to load Module: Linked to module rlm_radutmp Module: Instantiating radutmp radutmp { filename = "/var/log/radius/radutmp" username = "%{User-Name}" case_sensitive = yes check_with_nas = yes perm = 384 callerid = yes } Module: Checking post-proxy {...} for more modules to load Module: Checking post-auth {...} for more modules to load Module: Linked to module rlm_attr_filter Module: Instantiating attr_filter.access_reject attr_filter attr_filter.access_reject { attrsfile = "/etc/raddb/attrs.access_reject" key = "%{User-Name}" } } # modules } # server server { modules { Module: Checking authenticate {...} for more modules to load Module: Checking authorize {...} for more modules to load Module: Linked to module rlm_preprocess Module: Instantiating preprocess preprocess { huntgroups = "/etc/raddb/huntgroups" hints = "/etc/raddb/hints" with_ascend_hack = no ascend_channels_per_line = 23 with_ntdomain_hack = no with_specialix_jetstream_hack = no with_cisco_vsa_hack = no with_alvarion_vsa_hack = no } Module: Linked to module rlm_sql Module: Instantiating sql sql { driver = "rlm_sql_mysql" server = "27.34.225.33" port = "" login = "root" password = "*****" radius_db = "radius" read_groups = yes sqltrace = no sqltracefile = "/var/log/radius/sqltrace.sql" readclients = no deletestalesessions = yes num_sql_socks = 5 lifetime = 0 max_queries = 0 sql_user_name = "%{User-Name}" default_user_profile = "" nas_query = "SELECT id, nasname, shortname, type, secret FROM nas" authorize_check_query = "SELECT id, username, attribute, value, op FROM radcheck WHERE username = '%{SQL-User-Name}' ORDER BY id" authorize_reply_query = "SELECT id, username, attribute, value, op FROM radreply WHERE username = '%{SQL-User-Name}' ORDER BY id" authorize_group_check_query = "SELECT id, groupname, attribute, Value, op FROM radgroupcheck WHERE groupname = '%{Sql-Group}' ORDER BY id" authorize_group_reply_query = "SELECT id, groupname, attribute, value, op FROM radgroupreply WHERE groupname = '%{Sql-Group}' ORDER BY id" accounting_onoff_query = " UPDATE radacct SET acctstoptime = '%S', acctsessiontime = unix_timestamp('%S') - unix_timestamp(acctstarttime), acctterminatecause = '%{Acct-Terminate-Cause}', acctstopdelay = %{%{Acct-Delay-Time}:-0} WHERE acctstoptime IS NULL AND nasipaddress = '%{NAS-IP-Address}' AND acctstarttime <= '%S'" accounting_update_query = " UPDATE radacct SET framedipaddress = '%{Framed-IP-Address}', acctsessiontime = '%{Acct-Session-Time}', acctinputoctets = '%{%{Acct-Input-Gigawords}:-0}' << 32 | '%{%{Acct-Input-Octets}:-0}', acctoutputoctets = '%{%{Acct-Output-Gigawords}:-0}' << 32 | '%{%{Acct-Output-Octets}:-0}' WHERE acctsessionid = '%{Acct-Session-Id}' AND username = '%{SQL-User-Name}' AND nasipaddress = '%{NAS-IP-Address}'" accounting_update_query_alt = " INSERT INTO radacct (acctsessionid, acctuniqueid, username, realm, nasipaddress, nasportid, nasporttype, acctstarttime, acctsessiontime, acctauthentic, connectinfo_start, acctinputoctets, acctoutputoctets, calledstationid, callingstationid, servicetype, framedprotocol, framedipaddress, acctstartdelay, xascendsessionsvrkey) VALUES ('%{Acct-Session-Id}', '%{Acct-Unique-Session-Id}', '%{SQL-User-Name}', '%{Realm}', '%{NAS-IP-Address}', '%{NAS-Port}', '%{NAS-Port-Type}', DATE_SUB('%S', INTERVAL (%{%{Acct-Session-Time}:-0} + %{%{Acct-Delay-Time}:-0}) SECOND), '%{Acct-Session-Time}', '%{Acct-Authentic}', '', '%{%{Acct-Input-Gigawords}:-0}' << 32 | '%{%{Acct-Input-Octets}:-0}', '%{%{Acct-Output-Gigawords}:-0}' << 32 | '%{%{Acct-Output-Octets}:-0}', '%{Called-Station-Id}', '%{Calling-Station-Id}', '%{Service-Type}', '%{Framed-Protocol}', '%{Framed-IP-Address}', '0', '%{X-Ascend-Session-Svr-Key}')" accounting_start_query = " INSERT INTO radacct (acctsessionid, acctuniqueid, username, realm, nasipaddress, nasportid, nasporttype, acctstarttime, acctstoptime, acctsessiontime, acctauthentic, connectinfo_start, connectinfo_stop, acctinputoctets, acctoutputoctets, calledstationid, callingstationid, acctterminatecause, servicetype, framedprotocol, framedipaddress, acctstartdelay, acctstopdelay, xascendsessionsvrkey) VALUES ('%{Acct-Session-Id}', '%{Acct-Unique-Session-Id}', '%{SQL-User-Name}', '%{Realm}', '%{NAS-IP-Address}', '%{NAS-Port}', '%{NAS-Port-Type}', '%S', NULL, '0', '%{Acct-Authentic}', '%{Connect-Info}', '', '0', '0', '%{Called-Station-Id}', '%{Calling-Station-Id}', '', '%{Service-Type}', '%{Framed-Protocol}', '%{Framed-IP-Address}', '%{%{Acct-Delay-Time}:-0}', '0', '%{X-Ascend-Session-Svr-Key}')" accounting_start_query_alt = " UPDATE radacct SET acctstarttime = '%S', acctstartdelay = '%{%{Acct-Delay-Time}:-0}', connectinfo_start = '%{Connect-Info}' WHERE acctsessionid = '%{Acct-Session-Id}' AND username = '%{SQL-User-Name}' AND nasipaddress = '%{NAS-IP-Address}'" accounting_stop_query = " UPDATE radacct SET acctstoptime = '%S', acctsessiontime = '%{Acct-Session-Time}', acctinputoctets = '%{%{Acct-Input-Gigawords}:-0}' << 32 | '%{%{Acct-Input-Octets}:-0}', acctoutputoctets = '%{%{Acct-Output-Gigawords}:-0}' << 32 | '%{%{Acct-Output-Octets}:-0}', acctterminatecause = '%{Acct-Terminate-Cause}', acctstopdelay = '%{%{Acct-Delay-Time}:-0}', connectinfo_stop = '%{Connect-Info}' WHERE acctsessionid = '%{Acct-Session-Id}' AND username = '%{SQL-User-Name}' AND nasipaddress = '%{NAS-IP-Address}'" accounting_stop_query_alt = " INSERT INTO radacct (acctsessionid, acctuniqueid, username, realm, nasipaddress, nasportid, nasporttype, acctstarttime, acctstoptime, acctsessiontime, acctauthentic, connectinfo_start, connectinfo_stop, acctinputoctets, acctoutputoctets, calledstationid, callingstationid, acctterminatecause, servicetype, framedprotocol, framedipaddress, acctstartdelay, acctstopdelay) VALUES ('%{Acct-Session-Id}', '%{Acct-Unique-Session-Id}', '%{SQL-User-Name}', '%{Realm}', '%{NAS-IP-Address}', '%{NAS-Port}', '%{NAS-Port-Type}', DATE_SUB('%S', INTERVAL (%{%{Acct-Session-Time}:-0} + %{%{Acct-Delay-Time}:-0}) SECOND), '%S', '%{Acct-Session-Time}', '%{Acct-Authentic}', '', '%{Connect-Info}', '%{%{Acct-Input-Gigawords}:-0}' << 32 | '%{%{Acct-Input-Octets}:-0}', '%{%{Acct-Output-Gigawords}:-0}' << 32 | '%{%{Acct-Output-Octets}:-0}', '%{Called-Station-Id}', '%{Calling-Station-Id}', '%{Acct-Terminate-Cause}', '%{Service-Type}', '%{Framed-Protocol}', '%{Framed-IP-Address}', '0', '%{%{Acct-Delay-Time}:-0}')" group_membership_query = "SELECT groupname FROM radusergroup WHERE username = '%{SQL-User-Name}' ORDER BY priority" connect_failure_retry_delay = 60 simul_count_query = "" simul_verify_query = "SELECT radacctid, acctsessionid, username, nasipaddress, nasportid, framedipaddress, callingstationid, framedprotocol FROM radacct WHERE username = '%{SQL-User-Name}' AND acctstoptime IS NULL" postauth_query = "INSERT INTO radpostauth (username, pass, reply, authdate) VALUES ( '%{User-Name}', '%{%{User-Password}:-%{Chap-Password}}', '%{reply:Packet-Type}', '%S')" safe-characters = "@abcdefghijklmnopqrstuvwxyzABCDEFGHIJKLMNOPQRSTUVWXYZ0123456789.-_: /" } rlm_sql (sql): Driver rlm_sql_mysql (module rlm_sql_mysql) loaded and linked rlm_sql (sql): Attempting to connect to root@27.34.225.33:/radius rlm_sql (sql): starting 0 rlm_sql (sql): Attempting to connect rlm_sql_mysql #0 rlm_sql_mysql: Starting connect to MySQL server for #0 rlm_sql (sql): Connected new DB handle, #0 rlm_sql (sql): starting 1 rlm_sql (sql): Attempting to connect rlm_sql_mysql #1 rlm_sql_mysql: Starting connect to MySQL server for #1 rlm_sql (sql): Connected new DB handle, #1 rlm_sql (sql): starting 2 rlm_sql (sql): Attempting to connect rlm_sql_mysql #2 rlm_sql_mysql: Starting connect to MySQL server for #2 rlm_sql (sql): Connected new DB handle, #2 rlm_sql (sql): starting 3 rlm_sql (sql): Attempting to connect rlm_sql_mysql #3 rlm_sql_mysql: Starting connect to MySQL server for #3 rlm_sql (sql): Connected new DB handle, #3 rlm_sql (sql): starting 4 rlm_sql (sql): Attempting to connect rlm_sql_mysql #4 rlm_sql_mysql: Starting connect to MySQL server for #4 rlm_sql (sql): Connected new DB handle, #4 Module: Checking preacct {...} for more modules to load Module: Linked to module rlm_acct_unique Module: Instantiating acct_unique acct_unique { key = "User-Name, Acct-Session-Id, NAS-IP-Address, Client-IP-Address, NAS-Port" } Module: Checking accounting {...} for more modules to load Module: Linked to module rlm_detail Module: Instantiating detail detail { detailfile = "/var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d" header = "%t" detailperm = 384 dirperm = 493 locking = no log_packet_header = no } Module: Instantiating attr_filter.accounting_response attr_filter attr_filter.accounting_response { attrsfile = "/etc/raddb/attrs.accounting_response" key = "%{User-Name}" } Module: Checking session {...} for more modules to load Module: Checking post-proxy {...} for more modules to load Module: Checking post-auth {...} for more modules to load } # modules } # server radiusd: #### Opening IP addresses and Ports #### listen { type = "auth" ipaddr = * port = 0 } listen { type = "acct" ipaddr = * port = 0 } listen { type = "control" listen { socket = "/var/run/radiusd/radiusd.sock" } } Listening on authentication address * port 1812 Listening on accounting address * port 1813 Listening on command file /var/run/radiusd/radiusd.sock Listening on proxy address * port 1814 Ready to process requests.

3 2

Re: Slow DB / outstanding requests
by Alan Buxey 16 Sep '11

16 Sep '11

Just a quick question, how many DB connections do you have in your config? alan

5 7

Accounting Forwarding
by dbeutler 16 Sep '11

16 Sep '11

Hello, I have recently setup FreeRadius on a test machine and loaded (via a dictionary file) the VSA's for a NAS in our network. The Radius messages we are receiving are purely accounting messages. I am trying to accomplish the following: I would like to forward accounting messages to another Radius server based upon the value of one of the VSA's. In addition, I would like to pick certain attribute-value pairs to forward while discarding the others. I really appreciate any help and I should probably mention that I am pretty new to radius (yesterday was my first time installing it. :) Thanks, DB -- View this message in context: http://freeradius.1045715.n5.nabble.com/Accounting-Forwarding-tp4807387p480… Sent from the FreeRadius - User mailing list archive at Nabble.com.

2 3

Why nas1 and nas2 same NASIPAddress ( freeradius clients.conf and radiusclient.conf)
by sekchel lee 15 Sep '11

15 Sep '11

clients.conf client 127.0.0.1 { secret = test1234 shortname = localhost nastype = other } client 111.222.333.253 { secret = test0000 shortname = 111.222.333.253 nastype = other } --------------------------------------------------------------------------------- nas1 radiusclient.conf ... ... authserver localhost acctserver localhost ... ... nas2 radiusclient.conf ... ... authserver 111.222.333.253 acctserver 111.222.333.253 ... ... --------------------------------------------------------------------------------- user-nas1 id | pool_name | FramedIPAddress | NASIPAddress | CalledStationId | CallingStationID | expiry_time | username | pool_key +-----+-----------+-----------------+--------------+-----------------+------------------+---------------------+----------+---------- | 560 | ns1_pool | 172.16.6.22 | 127.0.0.1 | | 111.222.333.444 | 2011-10-01 09:06:50 | user-nas1 | 7 user-nas2 id | pool_name | FramedIPAddress | NASIPAddress | CalledStationId | CallingStationID | expiry_time | username | pool_key +-----+-----------+-----------------+--------------+-----------------+------------------+---------------------+----------+---------- | 614 | ns2_pool | 172.16.10.22 | 127.0.0.1 | | 555.666.777.888 | 2011-10-01 09:30:10 | user-nas2 | 15

2 1

Re: anybody out there?
by Alan Buxey 15 Sep '11

15 Sep '11

Hi, Just to confirm 2.1.12 is behaving itself (other than the GID issue for control socket) alan

3 2

Test
by Alan DeKok 15 Sep '11

15 Sep '11

Is the list down, or are people quiet?

8 7

FreeRADIUS Strange action (unfinished request/dropping conflict packet)
by Ali Majdzadeh 15 Sep '11

15 Sep '11

Hi I’m running freeradius 1.1.8 with rlm_exec. External program on ACCTOUNTING packets runs and my external program returns OK! And printout the following in its logfile: (PID 5036) 2011-09-15 18:24:28 Packet: updt UserName: hhsde0100413@tct9 187923(a)172.31.3.7 10320 Sec 3993228/61717432 Bytes FreeRADIUS Debugging shows log as the following and shows everything goes fine for that request. Thu Sep 15 18:24:28 2011 : Debug: Thread 1 handling request 175, (31 handled so far) User-Name = "hhsde0100413@tct9" NAS-Port = 136339956 NAS-IP-Address = 172.31.3.7 Framed-IP-Address = 2.179.17.211 Filter-Id = "tct9" Class = 0x68687364653031303034313340746374397c387c3137322e33312e332e377c316361666637623036653264 rad_recv: Accounting-Request packet from host 172.31.3.7:1813, id=92, length=530 NAS-Identifier = "KJ-RJ-ME60X16-01" Acct-Status-Type = Interim-Update Acct-Delay-Time = 0 Acct-Input-Octets = 3993228 Acct-Output-Octets = 61717432 Acct-Session-Id = "KJ-RJ-M08206050000000890a6e187923" Acct-Authentic = RADIUS Acct-Session-Time = 10320 Acct-Input-Packets = 45602 Acct-Output-Packets = 50322 Acct-Input-Gigawords = 0 Acct-Output-Gigawords = 0 Thu Sep 15 18:24:28 2011 : Debug: Thread 1 handling request 175, (31 handled so far) Thu Sep 15 18:24:28 2011 : Debug: modcall: entering group preacct for request 175 Thu Sep 15 18:24:28 2011 : Debug: modsingle[preacct]: calling preprocess (rlm_preprocess) for request 175 Acct-Session-Time = 10320Thu Sep 15 18:24:28 2011 : Debug: modsingle[preacct]: returned from preprocess (rlm_preprocess) for request 175 Thu Sep 15 18:24:28 2011 : Debug: modcall[preacct]: module "preprocess" returns noop for request 175 Thu Sep 15 18:24:28 2011 : Debug: modsingle[preacct]: calling acct_unique (rlm_acct_unique) for request 175 Thu Sep 15 18:24:28 2011 : Debug: modsingle[preacct]: returned from acct_unique (rlm_acct_unique) for request 175 Thu Sep 15 18:24:28 2011 : Debug: modcall[preacct]: module "acct_unique" returns ok for request 175 Thu Sep 15 18:24:28 2011 : Debug: modcall: leaving group preacct (returns ok) for request 175 Thu Sep 15 18:24:28 2011 : Debug: modcall: entering group accounting for request 175 Thu Sep 15 18:24:28 2011 : Debug: modsingle[accounting]: calling detail (rlm_detail) for request 175 Thu Sep 15 18:24:28 2011 : Debug: modsingle[accounting]: returned from detail (rlm_detail) for request 175 Thu Sep 15 18:24:28 2011 : Debug: modcall[accounting]: module "detail" returns ok for request 175 Thu Sep 15 18:24:28 2011 : Debug: modsingle[accounting]: calling netbill_acct (rlm_exec) for request 175 Tcpdump shows the accounting packet issued and returned back to the RAS: IP 172.31.3.7.radius-acct > 172.26.60.3.radius-acct: RADIUS, Accounting Request (4), id: 0xx length: 527 IP 172.26.60.3.radius-acct > 172.31.3.7.radius-acct: RADIUS, Accounting Response (5), id: 0xxx length: 20 But after about 30 secound, I got the following error in freeRADIUS’s log!!!! Thu Sep 15 18:24:59 2011 : Error: WARNING: Unresponsive child (id 3086457744) for request 175 (in component accounting module rlm_exec) hhsde0100413@tct9 Thu Sep 15 18:24:59 2011 : Debug: Server rejecting request 175. And then shows: Thu Sep 15 18:43:54 2011 : Error: Dropping conflicting packet from client 172.31.3.7:1646 - ID: 151 due to unfinished request 175 My external program returns 0 (means OK) and freeRADIUS getting it and returns back to the BRAS, so why freeradius gives such error?! Kind Regards, Ali Majdzadeh Kohbanani

2 1

Slow DB / outstanding requests
by Johan Meiring 15 Sep '11

15 Sep '11

Hi, Seeing as the list is quiet, something that might be of interest. I am running 2.1.12 on a production server. The server is (was) severly underpowered and the database was straining. I was expenting the normal - "rejecting duplicate request". (Cant remember exact error). Then the server received about 30 access requests in about .1 second It then went into a state where the following appeared over and over in the log: Mon Sep 12 11:33:46 2011 : Info: WARNING: Child is hung for request 647 in component <core> module <queue>. Mon Sep 12 11:33:46 2011 : Info: WARNING: Child is hung for request 648 in component <core> module <queue>. Mon Sep 12 11:33:46 2011 : Info: WARNING: Child is hung for request 649 in component <core> module <queue>. Mon Sep 12 11:33:46 2011 : Info: WARNING: Child is hung for request 650 in component <core> module <queue>. Mon Sep 12 11:33:46 2011 : Info: WARNING: Child is hung for request 651 in component <core> module <queue>. Mon Sep 12 11:33:46 2011 : Info: WARNING: Child is hung for request 652 in component <core> module <queue>. Mon Sep 12 11:33:46 2011 : Info: WARNING: Child is hung for request 690 in component <core> module <queue>. Mon Sep 12 11:33:46 2011 : Info: WARNING: Child is hung for request 685 in component <core> module <queue>. Mon Sep 12 11:33:47 2011 : Info: WARNING: Child is hung for request 691 in component <core> module <queue>. Mon Sep 12 11:33:47 2011 : Info: WARNING: Child is hung for request 692 in component <core> module <queue>. Mon Sep 12 11:33:47 2011 : Info: WARNING: Child is hung for request 693 in component <core> module <queue>. Mon Sep 12 11:33:47 2011 : Info: WARNING: Child is hung for request 694 in component <core> module <queue>. Mon Sep 12 11:33:47 2011 : Info: WARNING: Child is hung for request 677 in component <core> module <queue>. Mon Sep 12 11:33:47 2011 : Info: WARNING: Child is hung for request 686 in component <core> module <queue>. Mon Sep 12 11:33:48 2011 : Info: WARNING: Child is hung for request 625 in component <core> module <queue>. Mon Sep 12 11:33:48 2011 : Info: WARNING: Child is hung for request 626 in component <core> module <queue>. Mon Sep 12 11:33:48 2011 : Info: WARNING: Child is hung for request 627 in component <core> module <queue>. Mon Sep 12 11:33:48 2011 : Info: WARNING: Child is hung for request 628 in component <core> module <queue>. It never recovered. Had to be restarted. Even with no database queries outstanding. Dont know if 2.1.12 has more "difficulty" with slow databases? Unfortunately dont have more info, so this can probably be ignored. Cheers, -- Johan Meiring Cape PC Services CC Tel: (021) 883-8271 Fax: (021) 886-7782 -------------------- Before acting on this email or opening any attachments you should read Cape PC Service's email disclaimer at: http://www.pcservices.co.za/disclaimer.html

3 2