Authentification

Mon Mar 5 14:55:09 CET 2012

Good afternoon,

I'm new in Radius and I have no clue what happens, can anybody help me? from the server in the command line works fine, from the wireless client get this one.

Thanks

Regards

ad_recv: Access-Request packet from host 127.0.0.1 port 35226, id=0, length=200

        User-Name = "mysqltest"

        User-Password = "O%:snv\nB\334Îž\300H\035\235e"

        NAS-IP-Address = 0.0.0.0

        Service-Type = Login-User

        Framed-IP-Address = 192.168.182.5

        Calling-Station-Id = "68-A3-C4-37-A2-59"

        Called-Station-Id = "08-00-27-26-2C-CD"

        NAS-Identifier = "nas01"

        Acct-Session-Id = "4f54a3d900000000"

        NAS-Port-Type = Wireless-802.11

        NAS-Port = 0

        Message-Authenticator = 0x6fb3594ad7f0fad5aa33deab91da2216

        WISPr-Logoff-URL = "http://192.168.182.1:3990/logoff"

Mon Mar  5 12:36:33 2012 : Info: # Executing section authorize from file /etc/freeradius/radiusd.conf

Mon Mar  5 12:36:33 2012 : Info: +- entering group authorize {...}

Mon Mar  5 12:36:33 2012 : Info: ++[preprocess] returns ok

Mon Mar  5 12:36:33 2012 : Info: ++[chap] returns noop

Mon Mar  5 12:36:33 2012 : Info: ++[mschap] returns noop

Mon Mar  5 12:36:33 2012 : Info: [suffix] No '@' in User-Name = "mysqltest", looking up realm NULL

Mon Mar  5 12:36:33 2012 : Info: [suffix] No such realm "NULL"

Mon Mar  5 12:36:33 2012 : Info: ++[suffix] returns noop

Mon Mar  5 12:36:33 2012 : Info: [eap] No EAP-Message, not doing EAP

Mon Mar  5 12:36:33 2012 : Info: ++[eap] returns noop

Mon Mar  5 12:36:33 2012 : Info: [sql]  expand: %{User-Name} -> mysqltest

Mon Mar  5 12:36:33 2012 : Info: [sql] sql_set_user escaped user --> 'mysqltest'

Mon Mar  5 12:36:33 2012 : Debug: rlm_sql (sql): Reserving sql socket id: 0

Mon Mar  5 12:36:33 2012 : Info: [sql]  expand: SELECT id, username, attribute, value, op           FROM radcheck           WHERE username = '%{SQL-User-Name}'           ORDER BY id -> SELECT id, username, attribute, value, op           FROM radcheck           WHERE username = 'mysqltest'           ORDER BY id

Mon Mar  5 12:36:33 2012 : Info: [sql] User found in radcheck table

Mon Mar  5 12:36:33 2012 : Info: [sql]  expand: SELECT id, username, attribute, value, op           FROM radreply           WHERE username = '%{SQL-User-Name}'           ORDER BY id -> SELECT id, username, attribute, value, op           FROM radreply           WHERE username = 'mysqltest'           ORDER BY id

Mon Mar  5 12:36:33 2012 : Info: [sql]  expand: SELECT groupname           FROM radusergroup           WHERE username = '%{SQL-User-Name}'           ORDER BY priority -> SELECT groupname           FROM radusergroup           WHERE username = 'mysqltest'           ORDER BY priority

Mon Mar  5 12:36:33 2012 : Debug: rlm_sql (sql): Released sql socket id: 0

Mon Mar  5 12:36:33 2012 : Info: ++[sql] returns ok

Mon Mar  5 12:36:33 2012 : Info: ++[pap] returns updated

Mon Mar  5 12:36:33 2012 : Info: Found Auth-Type = PAP

Mon Mar  5 12:36:33 2012 : Info: # Executing group from file /etc/freeradius/radiusd.conf

Mon Mar  5 12:36:33 2012 : Info: +- entering group PAP {...}

Mon Mar  5 12:36:33 2012 : Info: [pap] login attempt with password "O%:snv Bï¿½ï¿½?ï¿½H??e"

Mon Mar  5 12:36:33 2012 : Info: [pap] Using clear text password "testsecret"

Mon Mar  5 12:36:33 2012 : Info: [pap] Passwords don't match

Mon Mar  5 12:36:33 2012 : Info: ++[pap] returns reject
Mon Mar  5 12:36:33 2012 : Info: Failed to authenticate the user.

Mon Mar  5 12:36:33 2012 : Debug:   WARNING: Unprintable characters in the password.      Double-check the shared secret on the server and the NAS!
Mon Mar  5 12:36:33 2012 : Info: Using Post-Auth-Type Reject
Mon Mar  5 12:36:33 2012 : Info: # Executing group from file /etc/freeradius/sites-enabled/default

Mon Mar  5 12:36:33 2012 : Info: +- entering group REJECT {...}
Mon Mar  5 12:36:33 2012 : Info: [attr_filter.access_reject]    expand: %{User-Name} -> mysqltest
Mon Mar  5 12:36:33 2012 : Debug:  attr_filter: Matched entry DEFAULT at line 11

Mon Mar  5 12:36:33 2012 : Info: ++[attr_filter.access_reject] returns updated
Mon Mar  5 12:36:33 2012 : Info: Delaying reject of request 14 for 1 seconds
Mon Mar  5 12:36:33 2012 : Debug: Going to the next request

Mon Mar  5 12:36:33 2012 : Debug: Waking up in 0.9 seconds.

Mon Mar  5 12:36:34 2012 : Info: Sending delayed reject for request 14
Sending Access-Reject of id 0 to 127.0.0.1 port 35226
Mon Mar  5 12:36:34 2012 : Debug: Waking up in 4.9 seconds.

Mon Mar  5 12:36:39 2012 : Info: Cleaning up request 14 ID 0 with timestamp +3498

Mon Mar  5 12:36:39 2012 : Info: Ready to process requests.

Javier Ruiz Escalante

Teléfono: 00 34 512 700 524

Skype: fruiz002

-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.freeradius.org/pipermail/freeradius-users/attachments/20120305/a44735fe/attachment-0001.html>