August 2006 - Freeradius-Users - lists.freeradius.org

AcctSessionTime is inserting Null
by raviprakash sunkara 17 Aug '06

17 Aug '06

Hi Users, So long back I'm mailing ... Now install Radius Server and client Freshly Actual My problem is THat ... In Accounting Part in . When I radius server recieve the Acc-status-type is Stop , AcctSessionTime is inserting NULL i.e " 0 "...... That is my problem .... Plz give hint to resolve it.... Cheers & Bye -- Thanks and Regards with cheers Sunkara Ravi Prakash Hyperion Technology Kondapur, Hi-tech city, Hyderabad. www.hyperion-tech.com +91-9985077535

2 1

FR-1.1.2 dies with error
by Alexander Serkin 17 Aug '06

17 Aug '06

Hi all. We have some trouble with fr-1.1.2 & Oracle-9.2.0.6 & Solaris 9. The process dies periodically with the error: Thu Aug 3 14:27:43 2006 : Error: Assertion failed in request_list.c, line 1012 FR is built with the following configuration: ./configure \ --with-ltdl-lib=libltdl \ --with-ltdl-include=libltdl \ --enable-ltdl-install=yes \ --with-threads \ --without-openssl \ --enable-developer \ --prefix=/opt/fr It did not dump core, thouigh i enabled it in radiusd.conf and said "ulimit -c unlimited". any suggestions? -- Sincerely Yours, Alexander

7 31

Change RAD_REPLY item in rlm_perl, not add a new pair
by Kenneth Marshall 17 Aug '06

17 Aug '06

Dear Freeradius Users: I am trying to use rlm_perl to append a number to one member of the reply packet using rlm_perl and the %RAD_REPLY hash. I am running freeradius-1.1.1. Here is the code that I am using, a modified example.pl: use strict; # use ... # This is very important ! Without this script will not get the filled hashesh from main. use vars qw(%RAD_REQUEST %RAD_REPLY %RAD_CHECK); use vars qw($count_visitor $count_staff $count_student @rad_array); use Data::Dumper; # This is hash wich hold original request from radius #my %RAD_REQUEST; # In this hash you add values that will be returned to NAS. #my %RAD_REPLY; my $count_visitor = 0, $count_staff = 0, $count_student = 0; #This is for check items #my %RAD_CHECK; ... # Function to handle authorize sub authorize { # For debugging purposes only &log_request_attributes; # Here's where your authorization code comes # You can call another function from here: &test_call; if ($RAD_REPLY{'Tunnel-Private-Group-Id'} =~ /visitor/i) { $RAD_REPLY{'Tunnel-Private-Group-Id'} .= $count_visitor % 4; $count_visitor += 1; } elsif ($RAD_REPLY{'Tunnel-Private-Group-Id'} =~ /staff/i) { $RAD_REPLY{'Tunnel-Private-Group-Id'} .= $count_staff % 3; $count_staff += 1; } elsif ($RAD_REPLY{'Tunnel-Private-Group-Id'} =~ /student/i) { $RAD_REPLY{'Tunnel-Private-Group-Id'} .= $count_student % 2; $count_student += 1; } return RLM_MODULE_UPDATED; } ... Here is the debug output from radiusd: /usr/site/freeradius/sbin/radiusd -Xxx Mon Jun 19 18:09:07 2006 : Info: Starting - reading configuration files ... Mon Jun 19 18:09:07 2006 : Debug: reread_config: reading radiusd.conf Mon Jun 19 18:09:07 2006 : Debug: Config: including file: /usr/site/freeradius-1.1.1/etc/raddb/proxy.conf Mon Jun 19 18:09:07 2006 : Debug: Config: including file: /usr/site/freeradius-1.1.1/etc/raddb/clients.conf Mon Jun 19 18:09:07 2006 : Debug: Config: including file: /usr/site/freeradius-1.1.1/etc/raddb/snmp.conf Mon Jun 19 18:09:07 2006 : Debug: Config: including file: /usr/site/freeradius-1.1.1/etc/raddb/eap.conf Mon Jun 19 18:09:07 2006 : Debug: Config: including file: /usr/site/freeradius-1.1.1/etc/raddb/sql.conf Mon Jun 19 18:09:07 2006 : Debug: main: prefix = "/usr/site/freeradius-1.1.1" Mon Jun 19 18:09:07 2006 : Debug: main: localstatedir = "/usr/site/freeradius-1.1.1/var" Mon Jun 19 18:09:07 2006 : Debug: main: logdir = "/usr/site/freeradius-1.1.1/var/log/radius" Mon Jun 19 18:09:07 2006 : Debug: main: libdir = "/usr/site/freeradius-1.1.1/lib" Mon Jun 19 18:09:07 2006 : Debug: main: radacctdir = "/usr/site/freeradius-1.1.1/var/log/radius/radacct" Mon Jun 19 18:09:07 2006 : Debug: main: hostname_lookups = no Mon Jun 19 18:09:07 2006 : Debug: main: snmp = no Mon Jun 19 18:09:07 2006 : Debug: main: max_request_time = 30 Mon Jun 19 18:09:07 2006 : Debug: main: cleanup_delay = 5 Mon Jun 19 18:09:07 2006 : Debug: main: max_requests = 1024 Mon Jun 19 18:09:07 2006 : Debug: main: delete_blocked_requests = 0 Mon Jun 19 18:09:07 2006 : Debug: main: port = 0 Mon Jun 19 18:09:07 2006 : Debug: main: allow_core_dumps = no Mon Jun 19 18:09:07 2006 : Debug: main: log_stripped_names = no Mon Jun 19 18:09:07 2006 : Debug: main: log_file = "/usr/site/freeradius-1.1.1/var/log/radius/radius.log" Mon Jun 19 18:09:07 2006 : Debug: main: log_auth = no Mon Jun 19 18:09:07 2006 : Debug: main: log_auth_badpass = no Mon Jun 19 18:09:07 2006 : Debug: main: log_auth_goodpass = no Mon Jun 19 18:09:07 2006 : Debug: main: pidfile = "/usr/site/freeradius-1.1.1/var/run/radiusd/radiusd.pid" Mon Jun 19 18:09:07 2006 : Debug: main: user = "(null)" Mon Jun 19 18:09:07 2006 : Debug: main: group = "(null)" Mon Jun 19 18:09:07 2006 : Debug: main: usercollide = no Mon Jun 19 18:09:07 2006 : Debug: main: lower_user = "no" Mon Jun 19 18:09:07 2006 : Debug: main: lower_pass = "no" Mon Jun 19 18:09:07 2006 : Debug: main: nospace_user = "no" Mon Jun 19 18:09:07 2006 : Debug: main: nospace_pass = "no" Mon Jun 19 18:09:07 2006 : Debug: main: checkrad = "/usr/site/freeradius-1.1.1/sbin/checkrad" Mon Jun 19 18:09:07 2006 : Debug: main: proxy_requests = yes Mon Jun 19 18:09:07 2006 : Debug: proxy: retry_delay = 5 Mon Jun 19 18:09:07 2006 : Debug: proxy: retry_count = 3 Mon Jun 19 18:09:07 2006 : Debug: proxy: synchronous = no Mon Jun 19 18:09:07 2006 : Debug: proxy: default_fallback = yes Mon Jun 19 18:09:07 2006 : Debug: proxy: dead_time = 120 Mon Jun 19 18:09:07 2006 : Debug: proxy: post_proxy_authorize = no Mon Jun 19 18:09:07 2006 : Debug: proxy: wake_all_if_all_dead = no Mon Jun 19 18:09:07 2006 : Debug: security: max_attributes = 200 Mon Jun 19 18:09:07 2006 : Debug: security: reject_delay = 1 Mon Jun 19 18:09:07 2006 : Debug: security: status_server = no Mon Jun 19 18:09:07 2006 : Debug: main: debug_level = 0 Mon Jun 19 18:09:07 2006 : Debug: read_config_files: reading dictionary Mon Jun 19 18:09:07 2006 : Debug: read_config_files: reading naslist Mon Jun 19 18:09:07 2006 : Info: Using deprecated naslist file. Support for this will go away soon. Mon Jun 19 18:09:07 2006 : Debug: read_config_files: reading clients Mon Jun 19 18:09:07 2006 : Debug: read_config_files: reading realms Mon Jun 19 18:09:07 2006 : Debug: radiusd: entering modules setup Mon Jun 19 18:09:07 2006 : Debug: Module: Library search path is /usr/site/freeradius-1.1.1/lib Mon Jun 19 18:09:07 2006 : Debug: Module: Loaded exec Mon Jun 19 18:09:07 2006 : Debug: exec: wait = yes Mon Jun 19 18:09:07 2006 : Debug: exec: program = "(null)" Mon Jun 19 18:09:07 2006 : Debug: exec: input_pairs = "request" Mon Jun 19 18:09:07 2006 : Debug: exec: output_pairs = "(null)" Mon Jun 19 18:09:07 2006 : Debug: exec: packet_type = "(null)" Mon Jun 19 18:09:07 2006 : Info: rlm_exec: Wait=yes but no output defined. Did you mean output=none? Mon Jun 19 18:09:07 2006 : Debug: Module: Instantiated exec (exec) Mon Jun 19 18:09:07 2006 : Debug: Module: Loaded expr Mon Jun 19 18:09:07 2006 : Debug: Module: Instantiated expr (expr) Mon Jun 19 18:09:07 2006 : Debug: Module: Loaded Counter Mon Jun 19 18:09:07 2006 : Debug: counter: filename = "/usr/site/freeradius-1.1.1/etc/raddb/db.vpnrrobin" Mon Jun 19 18:09:07 2006 : Debug: counter: key = "NAS-IP-Address" Mon Jun 19 18:09:07 2006 : Debug: counter: reset = "weekly" Mon Jun 19 18:09:07 2006 : Debug: counter: count-attribute = "User-Name" Mon Jun 19 18:09:07 2006 : Debug: counter: counter-name = "VPN-Connection-Count" Mon Jun 19 18:09:07 2006 : Debug: counter: check-name = "Max-Connection-Count" Mon Jun 19 18:09:07 2006 : Debug: counter: allowed-servicetype = "(null)" Mon Jun 19 18:09:07 2006 : Debug: counter: cache-size = 5000 Mon Jun 19 18:09:07 2006 : Debug: rlm_counter: Counter attribute VPN-Connection-Count is number 1830 Mon Jun 19 18:09:07 2006 : Debug: rlm_counter: Current Time: 1150758547 [2006-06-19 18:09:07], Next reset 1151211600 [2006-06-25 00:00:00] Mon Jun 19 18:09:07 2006 : Debug: Module: Instantiated counter (vpnrrobin) Mon Jun 19 18:09:07 2006 : Debug: Module: Loaded PAP Mon Jun 19 18:09:07 2006 : Debug: pap: encryption_scheme = "clear" Mon Jun 19 18:09:07 2006 : Debug: Module: Instantiated pap (pap) Mon Jun 19 18:09:07 2006 : Debug: Module: Loaded CHAP Mon Jun 19 18:09:07 2006 : Debug: Module: Instantiated chap (chap) Mon Jun 19 18:09:07 2006 : Debug: Module: Loaded MS-CHAP Mon Jun 19 18:09:07 2006 : Debug: mschap: use_mppe = yes Mon Jun 19 18:09:07 2006 : Debug: mschap: require_encryption = no Mon Jun 19 18:09:07 2006 : Debug: mschap: require_strong = no Mon Jun 19 18:09:07 2006 : Debug: mschap: with_ntdomain_hack = no Mon Jun 19 18:09:07 2006 : Debug: mschap: passwd = "(null)" Mon Jun 19 18:09:07 2006 : Debug: mschap: authtype = "MS-CHAP" Mon Jun 19 18:09:07 2006 : Debug: mschap: ntlm_auth = "(null)" Mon Jun 19 18:09:07 2006 : Debug: Module: Instantiated mschap (mschap) Mon Jun 19 18:09:07 2006 : Debug: Module: Loaded Kerberos Mon Jun 19 18:09:07 2006 : Debug: krb5: keytab = "/etc/opt/heimdal/krb5.keytab" Mon Jun 19 18:09:07 2006 : Debug: krb5: service_principal = "radius/dhcp-a.net.rice.edu(a)RICE.EDU" Mon Jun 19 18:09:07 2006 : Auth: rlm_krb5: krb5_init ok Mon Jun 19 18:09:07 2006 : Debug: Module: Instantiated krb5 (krb5) Mon Jun 19 18:09:07 2006 : Debug: Module: Loaded System Mon Jun 19 18:09:07 2006 : Debug: unix: cache = no Mon Jun 19 18:09:07 2006 : Debug: unix: passwd = "(null)" Mon Jun 19 18:09:07 2006 : Debug: unix: shadow = "(null)" Mon Jun 19 18:09:07 2006 : Debug: unix: group = "(null)" Mon Jun 19 18:09:07 2006 : Debug: unix: radwtmp = "/usr/site/freeradius-1.1.1/var/log/radius/radwtmp" Mon Jun 19 18:09:07 2006 : Debug: unix: usegroup = no Mon Jun 19 18:09:07 2006 : Debug: unix: cache_reload = 600 Mon Jun 19 18:09:07 2006 : Debug: Module: Instantiated unix (unix) Mon Jun 19 18:09:07 2006 : Debug: Module: Loaded eap Mon Jun 19 18:09:07 2006 : Debug: eap: default_eap_type = "tls" Mon Jun 19 18:09:07 2006 : Debug: eap: timer_expire = 60 Mon Jun 19 18:09:07 2006 : Debug: eap: ignore_unknown_eap_types = no Mon Jun 19 18:09:07 2006 : Debug: eap: cisco_accounting_username_bug = no Mon Jun 19 18:09:07 2006 : Debug: rlm_eap: Loaded and initialized type md5 Mon Jun 19 18:09:07 2006 : Debug: rlm_eap: Loaded and initialized type leap Mon Jun 19 18:09:07 2006 : Debug: gtc: challenge = "Password: " Mon Jun 19 18:09:07 2006 : Debug: gtc: auth_type = "PAP" Mon Jun 19 18:09:07 2006 : Debug: rlm_eap: Loaded and initialized type gtc Mon Jun 19 18:09:07 2006 : Debug: tls: rsa_key_exchange = no Mon Jun 19 18:09:07 2006 : Debug: tls: dh_key_exchange = yes Mon Jun 19 18:09:07 2006 : Debug: tls: rsa_key_length = 512 Mon Jun 19 18:09:07 2006 : Debug: tls: dh_key_length = 512 Mon Jun 19 18:09:07 2006 : Debug: tls: verify_depth = 0 Mon Jun 19 18:09:07 2006 : Debug: tls: CA_path = "(null)" Mon Jun 19 18:09:07 2006 : Debug: tls: pem_file_type = yes Mon Jun 19 18:09:07 2006 : Debug: tls: private_key_file = "/etc/opt/ssl/certs/cert.key" Mon Jun 19 18:09:07 2006 : Debug: tls: certificate_file = "/etc/opt/ssl/certs/cert.pem" Mon Jun 19 18:09:07 2006 : Debug: tls: CA_file = "/etc/opt/ssl/certs/CA/cacert.pem" Mon Jun 19 18:09:07 2006 : Debug: tls: private_key_password = "" Mon Jun 19 18:09:07 2006 : Debug: tls: dh_file = "/usr/site/freeradius-1.1.1/etc/raddb/certs/dh" Mon Jun 19 18:09:07 2006 : Debug: tls: random_file = "/usr/site/freeradius-1.1.1/etc/raddb/certs/random" Mon Jun 19 18:09:07 2006 : Debug: tls: fragment_size = 1024 Mon Jun 19 18:09:07 2006 : Debug: tls: include_length = yes Mon Jun 19 18:09:07 2006 : Debug: tls: check_crl = no Mon Jun 19 18:09:07 2006 : Debug: tls: check_cert_cn = "(null)" Mon Jun 19 18:09:07 2006 : Info: rlm_eap_tls: Loading the certificate file as a chain Mon Jun 19 18:09:07 2006 : Debug: rlm_eap: Loaded and initialized type tls Mon Jun 19 18:09:07 2006 : Debug: ttls: default_eap_type = "md5" Mon Jun 19 18:09:07 2006 : Debug: ttls: copy_request_to_tunnel = no Mon Jun 19 18:09:07 2006 : Debug: ttls: use_tunneled_reply = no Mon Jun 19 18:09:07 2006 : Debug: rlm_eap: Loaded and initialized type ttls Mon Jun 19 18:09:07 2006 : Debug: peap: default_eap_type = "mschapv2" Mon Jun 19 18:09:07 2006 : Debug: peap: copy_request_to_tunnel = no Mon Jun 19 18:09:07 2006 : Debug: peap: use_tunneled_reply = no Mon Jun 19 18:09:07 2006 : Debug: peap: proxy_tunneled_request_as_eap = yes Mon Jun 19 18:09:07 2006 : Debug: rlm_eap: Loaded and initialized type peap Mon Jun 19 18:09:07 2006 : Debug: mschapv2: with_ntdomain_hack = no Mon Jun 19 18:09:07 2006 : Debug: rlm_eap: Loaded and initialized type mschapv2 Mon Jun 19 18:09:07 2006 : Debug: Module: Instantiated eap (eap) Mon Jun 19 18:09:07 2006 : Debug: Module: Loaded preprocess Mon Jun 19 18:09:07 2006 : Debug: preprocess: huntgroups = "/usr/site/freeradius-1.1.1/etc/raddb/huntgroups" Mon Jun 19 18:09:07 2006 : Debug: preprocess: hints = "/usr/site/freeradius-1.1.1/etc/raddb/hints" Mon Jun 19 18:09:07 2006 : Debug: preprocess: with_ascend_hack = no Mon Jun 19 18:09:07 2006 : Debug: preprocess: ascend_channels_per_line = 23 Mon Jun 19 18:09:07 2006 : Debug: preprocess: with_ntdomain_hack = no Mon Jun 19 18:09:07 2006 : Debug: preprocess: with_specialix_jetstream_hack = no Mon Jun 19 18:09:07 2006 : Debug: preprocess: with_cisco_vsa_hack = no Mon Jun 19 18:09:07 2006 : Debug: Module: Instantiated preprocess (preprocess) Mon Jun 19 18:09:07 2006 : Debug: Module: Loaded realm Mon Jun 19 18:09:07 2006 : Debug: realm: format = "suffix" Mon Jun 19 18:09:07 2006 : Debug: realm: delimiter = "@" Mon Jun 19 18:09:07 2006 : Debug: realm: ignore_default = no Mon Jun 19 18:09:07 2006 : Debug: realm: ignore_null = no Mon Jun 19 18:09:07 2006 : Debug: Module: Instantiated realm (suffix) Mon Jun 19 18:09:07 2006 : Debug: Module: Loaded files Mon Jun 19 18:09:07 2006 : Debug: files: usersfile = "/usr/site/freeradius-1.1.1/etc/raddb/users" Mon Jun 19 18:09:07 2006 : Debug: files: acctusersfile = "/usr/site/freeradius-1.1.1/etc/raddb/acct_users" Mon Jun 19 18:09:07 2006 : Debug: files: preproxy_usersfile = "/usr/site/freeradius-1.1.1/etc/raddb/preproxy_users" Mon Jun 19 18:09:07 2006 : Debug: files: compat = "no" Mon Jun 19 18:09:07 2006 : Debug: Module: Instantiated files (files) Mon Jun 19 18:09:07 2006 : Debug: Module: Loaded LDAP Mon Jun 19 18:09:07 2006 : Debug: ldap: server = "ldap1.rice.edu" Mon Jun 19 18:09:07 2006 : Debug: ldap: port = 389 Mon Jun 19 18:09:07 2006 : Debug: ldap: net_timeout = 1 Mon Jun 19 18:09:07 2006 : Debug: ldap: timeout = 4 Mon Jun 19 18:09:07 2006 : Debug: ldap: timelimit = 3 Mon Jun 19 18:09:07 2006 : Debug: ldap: identity = "" Mon Jun 19 18:09:07 2006 : Debug: ldap: tls_mode = no Mon Jun 19 18:09:07 2006 : Debug: ldap: start_tls = no Mon Jun 19 18:09:07 2006 : Debug: ldap: tls_cacertfile = "(null)" Mon Jun 19 18:09:07 2006 : Debug: ldap: tls_cacertdir = "(null)" Mon Jun 19 18:09:07 2006 : Debug: ldap: tls_certfile = "(null)" Mon Jun 19 18:09:07 2006 : Debug: ldap: tls_keyfile = "(null)" Mon Jun 19 18:09:07 2006 : Debug: ldap: tls_randfile = "(null)" Mon Jun 19 18:09:07 2006 : Debug: ldap: tls_require_cert = "allow" Mon Jun 19 18:09:07 2006 : Debug: ldap: password = "" Mon Jun 19 18:09:07 2006 : Debug: ldap: basedn = "ou=People,dc=rice,dc=edu" Mon Jun 19 18:09:07 2006 : Debug: ldap: filter = "(uid=%{Stripped-User-Name:-%{User-Name}})" Mon Jun 19 18:09:07 2006 : Debug: ldap: base_filter = "(objectclass=radiusprofile)" Mon Jun 19 18:09:07 2006 : Debug: ldap: default_profile = "(null)" Mon Jun 19 18:09:07 2006 : Debug: ldap: profile_attribute = "(null)" Mon Jun 19 18:09:07 2006 : Debug: ldap: password_header = "(null)" Mon Jun 19 18:09:07 2006 : Debug: ldap: password_attribute = "(null)" Mon Jun 19 18:09:07 2006 : Debug: ldap: access_attr = "riceClass" Mon Jun 19 18:09:07 2006 : Debug: ldap: groupname_attribute = "cn" Mon Jun 19 18:09:07 2006 : Debug: ldap: groupmembership_filter = "(|(&(objectClass=GroupOfNames)(member=%{Ldap-UserDn}))(&(objectClass=GroupOfUniqueNames)(uniquemember=%{Ldap-UserDn})))" Mon Jun 19 18:09:07 2006 : Debug: ldap: groupmembership_attribute = "(null)" Mon Jun 19 18:09:07 2006 : Debug: ldap: dictionary_mapping = "/usr/site/freeradius-1.1.1/etc/raddb/ldap.attrmap" Mon Jun 19 18:09:07 2006 : Debug: ldap: ldap_debug = 0 Mon Jun 19 18:09:07 2006 : Debug: ldap: ldap_connections_number = 5 Mon Jun 19 18:09:07 2006 : Debug: ldap: compare_check_items = no Mon Jun 19 18:09:07 2006 : Debug: ldap: access_attr_used_for_allow = yes Mon Jun 19 18:09:07 2006 : Debug: ldap: do_xlat = yes Mon Jun 19 18:09:07 2006 : Debug: ldap: set_auth_type = yes Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: Registering ldap_groupcmp for Ldap-Group Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: Registering ldap_xlat with xlat_name ldap Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: Over-riding set_auth_type, as we're not listed in the "authenticate" section. Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: reading ldap<->radius mappings from file /usr/site/freeradius-1.1.1/etc/raddb/ldap.attrmap Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP radiusCheckItem mapped to RADIUS $GENERIC$ Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP radiusReplyItem mapped to RADIUS $GENERIC$ Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP radiusAuthType mapped to RADIUS Auth-Type Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP radiusSimultaneousUse mapped to RADIUS Simultaneous-Use Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP radiusCalledStationId mapped to RADIUS Called-Station-Id Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP radiusCallingStationId mapped to RADIUS Calling-Station-Id Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP lmPassword mapped to RADIUS LM-Password Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP ntPassword mapped to RADIUS NT-Password Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP acctFlags mapped to RADIUS SMB-Account-CTRL-TEXT Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP radiusExpiration mapped to RADIUS Expiration Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP radiusNASIpAddress mapped to RADIUS NAS-IP-Address Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP radiusServiceType mapped to RADIUS Service-Type Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP radiusFramedProtocol mapped to RADIUS Framed-Protocol Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP radiusFramedIPAddress mapped to RADIUS Framed-IP-Address Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP radiusFramedIPNetmask mapped to RADIUS Framed-IP-Netmask Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP radiusFramedRoute mapped to RADIUS Framed-Route Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP radiusFramedRouting mapped to RADIUS Framed-Routing Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP radiusFilterId mapped to RADIUS Filter-Id Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP radiusFramedMTU mapped to RADIUS Framed-MTU Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP radiusFramedCompression mapped to RADIUS Framed-Compression Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP radiusLoginIPHost mapped to RADIUS Login-IP-Host Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP radiusLoginService mapped to RADIUS Login-Service Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP radiusLoginTCPPort mapped to RADIUS Login-TCP-Port Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP radiusCallbackNumber mapped to RADIUS Callback-Number Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP radiusCallbackId mapped to RADIUS Callback-Id Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP radiusFramedIPXNetwork mapped to RADIUS Framed-IPX-Network Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP radiusClass mapped to RADIUS Class Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP radiusSessionTimeout mapped to RADIUS Session-Timeout Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP radiusIdleTimeout mapped to RADIUS Idle-Timeout Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP radiusTerminationAction mapped to RADIUS Termination-Action Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP radiusLoginLATService mapped to RADIUS Login-LAT-Service Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP radiusLoginLATNode mapped to RADIUS Login-LAT-Node Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP radiusLoginLATGroup mapped to RADIUS Login-LAT-Group Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP radiusFramedAppleTalkLink mapped to RADIUS Framed-AppleTalk-Link Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP radiusFramedAppleTalkNetwork mapped to RADIUS Framed-AppleTalk-Network Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP radiusFramedAppleTalkZone mapped to RADIUS Framed-AppleTalk-Zone Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP radiusPortLimit mapped to RADIUS Port-Limit Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP radiusLoginLATPort mapped to RADIUS Login-LAT-Port Mon Jun 19 18:09:07 2006 : Debug: rlm_ldap: LDAP radiusReplyMessage mapped to RADIUS Reply-Message Mon Jun 19 18:09:07 2006 : Debug: conns: 0x94d5038 Mon Jun 19 18:09:07 2006 : Debug: Module: Instantiated ldap (ldap) Mon Jun 19 18:09:07 2006 : Debug: Module: Loaded attr_rewrite Mon Jun 19 18:09:07 2006 : Debug: attr_rewrite: attribute = "Class" Mon Jun 19 18:09:07 2006 : Debug: attr_rewrite: searchfor = "[a-z]* student" Mon Jun 19 18:09:07 2006 : Debug: attr_rewrite: searchin = "reply" Mon Jun 19 18:09:07 2006 : Debug: attr_rewrite: replacewith = "student" Mon Jun 19 18:09:07 2006 : Debug: attr_rewrite: append = no Mon Jun 19 18:09:07 2006 : Debug: attr_rewrite: ignore_case = no Mon Jun 19 18:09:07 2006 : Debug: attr_rewrite: new_attribute = no Mon Jun 19 18:09:07 2006 : Debug: attr_rewrite: max_matches = 10 Mon Jun 19 18:09:07 2006 : Debug: Module: Instantiated attr_rewrite (cleanstudent) Mon Jun 19 18:09:07 2006 : Debug: attr_rewrite: attribute = "Class" Mon Jun 19 18:09:07 2006 : Debug: attr_rewrite: searchfor = "faculty" Mon Jun 19 18:09:07 2006 : Debug: attr_rewrite: searchin = "reply" Mon Jun 19 18:09:07 2006 : Debug: attr_rewrite: replacewith = "staff" Mon Jun 19 18:09:07 2006 : Debug: attr_rewrite: append = no Mon Jun 19 18:09:07 2006 : Debug: attr_rewrite: ignore_case = no Mon Jun 19 18:09:07 2006 : Debug: attr_rewrite: new_attribute = no Mon Jun 19 18:09:07 2006 : Debug: attr_rewrite: max_matches = 10 Mon Jun 19 18:09:07 2006 : Debug: Module: Instantiated attr_rewrite (cleanfaculty) Mon Jun 19 18:09:07 2006 : Debug: attr_rewrite: attribute = "Tunnel-private-group-id" Mon Jun 19 18:09:07 2006 : Debug: attr_rewrite: searchfor = "[a-z]* student" Mon Jun 19 18:09:07 2006 : Debug: attr_rewrite: searchin = "reply" Mon Jun 19 18:09:07 2006 : Debug: attr_rewrite: replacewith = "student" Mon Jun 19 18:09:07 2006 : Debug: attr_rewrite: append = no Mon Jun 19 18:09:07 2006 : Debug: attr_rewrite: ignore_case = no Mon Jun 19 18:09:07 2006 : Debug: attr_rewrite: new_attribute = no Mon Jun 19 18:09:07 2006 : Debug: attr_rewrite: max_matches = 10 Mon Jun 19 18:09:07 2006 : Debug: Module: Instantiated attr_rewrite (cleanstudentw) Mon Jun 19 18:09:07 2006 : Debug: attr_rewrite: attribute = "Tunnel-private-group-id" Mon Jun 19 18:09:07 2006 : Debug: attr_rewrite: searchfor = "faculty" Mon Jun 19 18:09:07 2006 : Debug: attr_rewrite: searchin = "reply" Mon Jun 19 18:09:07 2006 : Debug: attr_rewrite: replacewith = "staff" Mon Jun 19 18:09:07 2006 : Debug: attr_rewrite: append = no Mon Jun 19 18:09:07 2006 : Debug: attr_rewrite: ignore_case = no Mon Jun 19 18:09:07 2006 : Debug: attr_rewrite: new_attribute = no Mon Jun 19 18:09:07 2006 : Debug: attr_rewrite: max_matches = 10 Mon Jun 19 18:09:07 2006 : Debug: Module: Instantiated attr_rewrite (cleanfacultyw) Mon Jun 19 18:09:07 2006 : Debug: Module: Loaded perl Mon Jun 19 18:09:07 2006 : Debug: perl: module = "/usr/site/freeradius/etc/raddb/rrobin.pm" Mon Jun 19 18:09:07 2006 : Debug: perl: func_authorize = "authorize" Mon Jun 19 18:09:07 2006 : Debug: perl: func_authenticate = "authenticate" Mon Jun 19 18:09:07 2006 : Debug: perl: func_accounting = "accounting" Mon Jun 19 18:09:07 2006 : Debug: perl: func_preacct = "preacct" Mon Jun 19 18:09:07 2006 : Debug: perl: func_checksimul = "checksimul" Mon Jun 19 18:09:07 2006 : Debug: perl: func_detach = "detach" Mon Jun 19 18:09:07 2006 : Debug: perl: func_xlat = "xlat" Mon Jun 19 18:09:07 2006 : Debug: perl: func_pre_proxy = "pre_proxy" Mon Jun 19 18:09:07 2006 : Debug: perl: func_post_proxy = "post_proxy" Mon Jun 19 18:09:07 2006 : Debug: perl: func_post_auth = "post_auth" Mon Jun 19 18:09:07 2006 : Debug: perl: perl_flags = "(null)" Mon Jun 19 18:09:07 2006 : Debug: perl: func_start_accounting = "(null)" Mon Jun 19 18:09:07 2006 : Debug: perl: func_stop_accounting = "(null)" Mon Jun 19 18:09:07 2006 : Debug: Module: Instantiated perl (perl) Mon Jun 19 18:09:07 2006 : Debug: Module: Loaded Acct-Unique-Session-Id Mon Jun 19 18:09:07 2006 : Debug: acct_unique: key = "User-Name, Acct-Session-Id, NAS-IP-Address, Client-IP-Address, NAS-Port" Mon Jun 19 18:09:07 2006 : Debug: Module: Instantiated acct_unique (acct_unique) Mon Jun 19 18:09:07 2006 : Debug: Module: Loaded detail Mon Jun 19 18:09:07 2006 : Debug: detail: detailfile = "/usr/site/freeradius-1.1.1/var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d" Mon Jun 19 18:09:07 2006 : Debug: detail: detailperm = 384 Mon Jun 19 18:09:07 2006 : Debug: detail: dirperm = 493 Mon Jun 19 18:09:07 2006 : Debug: detail: locking = no Mon Jun 19 18:09:07 2006 : Debug: Module: Instantiated detail (detail) Mon Jun 19 18:09:07 2006 : Debug: Module: Loaded radutmp Mon Jun 19 18:09:07 2006 : Debug: radutmp: filename = "/usr/site/freeradius-1.1.1/var/log/radius/radutmp" Mon Jun 19 18:09:07 2006 : Debug: radutmp: username = "%{User-Name}" Mon Jun 19 18:09:07 2006 : Debug: radutmp: case_sensitive = yes Mon Jun 19 18:09:07 2006 : Debug: radutmp: check_with_nas = yes Mon Jun 19 18:09:07 2006 : Debug: radutmp: perm = 384 Mon Jun 19 18:09:07 2006 : Debug: radutmp: callerid = yes Mon Jun 19 18:09:07 2006 : Debug: Module: Instantiated radutmp (radutmp) Mon Jun 19 18:09:07 2006 : Debug: Listening on authentication *:1812 Mon Jun 19 18:09:07 2006 : Debug: Listening on accounting *:1813 Mon Jun 19 18:09:07 2006 : Info: Ready to process requests. rad_recv: Access-Request packet from host 127.0.0.1:33469, id=75, length=61 User-Name = "teststaff" User-Password = "xxxx" NAS-IP-Address = 255.255.255.255 NAS-Port = 13 Mon Jun 19 18:09:26 2006 : Debug: Processing the authorize section of radiusd.conf Mon Jun 19 18:09:26 2006 : Debug: modcall: entering group authorize for request 0 Mon Jun 19 18:09:26 2006 : Debug: modsingle[authorize]: calling preprocess (rlm_preprocess) for request 0 Mon Jun 19 18:09:26 2006 : Debug: modsingle[authorize]: returned from preprocess (rlm_preprocess) for request 0 Mon Jun 19 18:09:26 2006 : Debug: modcall[authorize]: module "preprocess" returns ok for request 0 Mon Jun 19 18:09:26 2006 : Debug: modsingle[authorize]: calling chap (rlm_chap) for request 0 Mon Jun 19 18:09:26 2006 : Debug: modsingle[authorize]: returned from chap (rlm_chap) for request 0 Mon Jun 19 18:09:26 2006 : Debug: modcall[authorize]: module "chap" returns noop for request 0 Mon Jun 19 18:09:26 2006 : Debug: modsingle[authorize]: calling mschap (rlm_mschap) for request 0 Mon Jun 19 18:09:26 2006 : Debug: modsingle[authorize]: returned from mschap (rlm_mschap) for request 0 Mon Jun 19 18:09:26 2006 : Debug: modcall[authorize]: module "mschap" returns noop for request 0 Mon Jun 19 18:09:26 2006 : Debug: modsingle[authorize]: calling suffix (rlm_realm) for request 0 Mon Jun 19 18:09:26 2006 : Debug: rlm_realm: No '@' in User-Name = "teststaff", looking up realm NULL Mon Jun 19 18:09:26 2006 : Debug: rlm_realm: No such realm "NULL" Mon Jun 19 18:09:26 2006 : Debug: modsingle[authorize]: returned from suffix (rlm_realm) for request 0 Mon Jun 19 18:09:26 2006 : Debug: modcall[authorize]: module "suffix" returns noop for request 0 Mon Jun 19 18:09:26 2006 : Debug: modsingle[authorize]: calling eap (rlm_eap) for request 0 Mon Jun 19 18:09:26 2006 : Debug: rlm_eap: No EAP-Message, not doing EAP Mon Jun 19 18:09:26 2006 : Debug: modsingle[authorize]: returned from eap (rlm_eap) for request 0 Mon Jun 19 18:09:26 2006 : Debug: modcall[authorize]: module "eap" returns noop for request 0 Mon Jun 19 18:09:26 2006 : Debug: modsingle[authorize]: calling files (rlm_files) for request 0 Mon Jun 19 18:09:26 2006 : Debug: users: Matched entry DEFAULT at line 203 Mon Jun 19 18:09:26 2006 : Debug: radius_xlat: Running registered xlat function of module ldap for string 'ldap:///dc=rice,dc=edu?riceClass?sub?uid=%u' Mon Jun 19 18:09:26 2006 : Debug: rlm_ldap: - ldap_xlat Mon Jun 19 18:09:26 2006 : Debug: radius_xlat: 'ldap:///dc=rice,dc=edu?riceClass?sub?uid=teststaff' Mon Jun 19 18:09:26 2006 : Debug: rlm_ldap: ldap_get_conn: Checking Id: 0 Mon Jun 19 18:09:26 2006 : Debug: rlm_ldap: ldap_get_conn: Got Id: 0 Mon Jun 19 18:09:26 2006 : Debug: rlm_ldap: attempting LDAP reconnection Mon Jun 19 18:09:26 2006 : Debug: rlm_ldap: (re)connect to ldap1.rice.edu:389, authentication 0 Mon Jun 19 18:09:26 2006 : Debug: rlm_ldap: bind as / to ldap1.rice.edu:389 Mon Jun 19 18:09:31 2006 : Debug: rlm_ldap: waiting for bind result ... Mon Jun 19 18:09:31 2006 : Debug: rlm_ldap: Bind was successful Mon Jun 19 18:09:31 2006 : Debug: rlm_ldap: performing search in dc=rice,dc=edu, with filter uid=teststaff Mon Jun 19 18:09:31 2006 : Debug: rlm_ldap: Adding attribute riceClass, value: staff Mon Jun 19 18:09:31 2006 : Debug: rlm_ldap: ldap_release_conn: Release Id: 0 Mon Jun 19 18:09:31 2006 : Debug: rlm_ldap: - ldap_xlat end Mon Jun 19 18:09:31 2006 : Debug: radius_xlat: 'staff' Mon Jun 19 18:09:31 2006 : Debug: modsingle[authorize]: returned from files (rlm_files) for request 0 Mon Jun 19 18:09:31 2006 : Debug: modcall[authorize]: module "files" returns ok for request 0 Mon Jun 19 18:09:31 2006 : Debug: modsingle[authorize]: calling ldap (rlm_ldap) for request 0 Mon Jun 19 18:09:31 2006 : Debug: rlm_ldap: - authorize Mon Jun 19 18:09:31 2006 : Debug: rlm_ldap: performing user authorization for teststaff Mon Jun 19 18:09:31 2006 : Debug: radius_xlat: '(uid=teststaff)' Mon Jun 19 18:09:31 2006 : Debug: radius_xlat: 'ou=People,dc=rice,dc=edu' Mon Jun 19 18:09:31 2006 : Debug: rlm_ldap: ldap_get_conn: Checking Id: 0 Mon Jun 19 18:09:31 2006 : Debug: rlm_ldap: ldap_get_conn: Got Id: 0 Mon Jun 19 18:09:31 2006 : Debug: rlm_ldap: performing search in ou=People,dc=rice,dc=edu, with filter (uid=teststaff) Mon Jun 19 18:09:31 2006 : Debug: rlm_ldap: checking if remote access for teststaff is allowed by riceClass Mon Jun 19 18:09:31 2006 : Debug: rlm_ldap: looking for check items in directory... Mon Jun 19 18:09:31 2006 : Debug: rlm_ldap: looking for reply items in directory... Mon Jun 19 18:09:31 2006 : Debug: rlm_ldap: user teststaff authorized to use remote access Mon Jun 19 18:09:31 2006 : Debug: rlm_ldap: ldap_release_conn: Release Id: 0 Mon Jun 19 18:09:31 2006 : Debug: modsingle[authorize]: returned from ldap (rlm_ldap) for request 0 Mon Jun 19 18:09:31 2006 : Debug: modcall[authorize]: module "ldap" returns ok for request 0 Mon Jun 19 18:09:31 2006 : Debug: modsingle[authorize]: calling cleanstudent (rlm_attr_rewrite) for request 0 Mon Jun 19 18:09:31 2006 : Debug: rlm_attr_rewrite: Could not find value pair for attribute Class Mon Jun 19 18:09:31 2006 : Debug: modsingle[authorize]: returned from cleanstudent (rlm_attr_rewrite) for request 0 Mon Jun 19 18:09:31 2006 : Debug: modcall[authorize]: module "cleanstudent" returns noop for request 0 Mon Jun 19 18:09:31 2006 : Debug: modsingle[authorize]: calling cleanfaculty (rlm_attr_rewrite) for request 0 Mon Jun 19 18:09:31 2006 : Debug: rlm_attr_rewrite: Could not find value pair for attribute Class Mon Jun 19 18:09:31 2006 : Debug: modsingle[authorize]: returned from cleanfaculty (rlm_attr_rewrite) for request 0 Mon Jun 19 18:09:31 2006 : Debug: modcall[authorize]: module "cleanfaculty" returns noop for request 0 Mon Jun 19 18:09:31 2006 : Debug: modsingle[authorize]: calling cleanstudentw (rlm_attr_rewrite) for request 0 Mon Jun 19 18:09:31 2006 : Debug: radius_xlat: '[a-z]* student' Mon Jun 19 18:09:31 2006 : Debug: rlm_attr_rewrite: No match found for attribute Tunnel-private-group-id with value 'staff' Mon Jun 19 18:09:31 2006 : Debug: modsingle[authorize]: returned from cleanstudentw (rlm_attr_rewrite) for request 0 Mon Jun 19 18:09:31 2006 : Debug: modcall[authorize]: module "cleanstudentw" returns ok for request 0 Mon Jun 19 18:09:31 2006 : Debug: modsingle[authorize]: calling cleanfacultyw (rlm_attr_rewrite) for request 0 Mon Jun 19 18:09:31 2006 : Debug: radius_xlat: 'faculty' Mon Jun 19 18:09:31 2006 : Debug: rlm_attr_rewrite: No match found for attribute Tunnel-private-group-id with value 'staff' Mon Jun 19 18:09:31 2006 : Debug: modsingle[authorize]: returned from cleanfacultyw (rlm_attr_rewrite) for request 0 Mon Jun 19 18:09:31 2006 : Debug: modcall[authorize]: module "cleanfacultyw" returns ok for request 0 Mon Jun 19 18:09:31 2006 : Debug: modsingle[authorize]: calling vpnrrobin (rlm_counter) for request 0 Mon Jun 19 18:09:31 2006 : Debug: rlm_counter: Entering module authorize code Mon Jun 19 18:09:31 2006 : Debug: rlm_counter: Could not find Check item value pair Mon Jun 19 18:09:31 2006 : Debug: modsingle[authorize]: returned from vpnrrobin (rlm_counter) for request 0 Mon Jun 19 18:09:31 2006 : Debug: modcall[authorize]: module "vpnrrobin" returns noop for request 0 Mon Jun 19 18:09:31 2006 : Debug: modsingle[authorize]: calling perl (rlm_perl) for request 0 Mon Jun 19 18:09:31 2006 : Debug: Using perl at 0x94d7920 Mon Jun 19 18:09:31 2006 : Debug: rlm_perl: RAD_REQUEST: Client-IP-Address = 127.0.0.1 Mon Jun 19 18:09:31 2006 : Debug: rlm_perl: RAD_REQUEST: User-Name = teststaff Mon Jun 19 18:09:31 2006 : Debug: rlm_perl: RAD_REQUEST: User-Password = xxxxx Mon Jun 19 18:09:31 2006 : Debug: rlm_perl: RAD_REQUEST: Ldap-UserDn = uid=teststaff,ou=People,dc=rice,dc=edu Mon Jun 19 18:09:31 2006 : Debug: rlm_perl: RAD_REQUEST: NAS-Port = 13 Mon Jun 19 18:09:31 2006 : Debug: rlm_perl: RAD_REQUEST: NAS-IP-Address = 255.255.255.255 Mon Jun 19 18:09:31 2006 : Debug: rlm_perl: RAD_REPLY: Tunnel-Medium-Type = IEEE-802 Mon Jun 19 18:09:31 2006 : Debug: rlm_perl: RAD_REPLY: Tunnel-Type = VLAN Mon Jun 19 18:09:31 2006 : Debug: rlm_perl: RAD_REPLY: Tunnel-Private-Group-Id = staff Mon Jun 19 18:09:31 2006 : Debug: rlm_perl: Added pair Tunnel-Medium-Type = IEEE-802 Mon Jun 19 18:09:31 2006 : Debug: rlm_perl: Added pair Tunnel-Type = VLAN Mon Jun 19 18:09:31 2006 : Debug: rlm_perl: Added pair Tunnel-Private-Group-Id = staff0 Mon Jun 19 18:09:31 2006 : Debug: rlm_perl: Added pair Auth-Type = Kerberos Mon Jun 19 18:09:31 2006 : Debug: rlm_perl: Added pair NAS-Port = 13 Mon Jun 19 18:09:31 2006 : Debug: rlm_perl: Added pair NAS-IP-Address = 255.255.255.255 Mon Jun 19 18:09:31 2006 : Debug: modsingle[authorize]: returned from perl (rlm_perl) for request 0 Mon Jun 19 18:09:31 2006 : Debug: modcall[authorize]: module "perl" returns updated for request 0 Mon Jun 19 18:09:31 2006 : Debug: modcall: leaving group authorize (returns updated) for request 0 Mon Jun 19 18:09:31 2006 : Debug: rad_check_password: Found Auth-Type Kerberos Mon Jun 19 18:09:31 2006 : Debug: auth: type "Kerberos" Mon Jun 19 18:09:31 2006 : Debug: Processing the authenticate section of radiusd.conf Mon Jun 19 18:09:31 2006 : Debug: modcall: entering group authenticate for request 0 Mon Jun 19 18:09:31 2006 : Debug: modsingle[authenticate]: calling krb5 (rlm_krb5) for request 0 Mon Jun 19 18:09:31 2006 : Auth: rlm_krb5: Parsed name is: teststaff(a)RICE.EDU Mon Jun 19 18:09:31 2006 : Debug: modsingle[authenticate]: returned from krb5 (rlm_krb5) for request 0 Mon Jun 19 18:09:31 2006 : Debug: modcall[authenticate]: module "krb5" returns ok for request 0 Mon Jun 19 18:09:31 2006 : Debug: modcall: leaving group authenticate (returns ok) for request 0 Sending Access-Accept of id 75 to 127.0.0.1 port 33469 Tunnel-Type:0 = VLAN Tunnel-Medium-Type:0 = IEEE-802 Tunnel-Private-Group-Id:0 = "staff" Mon Jun 19 18:09:31 2006 : Debug: Finished request 0 Mon Jun 19 18:09:31 2006 : Debug: Going to the next request Mon Jun 19 18:09:31 2006 : Debug: --- Walking the entire request list --- Mon Jun 19 18:09:31 2006 : Debug: Waking up in 6 seconds... rad_recv: Access-Request packet from host 127.0.0.1:33469, id=75, length=61 Mon Jun 19 18:09:31 2006 : Debug: Sending duplicate reply to client localhost:33469 - ID: 75 Re-sending Access-Accept of id 75 to 127.0.0.1 port 33469 Mon Jun 19 18:09:31 2006 : Debug: --- Walking the entire request list --- Mon Jun 19 18:09:31 2006 : Debug: Waking up in 1 seconds... Mon Jun 19 18:09:32 2006 : Debug: --- Walking the entire request list --- Mon Jun 19 18:09:32 2006 : Debug: Cleaning up request 0 ID 75 with timestamp 44972ea6 Mon Jun 19 18:09:32 2006 : Debug: Nothing to do. Sleeping until we see a request. ----------------------- As you can see from the log, a new reply pair is added for the Tunnel-Private-Group-ID instead of updating the existing one. The initial one is populated via LDAP and I am using rlm_perl to manage the load balancing of the individual VLANs. Is there a way to have rlm_perl change the actual contents of the reply packet so that the correct VLAN entry is returned? If not, does anyone have a good idea about how that may be accomplished? Ken Marshall

4 13

sql segmentaiton fault
by YvesDM 16 Aug '06

16 Aug '06

hi, Created my own debs of freeradius 1.0.5 Everything works, but when i try to use mysql i get a segmentation fault running radiusd -X Could my freeradius-mysql.deb be corrupt? I got no errors creating it. I used the rules file in the debian dir of the tar.gz, but added --with-experimental modules as a configure option in it cause i need the sqlcounter. These are the last lines of the radiusd -X output: sql: postauth_query = "INSERT into radpostauth (id, user, pass, reply, date) values ('', '%{User-Name}', '%{User-Password:-Chap-Password}', '%{reply:Packet-Type}', NOW())" sql: safe-characters = "@abcdefghijklmnopqrstuvwxyzABCDEFGHIJKLMNOPQRSTUVWXYZ0123456789.-_: /" rlm_sql (sql): Driver rlm_sql_mysql (module rlm_sql_mysql) loaded and linked rlm_sql (sql): Attempting to connect to freeradius@localhost:/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 rlm_sql (sql): - generate_sql_clients rlm_sql (sql): Query: SELECT * FROM nas rlm_sql (sql): Reserving sql socket id: 4 rlm_sql (sql): Read entry nasname=localhost,shortname=localhost,secret=XXXXXXXXXXX rlm_sql (sql): Adding client 127.0.0.1 (localhost) to clients list rlm_sql (sql): Released sql socket id: 4 Module: Instantiated sql (sql) Segmentation fault Any idea's?

3 6

Proxy Problem maybe a bug!
by Mitaine Yoann 16 Aug '06

16 Aug '06

Dear everybody, I've installed the radius 's CVS version of 08-02-06. I've this architecture : client < ====> AP <====> Radius A <====> Radius B proxying with proxy.conf file : realm NULL { type = radius authhost = LOCAL accthost = LOCAL } realm AAA { type = radius authhost = LOCAL accthost = LOCAL type = radius } realm BBB { type = radius authhost = 147.173.3.249:1812 accthost = 147.173.3.249:1813 secret = RaDCNRSgreCentr1 nostrip } # This realm is for ALL OTHER requests. ## realm DEFAULT { type = radius authhost = anIP@:1812 accthost = anIP@:1813 secret = RaDCNRSgreCentr1 nostrip } I tried to use the proxy's configuration between the Server A and the Server B. the server A sent an Access-Request proxied to the Server B. When the server B answered to the proxy-request by an Acces-Chalenge request proxied, I had an error message like this : "Received Unknown packet code 11from client 147.173.3.249 port 1812: Cannot validate signature Dropping packet without response." So I searched for what could cause this error and I think I found it in the radius.c file, at the end of the rad_verify function. in the last switch-case code : /* * Calculate and/or verify digest. */ switch(packet->code) { int rcode; char buffer[32]; case PW_AUTHENTICATION_REQUEST: case PW_STATUS_SERVER: case PW_DISCONNECT_REQUEST: /* * The authentication vector is random * nonsense, invented by the client. */ break; case PW_ACCOUNTING_REQUEST: if (calc_acctdigest(packet, secret) > 1) { librad_log("Received Accounting-Request packet " "from %s with invalid signature! (Shared secret is incorrect.)", inet_ntop(packet->src_ipaddr.af, &packet->src_ipaddr.ipaddr,buffer, sizeof(buffer))); return -1; } break; /* Verify the reply digest */ case PW_AUTHENTICATION_ACK: case PW_AUTHENTICATION_REJECT: case PW_ACCOUNTING_RESPONSE: rcode = calc_replydigest(packet,original, secret); if (rcode > 1) { librad_log("Received %s packet " "from client %s port %d with invalid signature (err=%d)! (Shared secret is incorrect.)",packet_codes[packet->code], inet_ntop(packet->src_ipaddr.af, &packet->src_ipaddr.ipaddr,buffer, sizeof(buffer)),packet->src_port, rcode); return -1; } break; default: librad_log("Received Unknown packet code %d" "from client %s port %d: Cannot validate signature", packet->code,inet_ntop(packet->src_ipaddr.af, &packet->src_ipaddr.ipaddr, buffer,sizeof(buffer)), packet->src_port); return -1; } There was no case of Acces challenge resquest ,I added it (case PW_ACCESS_CHALLENGE). And now the proxy request works ! I would like to know if the change is correct and if somebody already had this error . Your sincerly. --------------------------------- Découvrez un nouveau moyen de poser toutes vos questions quelque soit le sujet ! Yahoo! Questions/Réponses pour partager vos connaissances, vos opinions et vos expériences. Cliquez ici.

2 1

Limiting Bandwidth Usage !?!?
by Calode 16 Aug '06

16 Aug '06

I know that this question was answered so many times cause i read almost all the q/a but i am very a beginner to all Linux world and especially custom configuration , compiling editing and so on ... but i am very interested in learning all of this new technic but i need some help ... can u guys teach me in some way ?! cause i understood some of the answers but couldn't really apply the code ... i seem to be An idiot when it comes to customizing ... I've managed to make the configuration work @ its default settings with some text readings but again i am stuck (configuration is Nas + Freeradius + MySql + Dialup_admin ) plz help me ! Perhaps some clarification on how to reconfigure rlm_sqlcounter ... i couldn't really understand what is in the docs . Best Regards Claude Rizkallah.

1 0

how to input data in radius MySQL database for using MAC address authentication
by Edward.Shih＠rcc.edu 16 Aug '06

16 Aug '06

Hi everyone, I read through some of threads about using MAC address authentication, but the issue still wasn't solved. I am new to this field, and I want to implement a FreeRadius server to communicate with Cisco Aironet 1200 Access Point using MAC address authentication method. The network environment: 1. Set up Cisco AP to use Radius server, and MAC Address Authentication 2. Set up freeRadius (Ver.1.1.2) on FreeBSD server (Ver 6.1), and use MySQL database (not users file) 3. I insert a record into radcheck table: use MAC address as user name 1 000b6b54a738 Password := '' 4. Use Ntradping.exe to test the radius server with above user account (leave password as blank), and get Access-Reject. Obviously, I guess the issue is in the password. If I put the some characters into the password field in radcheck table and test it again with the same password in Ntradoing.exe, I do get Access-Accept. But, I don't think Cisco AP will send a password when using MAC address authentication. I am wondering how to input data in radius database for AP using MAC address authentication, and where I should fill in all relating settings. Any input from the members of this list would be much appreciated. Thanks & Regards, Edward

1 0

Freeradius doesn't read vendor specific dictionary
by SusePersonalTrainer 16 Aug '06

16 Aug '06

Hi to all! I have a problem. My freeradius Version 1.0.2 (debian) server doesn't read dictionary.mikrotik file. My configuration includes /usr/share/freeradius/disctionary wich includes dictionary.mikrotik. The dictionary.mikrotik contains the attribute Rate-Limit I use to manage the user's bandwith. Moreover the rlm_sql module says: radius_xlat: 'SELECT id,UserName,Attribute,Value,op FROM radreply WHERE Username = 'steve' ORDER BY id' rlm_sql: unknown attribute Rate-Limit Why?

3 2

Rép. : Re: Comments problem in huntgroups file
by Thomas BAUDELET 16 Aug '06

16 Aug '06

Thanks, I'm not able to change the parser. Is there a problem to use the comments with the comma like this ? FreeRadius may think that #test is an attribute as it follows a comma ? Switchs NAS-IP-Address == 10.195.132.7 ,# test Can I use it like this ? Or maybe a ";" or "//" will work ? Thomas ********************************************************************** This email and any files transmitted with it are confidential and intended solely for the use of the individual or entity to whom they are addressed. If you have received this email in error please notify the system manager. **********************************************************************

3 2

RE: sql segmentaiton fault
by Hasan Ovuc 16 Aug '06

16 Aug '06

Try to start with strace tool, maybe it helps you. strace radiusd -d /etc/raddb > -----Original Message----- > From: > freeradius-users-bounces+hasan.ovuc=superonline.net(a)lists.free > radius.org > [mailto:freeradius-users-bounces+hasan.ovuc=superonline.net@li > sts.freeradius.org] On Behalf Of Nicolas Baradakis > Sent: Wednesday, August 16, 2006 12:09 PM > To: FreeRadius users mailing list > Subject: Re: sql segmentaiton fault > > YvesDM wrote: > > > Created my own debs of freeradius 1.0.5 > > Please upgrade to 1.1.2. > > > Everything works, but when i try to use mysql i get a segmentation > > fault running radiusd -X > > See http://freeradius.org/radiusd/doc/bugs > > > I used the rules file in the debian dir of the tar.gz, but added > > --with-experimental modules as a configure option in it > cause i need > > the sqlcounter. > > sqlcounter is in the stable modules list in versions >= 1.1.0. > > -- > Nicolas Baradakis > > - > List info/subscribe/unsubscribe? See > http://www.freeradius.org/list/users.html > Bu e-posta mesaji ve ekleri sadece gonderildigi kisi veya kuruma ozeldir. Eger dogru kisiye ulasmadigini dusunuyorsaniz, bu mesajin yonlendirilmesi, kopyalanmasi veya herhangi bir sekilde kullanilmasi yasaktir.Mesaj iceriginde bulunan fikir ve yorumlar, SUPERONLINE'a degil sadece gondericiye aittir. Bu mesaj bilinen tum viruslere karsi test edilmistir. This e-mail and any files transmitted with it are confidential and intended solely for the use of the individual or entity to whom they are addressed. If you are not the intended recipient you are hereby notified that any dissemination, copying or use of the information is prohibited. The opinions expressed in this message belong to sender alone. There is no implied endorsement by SUPERONLINE.This e-mail has been scanned for all known computer viruses.

1 0