Here is the radiusd -Xxxx output from when the Extreme Networks switch
tries to auth the port:
------------ <snip> ------------
Thu Jan 20 04:21:12 2005 : Debug: Listening on authentication *:1812
Thu Jan 20 04:21:12 2005 : Debug: Listening on accounting *:1813
Thu Jan 20 04:21:12 2005 : Debug: Listening on proxy *:1814
Thu Jan 20 04:21:12 2005 : Info: Ready to process requests.
rad_recv: Access-Request packet from host 10.0.4.3:2082, id=176, length=98
User-Name = "[EMAIL PROTECTED]"
EAP-Message = 0x0201001101414d535c6d636170656c6c65
NAS-IP-Address = 10.0.4.3
Service-Type = Login-User
Calling-Station-Id = "0.0.0.0"
NAS-Port-Type = Ethernet
Message-Authenticator = 0x79e9c575d1b7ebe5618c65d8034791e4
Thu Jan 20 04:21:36 2005 : Debug: Processing the authorize section of
radiusd.conf
Thu Jan 20 04:21:36 2005 : Debug: modcall: entering group authorize for
request 0
Thu Jan 20 04:21:36 2005 : Debug: modsingle[authorize]: calling
preprocess (rlm_preprocess) for request 0
Thu Jan 20 04:21:36 2005 : Debug: modsingle[authorize]: returned from
preprocess (rlm_preprocess) for request 0
Thu Jan 20 04:21:36 2005 : Debug: modcall[authorize]: module "preprocess"
returns ok for request 0
Thu Jan 20 04:21:36 2005 : Debug: modsingle[authorize]: calling chap
(rlm_chap) for request 0
Thu Jan 20 04:21:36 2005 : Debug: modsingle[authorize]: returned from
chap (rlm_chap) for request 0
Thu Jan 20 04:21:36 2005 : Debug: modcall[authorize]: module "chap"
returns noop for request 0
Thu Jan 20 04:21:36 2005 : Debug: modsingle[authorize]: calling mschap
(rlm_mschap) for request 0
Thu Jan 20 04:21:36 2005 : Debug: modsingle[authorize]: returned from
mschap (rlm_mschap) for request 0
Thu Jan 20 04:21:36 2005 : Debug: modcall[authorize]: module "mschap"
returns noop for request 0
Thu Jan 20 04:21:36 2005 : Debug: modsingle[authorize]: calling suffix
(rlm_realm) for request 0
Thu Jan 20 04:21:36 2005 : Debug: rlm_realm: Looking up realm "AMS" for
User-Name = "[EMAIL PROTECTED]"
Thu Jan 20 04:21:36 2005 : Debug: rlm_realm: No such realm "AMS"
Thu Jan 20 04:21:36 2005 : Debug: modsingle[authorize]: returned from
suffix (rlm_realm) for request 0
Thu Jan 20 04:21:36 2005 : Debug: modcall[authorize]: module "suffix"
returns noop for request 0
Thu Jan 20 04:21:36 2005 : Debug: modsingle[authorize]: calling ntdomain
(rlm_realm) for request 0
Thu Jan 20 04:21:36 2005 : Debug: rlm_realm: No '\' in User-Name =
"[EMAIL PROTECTED]", looking up realm NULL
Thu Jan 20 04:21:36 2005 : Debug: rlm_realm: No such realm "NULL"
Thu Jan 20 04:21:36 2005 : Debug: modsingle[authorize]: returned from
ntdomain (rlm_realm) for request 0
Thu Jan 20 04:21:36 2005 : Debug: modcall[authorize]: module "ntdomain"
returns noop for request 0
Thu Jan 20 04:21:36 2005 : Debug: modsingle[authorize]: calling eap
(rlm_eap) for request 0
Thu Jan 20 04:21:36 2005 : Debug: rlm_eap: EAP packet type response id 1
length 17
Thu Jan 20 04:21:36 2005 : Debug: rlm_eap: No EAP Start, assuming it's an
on-going EAP conversation
Thu Jan 20 04:21:36 2005 : Debug: modsingle[authorize]: returned from eap
(rlm_eap) for request 0
Thu Jan 20 04:21:36 2005 : Debug: modcall[authorize]: module "eap"
returns updated for request 0
Thu Jan 20 04:21:36 2005 : Debug: modsingle[authorize]: calling files
(rlm_files) for request 0
Thu Jan 20 04:21:36 2005 : Debug: users: Matched DEFAULT at 152
Thu Jan 20 04:21:36 2005 : Debug: modsingle[authorize]: returned from
files (rlm_files) for request 0
Thu Jan 20 04:21:36 2005 : Debug: modcall[authorize]: module "files"
returns ok for request 0
Thu Jan 20 04:21:36 2005 : Debug: modcall: group authorize returns updated
for request 0
Thu Jan 20 04:21:36 2005 : Debug: rad_check_password: Found Auth-Type
EAP
Thu Jan 20 04:21:36 2005 : Debug: auth: type "EAP"
Thu Jan 20 04:21:36 2005 : Debug: Processing the authenticate section of
radiusd.conf
Thu Jan 20 04:21:36 2005 : Debug: modcall: entering group authenticate for
request 0
Thu Jan 20 04:21:36 2005 : Debug: modsingle[authenticate]: calling eap
(rlm_eap) for request 0
Thu Jan 20 04:21:36 2005 : Error: rlm_eap: Identity does not match
User-Name, setting from EAP Identity.
Thu Jan 20 04:21:36 2005 : Debug: rlm_eap: Failed in handler
Thu Jan 20 04:21:36 2005 : Debug: modsingle[authenticate]: returned from
eap (rlm_eap) for request 0
Thu Jan 20 04:21:36 2005 : Debug: modcall[authenticate]: module "eap"
returns invalid for request 0
Thu Jan 20 04:21:36 2005 : Debug: modcall: group authenticate returns
invalid for request 0
Thu Jan 20 04:21:36 2005 : Debug: auth: Failed to validate the user.
Thu Jan 20 04:21:36 2005 : Auth: Login incorrect: [EMAIL PROTECTED] (from
client Alpine port 0 cli 0.0.0.0)
Thu Jan 20 04:21:36 2005 : Debug: Delaying request 0 for 1 seconds
Thu Jan 20 04:21:36 2005 : Debug: Finished request 0
Thu Jan 20 04:21:36 2005 : Debug: Going to the next request
Thu Jan 20 04:21:36 2005 : Debug: --- Walking the entire request list ---
Thu Jan 20 04:21:36 2005 : Debug: Waking up in 1 seconds...
Thu Jan 20 04:21:37 2005 : Debug: --- Walking the entire request list ---
Thu Jan 20 04:21:37 2005 : Debug: Waking up in 1 seconds...
Thu Jan 20 04:21:38 2005 : Debug: --- Walking the entire request list ---
Sending Access-Reject of id 176 to 10.0.4.3:2082
Thu Jan 20 04:21:38 2005 : Debug: Waking up in 4 seconds...
Thu Jan 20 04:21:42 2005 : Debug: --- Walking the entire request list ---
Thu Jan 20 04:21:42 2005 : Debug: Cleaning up request 0 ID 176 with
timestamp 41ef8630
Thu Jan 20 04:21:42 2005 : Debug: Nothing to do. Sleeping until we see a
request.
-
List info/subscribe/unsubscribe? See http://www.freeradius.org/list/users.html
