This post has NOT been accepted by the mailing list yet. Hi, Would greatly someone's help on this. I need free radius to authenticate with using wpa.
From the local radtest I can see, it is authenticating fine but when testing with a wpa device, this is the error m getting on the debug log:
I just need it to work from wireless device, I think it is the eap.conf part. Would greatly appreciate someone's help on this::: FreeRADIUS Debugging Output This colorized output was produced by an automated tool from Network RADIUS FreeRADIUS Version 2.1.7, for host x86_64-redhat-linux-gnu, built on Mar 31 2010 at 00:14:28 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/detail.example.com including configuration file /etc/raddb/modules/smsotp including configuration file /etc/raddb/modules/sradutmp including configuration file /etc/raddb/modules/sqlcounter_expire_on_login including configuration file /etc/raddb/modules/otp including configuration file /etc/raddb/modules/realm including configuration file /etc/raddb/modules/sql_log including configuration file /etc/raddb/modules/logintime including configuration file /etc/raddb/modules/inner-eap including configuration file /etc/raddb/modules/checkval including configuration file /etc/raddb/modules/linelog including configuration file /etc/raddb/modules/pam including configuration file /etc/raddb/modules/passwd including configuration file /etc/raddb/modules/preprocess including configuration file /etc/raddb/modules/attr_filter including configuration file /etc/raddb/modules/unix including configuration file /etc/raddb/modules/wimax including configuration file /etc/raddb/modules/chap including configuration file /etc/raddb/modules/files including configuration file /etc/raddb/modules/mac2ip including configuration file /etc/raddb/modules/echo including configuration file /etc/raddb/modules/radutmp including configuration file /etc/raddb/modules/always including configuration file /etc/raddb/modules/etc_group including configuration file /etc/raddb/modules/detail including configuration file /etc/raddb/modules/attr_rewrite including configuration file /etc/raddb/modules/exec including configuration file /etc/raddb/modules/policy including configuration file /etc/raddb/modules/pap including configuration file /etc/raddb/modules/expr including configuration file /etc/raddb/modules/acct_unique including configuration file /etc/raddb/modules/ippool including configuration file /etc/raddb/modules/perl including configuration file /etc/raddb/modules/ldap including configuration file /etc/raddb/modules/counter including configuration file /etc/raddb/modules/digest including configuration file /etc/raddb/modules/smbpasswd including configuration file /etc/raddb/modules/detail.log including configuration file /etc/raddb/modules/cui including configuration file /etc/raddb/modules/OLD_ldap-ORIG including configuration file /etc/raddb/modules/mac2vlan including configuration file /etc/raddb/modules/expiration including configuration file /etc/raddb/modules/mschap including configuration file /etc/raddb/eap.conf including configuration file /etc/raddb/policy.conf including files in directory /etc/raddb/sites-enabled/ including configuration file /etc/raddb/sites-enabled/control-socket including configuration file /etc/raddb/sites-enabled/inner-tunnel 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/lib64/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 = yes auth_badpass = no auth_goodpass = no msg_badpass = "Host %n" msg_goodpass = "Host %n" } security { max_attributes = 200 reject_delay = 3 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 localhost { ipaddr = 127.0.0.1 require_message_authenticator = no secret = "testing123" shortname = "localhost" nastype = "other" } client 10.38.0.3 { require_message_authenticator = no secret = "EduroamACUwlan" shortname = "acubluecoat" 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 = yes } Module: Linked to module rlm_ldap Module: Instantiating ldap ldap { server = "acustaff.acu.edu.au" port = 3268 password = "9yRD1133" identity = "cn=Radauth,cn=Users,dc=acustaff,dc=acu,dc=edu,dc=au" net_timeout = 1 timeout = 20 timelimit = 20 tls_mode = no start_tls = no tls_require_cert = "allow" tls { start_tls = no require_cert = "allow" } basedn = "dc=acu,dc=edu,dc=au" filter = "(&(sAMAccountName=%{Stripped-User-Name:-%{User-Name}}))" base_filter = "(objectclass=radiusprofile)" auto_header = no access_attr_used_for_allow = yes groupname_attribute = "cn" groupmembership_filter = "(|(&(objectClass=GroupOfNames)(member=%{Ldap-UserDn}))(&(objectClass=GroupOfUniqueNames)(uniquemember=%{Ldap-UserDn})))" groupmembership_attribute = "memberOf" dictionary_mapping = "/etc/raddb/ldap.attrmap" ldap_debug = 0 ldap_connections_number = 5 compare_check_items = no do_xlat = yes set_auth_type = yes } rlm_ldap: Registering ldap_groupcmp for Ldap-Group rlm_ldap: Registering ldap_xlat with xlat_name ldap rlm_ldap: reading ldap<->radius mappings from file /etc/raddb/ldap.attrmap rlm_ldap: LDAP radiusCheckItem mapped to RADIUS $GENERIC$ rlm_ldap: LDAP radiusReplyItem mapped to RADIUS $GENERIC$ rlm_ldap: LDAP radiusAuthType mapped to RADIUS Auth-Type rlm_ldap: LDAP radiusSimultaneousUse mapped to RADIUS Simultaneous-Use rlm_ldap: LDAP radiusCalledStationId mapped to RADIUS Called-Station-Id rlm_ldap: LDAP radiusCallingStationId mapped to RADIUS Calling-Station-Id rlm_ldap: LDAP lmPassword mapped to RADIUS LM-Password rlm_ldap: LDAP ntPassword mapped to RADIUS NT-Password rlm_ldap: LDAP sambaLmPassword mapped to RADIUS LM-Password rlm_ldap: LDAP sambaNtPassword mapped to RADIUS NT-Password rlm_ldap: LDAP dBCSPwd mapped to RADIUS LM-Password rlm_ldap: LDAP acctFlags mapped to RADIUS SMB-Account-CTRL-TEXT rlm_ldap: LDAP radiusExpiration mapped to RADIUS Expiration rlm_ldap: LDAP radiusNASIpAddress mapped to RADIUS NAS-IP-Address rlm_ldap: LDAP userPassword mapped to RADIUS Cleartext-Password rlm_ldap: LDAP radiusServiceType mapped to RADIUS Service-Type rlm_ldap: LDAP radiusFramedProtocol mapped to RADIUS Framed-Protocol rlm_ldap: LDAP radiusFramedIPAddress mapped to RADIUS Framed-IP-Address rlm_ldap: LDAP radiusFramedIPNetmask mapped to RADIUS Framed-IP-Netmask rlm_ldap: LDAP radiusFramedRoute mapped to RADIUS Framed-Route rlm_ldap: LDAP radiusFramedRouting mapped to RADIUS Framed-Routing rlm_ldap: LDAP radiusFilterId mapped to RADIUS Filter-Id rlm_ldap: LDAP radiusFramedMTU mapped to RADIUS Framed-MTU rlm_ldap: LDAP radiusFramedCompression mapped to RADIUS Framed-Compression rlm_ldap: LDAP radiusLoginIPHost mapped to RADIUS Login-IP-Host rlm_ldap: LDAP radiusLoginService mapped to RADIUS Login-Service rlm_ldap: LDAP radiusLoginTCPPort mapped to RADIUS Login-TCP-Port rlm_ldap: LDAP radiusCallbackNumber mapped to RADIUS Callback-Number rlm_ldap: LDAP radiusCallbackId mapped to RADIUS Callback-Id rlm_ldap: LDAP radiusFramedIPXNetwork mapped to RADIUS Framed-IPX-Network rlm_ldap: LDAP radiusClass mapped to RADIUS Class rlm_ldap: LDAP radiusSessionTimeout mapped to RADIUS Session-Timeout rlm_ldap: LDAP radiusIdleTimeout mapped to RADIUS Idle-Timeout rlm_ldap: LDAP radiusTerminationAction mapped to RADIUS Termination-Action rlm_ldap: LDAP radiusLoginLATService mapped to RADIUS Login-LAT-Service rlm_ldap: LDAP radiusLoginLATNode mapped to RADIUS Login-LAT-Node rlm_ldap: LDAP radiusLoginLATGroup mapped to RADIUS Login-LAT-Group rlm_ldap: LDAP radiusFramedAppleTalkLink mapped to RADIUS Framed-AppleTalk-Link rlm_ldap: LDAP radiusFramedAppleTalkNetwork mapped to RADIUS Framed-AppleTalk-Network rlm_ldap: LDAP radiusFramedAppleTalkZone mapped to RADIUS Framed-AppleTalk-Zone rlm_ldap: LDAP radiusPortLimit mapped to RADIUS Port-Limit rlm_ldap: LDAP radiusLoginLATPort mapped to RADIUS Login-LAT-Port rlm_ldap: LDAP radiusReplyMessage mapped to RADIUS Reply-Message rlm_ldap: LDAP radiusTunnelType mapped to RADIUS Tunnel-Type rlm_ldap: LDAP radiusTunnelMediumType mapped to RADIUS Tunnel-Medium-Type rlm_ldap: LDAP radiusTunnelPrivateGroupId mapped to RADIUS Tunnel-Private-Group-Id conns: 0x1e9ceee0 Module: Linked to module rlm_eap Module: Instantiating eap eap { default_eap_type = "peap" timer_expire = 60 ignore_unknown_eap_types = no cisco_accounting_username_bug = no max_sessions = 2048 } 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 = "/dev/urandom" 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 = yes 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_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 = yes } Module: Linked to module rlm_unix Module: Instantiating unix unix { radwtmp = "/var/log/radius/radwtmp" } 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 } # 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_detail Module: Instantiating auth_log detail auth_log { detailfile = "/var/log/radius/radacct/%{Client-IP-Address}/auth-detail-%Y%m%d" header = "%t" detailperm = 384 dirperm = 493 locking = no log_packet_header = no } 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: 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: Linked to module rlm_attr_filter 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-auth {...} for more modules to load Module: Instantiating attr_filter.access_reject attr_filter attr_filter.access_reject { attrsfile = "/etc/raddb/attrs.access_reject" key = "%{User-Name}" } } # 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. Packet 0 rad_recv: Access-Request packet from host 10.38.0.3 port 32769, id=237, length=236 User-Name = "uldaptest" Calling-Station-Id = "d0-23-db-e8-b6-01" Called-Station-Id = "e8-ba-70-9c-a3-d0:acubluecoat" NAS-Port = 1 Cisco-AVPair = "audit-session-id=0a26000300007fac4ed31076" NAS-IP-Address = 10.38.0.3 NAS-Identifier = "MAKWLC5508-1" Airespace-Wlan-Id = 4 Service-Type = Framed-User Framed-MTU = 1300 NAS-Port-Type = Wireless-802.11 Tunnel-Type:0 = VLAN Tunnel-Medium-Type:0 = IEEE-802 Tunnel-Private-Group-Id:0 = "19" EAP-Message = 0x0201000e01756c64617074657374 Message-Authenticator = 0x60f3efa9af61cb0e0f5ad8534f494671 +- entering group authorize {...} ++[preprocess] returns ok [auth_log] expand: /var/log/radius/radacct/%{Client-IP-Address}/auth-detail-%Y%m%d -> /var/log/radius/radacct/10.38.0.3/auth-detail-20111128 [auth_log] /var/log/radius/radacct/%{Client-IP-Address}/auth-detail-%Y%m%d expands to /var/log/radius/radacct/10.38.0.3/auth-detail-20111128 [auth_log] expand: %t -> Mon Nov 28 15:39:13 2011 ++[auth_log] returns ok [suffix] No '@' in User-Name = "uldaptest", looking up realm NULL [suffix] No such realm "NULL" ++[suffix] returns noop [eap] EAP packet type response id 1 length 14 [eap] No EAP Start, assuming it's an on-going EAP conversation ++[eap] returns updated [ldap] performing user authorization for uldaptest [ldap] WARNING: Deprecated conditional expansion ":-". See "man unlang" for details [ldap] expand: (&(sAMAccountName=%{Stripped-User-Name:-%{User-Name}})) -> (&(sAMAccountName=uldaptest)) [ldap] expand: dc=acu,dc=edu,dc=au -> dc=acu,dc=edu,dc=au rlm_ldap: ldap_get_conn: Checking Id: 0 rlm_ldap: ldap_get_conn: Got Id: 0 rlm_ldap: attempting LDAP reconnection rlm_ldap: (re)connect to acustaff.acu.edu.au:3268, authentication 0 rlm_ldap: bind as cn=Radauth,cn=Users,dc=acustaff,dc=acu,dc=edu,dc=au/9yRD1133 to acustaff.acu.edu.au:3268 rlm_ldap: waiting for bind result ... rlm_ldap: Bind was successful rlm_ldap: performing search in dc=acu,dc=edu,dc=au, with filter (&(sAMAccountName=uldaptest)) [ldap] looking for check items in directory... [ldap] looking for reply items in directory... WARNING: No "known good" password was found in LDAP. Are you sure that the user is configured correctly? [ldap] user uldaptest authorized to use remote access rlm_ldap: ldap_release_conn: Release Id: 0 ++[ldap] returns ok ++[expiration] returns noop ++[logintime] returns noop [pap] WARNING! No "known good" password found for the user. Authentication may fail because of this. ++[pap] returns noop Found Auth-Type = EAP +- entering group authenticate {...} [eap] EAP Identity [eap] processing type tls [tls] Initiate [tls] Start returned 1 ++[eap] returns handled Sending Access-Challenge of id 237 to 10.38.0.3 port 32769 EAP-Message = 0x010200061920 Message-Authenticator = 0x00000000000000000000000000000000 State = 0x0c78f6160c7aefab29789ce03c2fa122 Finished request 0. Going to the next request Waking up in 4.9 seconds. Packet 1 rad_recv: Access-Request packet from host 10.38.0.3 port 32769, id=238, length=392 User-Name = "uldaptest" Calling-Station-Id = "d0-23-db-e8-b6-01" Called-Station-Id = "e8-ba-70-9c-a3-d0:acubluecoat" NAS-Port = 1 Cisco-AVPair = "audit-session-id=0a26000300007fac4ed31076" NAS-IP-Address = 10.38.0.3 NAS-Identifier = "MAKWLC5508-1" Airespace-Wlan-Id = 4 Service-Type = Framed-User Framed-MTU = 1300 NAS-Port-Type = Wireless-802.11 Tunnel-Type:0 = VLAN Tunnel-Medium-Type:0 = IEEE-802 Tunnel-Private-Group-Id:0 = "19" EAP-Message = 0x0202009819800000008e16030100890100008503014ed31073 ... State = 0x0c78f6160c7aefab29789ce03c2fa122 Message-Authenticator = 0x562b36ca8df14283f8e01ac8ac63a3c6 +- entering group authorize {...} ++[preprocess] returns ok [auth_log] expand: /var/log/radius/radacct/%{Client-IP-Address}/auth-detail-%Y%m%d -> /var/log/radius/radacct/10.38.0.3/auth-detail-20111128 [auth_log] /var/log/radius/radacct/%{Client-IP-Address}/auth-detail-%Y%m%d expands to /var/log/radius/radacct/10.38.0.3/auth-detail-20111128 [auth_log] expand: %t -> Mon Nov 28 15:39:13 2011 ++[auth_log] returns ok [suffix] No '@' in User-Name = "uldaptest", looking up realm NULL [suffix] No such realm "NULL" ++[suffix] returns noop [eap] EAP packet type response id 2 length 152 [eap] Continuing tunnel setup. ++[eap] returns ok Found Auth-Type = EAP +- entering group authenticate {...} [eap] Request found, released from the list [eap] EAP/peap [eap] processing type peap [peap] processing EAP-TLS TLS Length 142 [peap] Length Included [peap] eaptls_verify returned 11 [peap] (other): before/accept initialization [peap] TLS_accept: before/accept initialization [peap] <<< TLS 1.0 Handshake [length 0089], ClientHello [peap] TLS_accept: SSLv3 read client hello A [peap] >>> TLS 1.0 Handshake [length 0031], ServerHello [peap] TLS_accept: SSLv3 write server hello A [peap] >>> TLS 1.0 Handshake [length 08ec], Certificate [peap] TLS_accept: SSLv3 write certificate A [peap] >>> TLS 1.0 Handshake [length 0004], ServerHelloDone [peap] TLS_accept: SSLv3 write server done A [peap] TLS_accept: SSLv3 flush data [peap] TLS_accept: Need to read more data: SSLv3 read client certificate A In SSL Handshake Phase In SSL Accept mode [peap] eaptls_process returned 13 [peap] EAPTLS_HANDLED ++[eap] returns handled Sending Access-Challenge of id 238 to 10.38.0.3 port 32769 EAP-Message = 0x0103040019c00000093016030100310200002d03014ed31071 ... EAP-Message = 0x22302006035504031319414355204365727469666963617465 ... EAP-Message = 0x00c51ed7ac80a20c32a6ef4bef301af76f54a9c4418ea270ad ... EAP-Message = 0xc8d5d9550203010001a317301530130603551d25040c300a06 ... EAP-Message = 0x8a2c7cd3db55a0a340e6b03d Message-Authenticator = 0x00000000000000000000000000000000 State = 0x0c78f6160d7befab29789ce03c2fa122 Finished request 1. Going to the next request Waking up in 4.9 seconds. Packet 2 rad_recv: Access-Request packet from host 10.38.0.3 port 32769, id=239, length=246 User-Name = "uldaptest" Calling-Station-Id = "d0-23-db-e8-b6-01" Called-Station-Id = "e8-ba-70-9c-a3-d0:acubluecoat" NAS-Port = 1 Cisco-AVPair = "audit-session-id=0a26000300007fac4ed31076" NAS-IP-Address = 10.38.0.3 NAS-Identifier = "MAKWLC5508-1" Airespace-Wlan-Id = 4 Service-Type = Framed-User Framed-MTU = 1300 NAS-Port-Type = Wireless-802.11 Tunnel-Type:0 = VLAN Tunnel-Medium-Type:0 = IEEE-802 Tunnel-Private-Group-Id:0 = "19" EAP-Message = 0x020300061900 State = 0x0c78f6160d7befab29789ce03c2fa122 Message-Authenticator = 0x7be3f3e3ed49355a492cd374601855d2 +- entering group authorize {...} ++[preprocess] returns ok [auth_log] expand: /var/log/radius/radacct/%{Client-IP-Address}/auth-detail-%Y%m%d -> /var/log/radius/radacct/10.38.0.3/auth-detail-20111128 [auth_log] /var/log/radius/radacct/%{Client-IP-Address}/auth-detail-%Y%m%d expands to /var/log/radius/radacct/10.38.0.3/auth-detail-20111128 [auth_log] expand: %t -> Mon Nov 28 15:39:13 2011 ++[auth_log] returns ok [suffix] No '@' in User-Name = "uldaptest", looking up realm NULL [suffix] No such realm "NULL" ++[suffix] returns noop [eap] EAP packet type response id 3 length 6 [eap] Continuing tunnel setup. ++[eap] returns ok Found Auth-Type = EAP +- entering group authenticate {...} [eap] Request found, released from the list [eap] EAP/peap [eap] processing type peap [peap] processing EAP-TLS [peap] Received TLS ACK [peap] ACK handshake fragment handler [peap] eaptls_verify returned 1 [peap] eaptls_process returned 13 [peap] EAPTLS_HANDLED ++[eap] returns handled Sending Access-Challenge of id 239 to 10.38.0.3 port 32769 EAP-Message = 0x010403fc1940200c8fc5aa47d15440082858eca603fd5a1969 ... EAP-Message = 0x746966696361746520417574686f72697479301e170d313131 ... EAP-Message = 0x82010a0282010100a511292c7b417649db9c0f5cdd107a7df5 ... EAP-Message = 0x1384fd317e150826ed17d50203010001a38201183082011430 ... EAP-Message = 0x2043657274696669 Message-Authenticator = 0x00000000000000000000000000000000 State = 0x0c78f6160e7cefab29789ce03c2fa122 Finished request 2. Going to the next request Waking up in 4.9 seconds. Packet 3 rad_recv: Access-Request packet from host 10.38.0.3 port 32769, id=240, length=246 User-Name = "uldaptest" Calling-Station-Id = "d0-23-db-e8-b6-01" Called-Station-Id = "e8-ba-70-9c-a3-d0:acubluecoat" NAS-Port = 1 Cisco-AVPair = "audit-session-id=0a26000300007fac4ed31076" NAS-IP-Address = 10.38.0.3 NAS-Identifier = "MAKWLC5508-1" Airespace-Wlan-Id = 4 Service-Type = Framed-User Framed-MTU = 1300 NAS-Port-Type = Wireless-802.11 Tunnel-Type:0 = VLAN Tunnel-Medium-Type:0 = IEEE-802 Tunnel-Private-Group-Id:0 = "19" EAP-Message = 0x020400061900 State = 0x0c78f6160e7cefab29789ce03c2fa122 Message-Authenticator = 0x5546f673ea00a405faa28720e9f6ab76 +- entering group authorize {...} ++[preprocess] returns ok [auth_log] expand: /var/log/radius/radacct/%{Client-IP-Address}/auth-detail-%Y%m%d -> /var/log/radius/radacct/10.38.0.3/auth-detail-20111128 [auth_log] /var/log/radius/radacct/%{Client-IP-Address}/auth-detail-%Y%m%d expands to /var/log/radius/radacct/10.38.0.3/auth-detail-20111128 [auth_log] expand: %t -> Mon Nov 28 15:39:13 2011 ++[auth_log] returns ok [suffix] No '@' in User-Name = "uldaptest", looking up realm NULL [suffix] No such realm "NULL" ++[suffix] returns noop [eap] EAP packet type response id 4 length 6 [eap] Continuing tunnel setup. ++[eap] returns ok Found Auth-Type = EAP +- entering group authenticate {...} [eap] Request found, released from the list [eap] EAP/peap [eap] processing type peap [peap] processing EAP-TLS [peap] Received TLS ACK [peap] ACK handshake fragment handler [peap] eaptls_verify returned 1 [peap] eaptls_process returned 13 [peap] EAPTLS_HANDLED ++[eap] returns handled Sending Access-Challenge of id 240 to 10.38.0.3 port 32769 EAP-Message = 0x0105014a19006361746520417574686f726974798209009f5c ... EAP-Message = 0xd6e0fee86621f984bd730d2494704b554e1aa8baad5c4f1c2c ... Message-Authenticator = 0x00000000000000000000000000000000 State = 0x0c78f6160f7defab29789ce03c2fa122 Finished request 3. Going to the next request Waking up in 4.9 seconds. Packet 4 rad_recv: Access-Request packet from host 10.38.0.3 port 32769, id=241, length=578 User-Name = "uldaptest" Calling-Station-Id = "d0-23-db-e8-b6-01" Called-Station-Id = "e8-ba-70-9c-a3-d0:acubluecoat" NAS-Port = 1 Cisco-AVPair = "audit-session-id=0a26000300007fac4ed31076" NAS-IP-Address = 10.38.0.3 NAS-Identifier = "MAKWLC5508-1" Airespace-Wlan-Id = 4 Service-Type = Framed-User Framed-MTU = 1300 NAS-Port-Type = Wireless-802.11 Tunnel-Type:0 = VLAN Tunnel-Medium-Type:0 = IEEE-802 Tunnel-Private-Group-Id:0 = "19" EAP-Message = 0x020501501980000001461603010106100001020100960b620f ... EAP-Message = 0x050369c4597e0b74b7983fe6d4d126932cb6a14da376e61414 ... State = 0x0c78f6160f7defab29789ce03c2fa122 Message-Authenticator = 0xc5cf2ebf2d560e1cc00f06b96305c7b5 +- entering group authorize {...} ++[preprocess] returns ok [auth_log] expand: /var/log/radius/radacct/%{Client-IP-Address}/auth-detail-%Y%m%d -> /var/log/radius/radacct/10.38.0.3/auth-detail-20111128 [auth_log] /var/log/radius/radacct/%{Client-IP-Address}/auth-detail-%Y%m%d expands to /var/log/radius/radacct/10.38.0.3/auth-detail-20111128 [auth_log] expand: %t -> Mon Nov 28 15:39:13 2011 ++[auth_log] returns ok [suffix] No '@' in User-Name = "uldaptest", looking up realm NULL [suffix] No such realm "NULL" ++[suffix] returns noop [eap] EAP packet type response id 5 length 253 [eap] Continuing tunnel setup. ++[eap] returns ok Found Auth-Type = EAP +- entering group authenticate {...} [eap] Request found, released from the list [eap] EAP/peap [eap] processing type peap [peap] processing EAP-TLS TLS Length 326 [peap] Length Included [peap] eaptls_verify returned 11 [peap] <<< TLS 1.0 Handshake [length 0106], ClientKeyExchange [peap] TLS_accept: SSLv3 read client key exchange A [peap] <<< TLS 1.0 ChangeCipherSpec [length 0001] [peap] <<< TLS 1.0 Handshake [length 0010], Finished [peap] TLS_accept: SSLv3 read finished A [peap] >>> TLS 1.0 ChangeCipherSpec [length 0001] [peap] TLS_accept: SSLv3 write change cipher spec A [peap] >>> TLS 1.0 Handshake [length 0010], Finished [peap] TLS_accept: SSLv3 write finished A [peap] TLS_accept: SSLv3 flush data [peap] (other): SSL negotiation finished successfully SSL Connection Established [peap] eaptls_process returned 13 [peap] EAPTLS_HANDLED ++[eap] returns handled Sending Access-Challenge of id 241 to 10.38.0.3 port 32769 EAP-Message = 0x0106004119001403010001011603010030d7894bd4d1fdda80 ... Message-Authenticator = 0x00000000000000000000000000000000 State = 0x0c78f616087eefab29789ce03c2fa122 Finished request 4. Going to the next request Waking up in 4.8 seconds. Packet 5 rad_recv: Access-Request packet from host 10.38.0.3 port 32769, id=242, length=246 User-Name = "uldaptest" Calling-Station-Id = "d0-23-db-e8-b6-01" Called-Station-Id = "e8-ba-70-9c-a3-d0:acubluecoat" NAS-Port = 1 Cisco-AVPair = "audit-session-id=0a26000300007fac4ed31076" NAS-IP-Address = 10.38.0.3 NAS-Identifier = "MAKWLC5508-1" Airespace-Wlan-Id = 4 Service-Type = Framed-User Framed-MTU = 1300 NAS-Port-Type = Wireless-802.11 Tunnel-Type:0 = VLAN Tunnel-Medium-Type:0 = IEEE-802 Tunnel-Private-Group-Id:0 = "19" EAP-Message = 0x020600061900 State = 0x0c78f616087eefab29789ce03c2fa122 Message-Authenticator = 0xe0557ef5bb67ba6b81ab20513d65fd7f +- entering group authorize {...} ++[preprocess] returns ok [auth_log] expand: /var/log/radius/radacct/%{Client-IP-Address}/auth-detail-%Y%m%d -> /var/log/radius/radacct/10.38.0.3/auth-detail-20111128 [auth_log] /var/log/radius/radacct/%{Client-IP-Address}/auth-detail-%Y%m%d expands to /var/log/radius/radacct/10.38.0.3/auth-detail-20111128 [auth_log] expand: %t -> Mon Nov 28 15:39:14 2011 ++[auth_log] returns ok [suffix] No '@' in User-Name = "uldaptest", looking up realm NULL [suffix] No such realm "NULL" ++[suffix] returns noop [eap] EAP packet type response id 6 length 6 [eap] Continuing tunnel setup. ++[eap] returns ok Found Auth-Type = EAP +- entering group authenticate {...} [eap] Request found, released from the list [eap] EAP/peap [eap] processing type peap [peap] processing EAP-TLS [peap] Received TLS ACK [peap] ACK handshake is finished [peap] eaptls_verify returned 3 [peap] eaptls_process returned 3 [peap] EAPTLS_SUCCESS ++[eap] returns handled Sending Access-Challenge of id 242 to 10.38.0.3 port 32769 EAP-Message = 0x0107002b190017030100209de7fc5e4ae455f946e2ea4e4b18 ... Message-Authenticator = 0x00000000000000000000000000000000 State = 0x0c78f616097fefab29789ce03c2fa122 Finished request 5. Going to the next request Waking up in 4.8 seconds. Packet 6 rad_recv: Access-Request packet from host 10.38.0.3 port 32769, id=243, length=283 User-Name = "uldaptest" Calling-Station-Id = "d0-23-db-e8-b6-01" Called-Station-Id = "e8-ba-70-9c-a3-d0:acubluecoat" NAS-Port = 1 Cisco-AVPair = "audit-session-id=0a26000300007fac4ed31076" NAS-IP-Address = 10.38.0.3 NAS-Identifier = "MAKWLC5508-1" Airespace-Wlan-Id = 4 Service-Type = Framed-User Framed-MTU = 1300 NAS-Port-Type = Wireless-802.11 Tunnel-Type:0 = VLAN Tunnel-Medium-Type:0 = IEEE-802 Tunnel-Private-Group-Id:0 = "19" EAP-Message = 0x0207002b1900170301002002719aa3fa2024a6c67106b383a3 ... State = 0x0c78f616097fefab29789ce03c2fa122 Message-Authenticator = 0xe782aed7aa6de93a419f5e0d745eae21 +- entering group authorize {...} ++[preprocess] returns ok [auth_log] expand: /var/log/radius/radacct/%{Client-IP-Address}/auth-detail-%Y%m%d -> /var/log/radius/radacct/10.38.0.3/auth-detail-20111128 [auth_log] /var/log/radius/radacct/%{Client-IP-Address}/auth-detail-%Y%m%d expands to /var/log/radius/radacct/10.38.0.3/auth-detail-20111128 [auth_log] expand: %t -> Mon Nov 28 15:39:14 2011 ++[auth_log] returns ok [suffix] No '@' in User-Name = "uldaptest", looking up realm NULL [suffix] No such realm "NULL" ++[suffix] returns noop [eap] EAP packet type response id 7 length 43 [eap] Continuing tunnel setup. ++[eap] returns ok Found Auth-Type = EAP +- entering group authenticate {...} [eap] Request found, released from the list [eap] EAP/peap [eap] processing type peap [peap] processing EAP-TLS [peap] eaptls_verify returned 7 [peap] Done initial handshake [peap] eaptls_process returned 7 [peap] EAPTLS_OK [peap] Session established. Decoding tunneled attributes. [peap] Identity - uldaptest [peap] Got tunneled request EAP-Message = 0x0207000e01756c64617074657374 server { PEAP: Got tunneled identity of uldaptest PEAP: Setting default EAP type for tunneled EAP session. PEAP: Setting User-Name to uldaptest Sending tunneled request EAP-Message = 0x0207000e01756c64617074657374 FreeRADIUS-Proxied-To = 127.0.0.1 User-Name = "uldaptest" server inner-tunnel { +- entering group authorize {...} ++[chap] returns noop ++[mschap] returns noop ++[unix] returns notfound [suffix] No '@' in User-Name = "uldaptest", looking up realm NULL [suffix] No such realm "NULL" ++[suffix] returns noop ++[control] returns noop [eap] EAP packet type response id 7 length 14 [eap] No EAP Start, assuming it's an on-going EAP conversation ++[eap] returns updated [files] users: Matched entry DEFAULT at line 149 ++[files] returns ok [ldap] performing user authorization for uldaptest [ldap] WARNING: Deprecated conditional expansion ":-". See "man unlang" for details [ldap] expand: (&(sAMAccountName=%{Stripped-User-Name:-%{User-Name}})) -> (&(sAMAccountName=uldaptest)) [ldap] expand: dc=acu,dc=edu,dc=au -> dc=acu,dc=edu,dc=au rlm_ldap: ldap_get_conn: Checking Id: 0 rlm_ldap: ldap_get_conn: Got Id: 0 rlm_ldap: performing search in dc=acu,dc=edu,dc=au, with filter (&(sAMAccountName=uldaptest)) [ldap] looking for check items in directory... [ldap] looking for reply items in directory... WARNING: No "known good" password was found in LDAP. Are you sure that the user is configured correctly? [ldap] user uldaptest authorized to use remote access rlm_ldap: ldap_release_conn: Release Id: 0 ++[ldap] returns ok ++[expiration] returns noop ++[logintime] returns noop ++[pap] returns noop Found Auth-Type = EAP +- entering group authenticate {...} [eap] EAP Identity [eap] processing type mschapv2 rlm_eap_mschapv2: Issuing Challenge ++[eap] returns handled } # server inner-tunnel [peap] Got tunneled reply code 11 EAP-Message = 0x010800231a0108001e10be32d46bf3c68076eb2d8d743dadfb ... Message-Authenticator = 0x00000000000000000000000000000000 State = 0xc7715fc0c779457e374c07f4d937c2f5 [peap] Got tunneled reply RADIUS code 11 EAP-Message = 0x010800231a0108001e10be32d46bf3c68076eb2d8d743dadfb ... Message-Authenticator = 0x00000000000000000000000000000000 State = 0xc7715fc0c779457e374c07f4d937c2f5 [peap] Got tunneled Access-Challenge ++[eap] returns handled Sending Access-Challenge of id 243 to 10.38.0.3 port 32769 EAP-Message = 0x0108004b190017030100406a652f532ea4efc0dfd89cd91412 ... Message-Authenticator = 0x00000000000000000000000000000000 State = 0x0c78f6160a70efab29789ce03c2fa122 Finished request 6. Going to the next request Waking up in 4.8 seconds. Packet 7 rad_recv: Access-Request packet from host 10.38.0.3 port 32769, id=244, length=347 User-Name = "uldaptest" Calling-Station-Id = "d0-23-db-e8-b6-01" Called-Station-Id = "e8-ba-70-9c-a3-d0:acubluecoat" NAS-Port = 1 Cisco-AVPair = "audit-session-id=0a26000300007fac4ed31076" NAS-IP-Address = 10.38.0.3 NAS-Identifier = "MAKWLC5508-1" Airespace-Wlan-Id = 4 Service-Type = Framed-User Framed-MTU = 1300 NAS-Port-Type = Wireless-802.11 Tunnel-Type:0 = VLAN Tunnel-Medium-Type:0 = IEEE-802 Tunnel-Private-Group-Id:0 = "19" EAP-Message = 0x0208006b19001703010060e1bcc6f75e33d9687c4b70216560 ... State = 0x0c78f6160a70efab29789ce03c2fa122 Message-Authenticator = 0xca4936007fc87868f73c635317e7c8f4 +- entering group authorize {...} ++[preprocess] returns ok [auth_log] expand: /var/log/radius/radacct/%{Client-IP-Address}/auth-detail-%Y%m%d -> /var/log/radius/radacct/10.38.0.3/auth-detail-20111128 [auth_log] /var/log/radius/radacct/%{Client-IP-Address}/auth-detail-%Y%m%d expands to /var/log/radius/radacct/10.38.0.3/auth-detail-20111128 [auth_log] expand: %t -> Mon Nov 28 15:39:14 2011 ++[auth_log] returns ok [suffix] No '@' in User-Name = "uldaptest", looking up realm NULL [suffix] No such realm "NULL" ++[suffix] returns noop [eap] EAP packet type response id 8 length 107 [eap] Continuing tunnel setup. ++[eap] returns ok Found Auth-Type = EAP +- entering group authenticate {...} [eap] Request found, released from the list [eap] EAP/peap [eap] processing type peap [peap] processing EAP-TLS [peap] eaptls_verify returned 7 [peap] Done initial handshake [peap] eaptls_process returned 7 [peap] EAPTLS_OK [peap] Session established. Decoding tunneled attributes. [peap] EAP type mschapv2 [peap] Got tunneled request EAP-Message = 0x020800441a0208003f318c683ff9a452093504a6cd5448fd55 ... server { PEAP: Setting User-Name to uldaptest Sending tunneled request EAP-Message = 0x020800441a0208003f318c683ff9a452093504a6cd5448fd55 ... FreeRADIUS-Proxied-To = 127.0.0.1 User-Name = "uldaptest" State = 0xc7715fc0c779457e374c07f4d937c2f5 server inner-tunnel { +- entering group authorize {...} ++[chap] returns noop ++[mschap] returns noop ++[unix] returns notfound [suffix] No '@' in User-Name = "uldaptest", looking up realm NULL [suffix] No such realm "NULL" ++[suffix] returns noop ++[control] returns noop [eap] EAP packet type response id 8 length 68 [eap] No EAP Start, assuming it's an on-going EAP conversation ++[eap] returns updated [files] users: Matched entry DEFAULT at line 149 ++[files] returns ok [ldap] performing user authorization for uldaptest [ldap] WARNING: Deprecated conditional expansion ":-". See "man unlang" for details [ldap] expand: (&(sAMAccountName=%{Stripped-User-Name:-%{User-Name}})) -> (&(sAMAccountName=uldaptest)) [ldap] expand: dc=acu,dc=edu,dc=au -> dc=acu,dc=edu,dc=au rlm_ldap: ldap_get_conn: Checking Id: 0 rlm_ldap: ldap_get_conn: Got Id: 0 rlm_ldap: performing search in dc=acu,dc=edu,dc=au, with filter (&(sAMAccountName=uldaptest)) [ldap] looking for check items in directory... [ldap] looking for reply items in directory... WARNING: No "known good" password was found in LDAP. Are you sure that the user is configured correctly? [ldap] user uldaptest authorized to use remote access rlm_ldap: ldap_release_conn: Release Id: 0 ++[ldap] returns ok ++[expiration] returns noop ++[logintime] returns noop ++[pap] returns noop Found Auth-Type = EAP +- entering group authenticate {...} [eap] Request found, released from the list [eap] EAP/mschapv2 [eap] processing type mschapv2 [mschapv2] WARNING: Unknown value specified for Auth-Type. Cannot perform requested action. [eap] Freeing handler ++[eap] returns reject Failed to authenticate the user. expand: Host %n -> Host ?.?.?.? Login incorrect: [uldaptest] (from client acubluecoat port 0 via TLS tunnel) Host ?.?.?.? } # server inner-tunnel [peap] Got tunneled reply code 3 EAP-Message = 0x04080004 Message-Authenticator = 0x00000000000000000000000000000000 [peap] Got tunneled reply RADIUS code 3 EAP-Message = 0x04080004 Message-Authenticator = 0x00000000000000000000000000000000 [peap] Tunneled authentication was rejected. [peap] FAILURE ++[eap] returns handled Sending Access-Challenge of id 244 to 10.38.0.3 port 32769 EAP-Message = 0x0109002b1900170301002077a23a436acd15a5f46f48e1ad3f ... Message-Authenticator = 0x00000000000000000000000000000000 State = 0x0c78f6160b71efab29789ce03c2fa122 Finished request 7. Going to the next request Waking up in 4.8 seconds. Packet 8 rad_recv: Access-Request packet from host 10.38.0.3 port 32769, id=245, length=283 User-Name = "uldaptest" Calling-Station-Id = "d0-23-db-e8-b6-01" Called-Station-Id = "e8-ba-70-9c-a3-d0:acubluecoat" NAS-Port = 1 Cisco-AVPair = "audit-session-id=0a26000300007fac4ed31076" NAS-IP-Address = 10.38.0.3 NAS-Identifier = "MAKWLC5508-1" Airespace-Wlan-Id = 4 Service-Type = Framed-User Framed-MTU = 1300 NAS-Port-Type = Wireless-802.11 Tunnel-Type:0 = VLAN Tunnel-Medium-Type:0 = IEEE-802 Tunnel-Private-Group-Id:0 = "19" EAP-Message = 0x0209002b190017030100203e380273aaacc98737e599c8b886 ... State = 0x0c78f6160b71efab29789ce03c2fa122 Message-Authenticator = 0x49fde68a41b84dab6fd1437fd478289c +- entering group authorize {...} ++[preprocess] returns ok [auth_log] expand: /var/log/radius/radacct/%{Client-IP-Address}/auth-detail-%Y%m%d -> /var/log/radius/radacct/10.38.0.3/auth-detail-20111128 [auth_log] /var/log/radius/radacct/%{Client-IP-Address}/auth-detail-%Y%m%d expands to /var/log/radius/radacct/10.38.0.3/auth-detail-20111128 [auth_log] expand: %t -> Mon Nov 28 15:39:14 2011 ++[auth_log] returns ok [suffix] No '@' in User-Name = "uldaptest", looking up realm NULL [suffix] No such realm "NULL" ++[suffix] returns noop [eap] EAP packet type response id 9 length 43 [eap] Continuing tunnel setup. ++[eap] returns ok Found Auth-Type = EAP +- entering group authenticate {...} [eap] Request found, released from the list [eap] EAP/peap [eap] processing type peap [peap] processing EAP-TLS [peap] eaptls_verify returned 7 [peap] Done initial handshake [peap] eaptls_process returned 7 [peap] EAPTLS_OK [peap] Session established. Decoding tunneled attributes. [peap] Received EAP-TLV response. [peap] Had sent TLV failure. User was rejected earlier in this session. [eap] Handler failed in EAP/peap [eap] Failed in EAP select ++[eap] returns invalid Failed to authenticate the user. expand: Host %n -> Host 10.38.0.3 Login incorrect: [uldaptest] (from client acubluecoat port 1 cli d0-23-db-e8-b6-01) Host 10.38.0.3 Using Post-Auth-Type Reject +- entering group REJECT {...} [attr_filter.access_reject] expand: %{User-Name} -> uldaptest attr_filter: Matched entry DEFAULT at line 11 ++[attr_filter.access_reject] returns updated Delaying reject of request 8 for 3 seconds Going to the next request Waking up in 0.9 seconds. Waking up in 1.9 seconds. Packet 9 rad_recv: Access-Request packet from host 10.38.0.3 port 32769, id=245, length=283 Waiting to send Access-Reject to client acubluecoat port 32769 - ID: 245 Waking up in 0.9 seconds. Sending delayed reject for request 8 Sending Access-Reject of id 245 to 10.38.0.3 port 32769 EAP-Message = 0x04090004 Message-Authenticator = 0x00000000000000000000000000000000 Waking up in 1.8 seconds. Cleaning up request 0 ID 237 with timestamp +6 Cleaning up request 1 ID 238 with timestamp +6 Cleaning up request 2 ID 239 with timestamp +6 Cleaning up request 3 ID 240 with timestamp +6 Cleaning up request 4 ID 241 with timestamp +6 Cleaning up request 5 ID 242 with timestamp +7 Cleaning up request 6 ID 243 with timestamp +7 Cleaning up request 7 ID 244 with timestamp +7 Waking up in 3.0 seconds. Cleaning up request 8 ID 245 with timestamp +7 Ready to process requests. -- View this message in context: http://freeradius.1045715.n5.nabble.com/Free-radius-authentication-with-AD-u... Sent from the FreeRadius - User mailing list archive at Nabble.com.